builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1472844170.85 results: success (0) buildid: 20160902104649 builduid: 1080ab1fa3a74daf807266848dd07e82 revision: 97471e6c4d4c67339d3896f7df36b02e1d570105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:50.846315) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:50.846747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:50.847051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:50.868720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:50.869322) ========= 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=4300f881736b422476174874000001bc-1472843764.257459-281163976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 12:22:50-- 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% 103M=0s 2016-09-02 12:22:50 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075695 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.105218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.105548) ========= 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=4300f881736b422476174874000001bc-1472843764.257459-281163976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014889 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.139892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.140274) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 97471e6c4d4c67339d3896f7df36b02e1d570105 --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 97471e6c4d4c67339d3896f7df36b02e1d570105 --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=4300f881736b422476174874000001bc-1472843764.257459-281163976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 12:22:51,241 truncating revision to first 12 chars 2016-09-02 12:22:51,241 Setting DEBUG logging. 2016-09-02 12:22:51,241 attempt 1/10 2016-09-02 12:22:51,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/97471e6c4d4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 12:22:51,672 unpacking tar archive at: autoland-97471e6c4d4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.898071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.898347) ========= script_repo_revision: 97471e6c4d4c67339d3896f7df36b02e1d570105 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.898694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.898963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 12:22:51.909655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-02 12:22:51.909921) ========= /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=4300f881736b422476174874000001bc-1472843764.257459-281163976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:22:52 INFO - MultiFileLogger online at 20160902 12:22:52 in /builds/slave/test 12:22:52 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:22:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:22:52 INFO - {'append_to_log': False, 12:22:52 INFO - 'base_work_dir': '/builds/slave/test', 12:22:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:22:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:22:52 INFO - 'branch': 'Autoland-Non-PGO', 12:22:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:22:52 INFO - 'config_files': ('talos/linux_config.py',), 12:22:52 INFO - 'default_actions': ('clobber', 12:22:52 INFO - 'read-buildbot-config', 12:22:52 INFO - 'download-and-extract', 12:22:52 INFO - 'populate-webroot', 12:22:52 INFO - 'create-virtualenv', 12:22:52 INFO - 'install', 12:22:52 INFO - 'run-tests'), 12:22:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:22:52 INFO - 'download_minidump_stackwalk': True, 12:22:52 INFO - 'download_symbols': 'ondemand', 12:22:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:22:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:22:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:22:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:22:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:22:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:22:52 INFO - 'installer_path': 'installer.exe', 12:22:52 INFO - 'log_level': 'info', 12:22:52 INFO - 'log_name': 'talos', 12:22:52 INFO - 'log_to_console': True, 12:22:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:22:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:22:52 INFO - 'opt_config_files': (), 12:22:52 INFO - 'pip_index': False, 12:22:52 INFO - 'sps_profile': False, 12:22:52 INFO - 'sps_profile_interval': 0, 12:22:52 INFO - 'suite': 'dromaeojs', 12:22:52 INFO - 'system_bits': '32', 12:22:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:22:52 INFO - 'title': 'talos-linux64-ix-045', 12:22:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:22:52 INFO - 'use_talos_json': True, 12:22:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:22:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:22:52 INFO - 'work_dir': 'build'} 12:22:52 INFO - [mozharness: 2016-09-02 19:22:52.106557Z] Running clobber step. 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: clobber 12:22:52 INFO - rmtree: /builds/slave/test/build 12:22:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - [mozharness: 2016-09-02 19:22:52.560918Z] Finished clobber step (success) 12:22:52 INFO - [mozharness: 2016-09-02 19:22:52.561021Z] Running read-buildbot-config step. 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: read_buildbot_config 12:22:52 INFO - Using buildbot properties: 12:22:52 INFO - { 12:22:52 INFO - "project": "", 12:22:52 INFO - "product": "firefox", 12:22:52 INFO - "script_repo_revision": "production", 12:22:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:22:52 INFO - "repository": "", 12:22:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:22:52 INFO - "buildid": "20160902104649", 12:22:52 INFO - "pgo_build": "False", 12:22:52 INFO - "basedir": "/builds/slave/test", 12:22:52 INFO - "buildnumber": 602, 12:22:52 INFO - "slavename": "talos-linux64-ix-045", 12:22:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:22:52 INFO - "platform": "ubuntu64_hw", 12:22:52 INFO - "scheduler": "tests-autoland-linux64-talos", 12:22:52 INFO - "branch": "autoland", 12:22:52 INFO - "repo_path": "integration/autoland", 12:22:52 INFO - "revision": "97471e6c4d4c67339d3896f7df36b02e1d570105", 12:22:52 INFO - "stage_platform": "linux64", 12:22:52 INFO - "builduid": "1080ab1fa3a74daf807266848dd07e82", 12:22:52 INFO - "slavebuilddir": "test" 12:22:52 INFO - } 12:22:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:22:52 INFO - Running post-action listener: _resource_record_post_action 12:22:52 INFO - [mozharness: 2016-09-02 19:22:52.563490Z] Finished read-buildbot-config step (success) 12:22:52 INFO - [mozharness: 2016-09-02 19:22:52.563580Z] Running download-and-extract step. 12:22:52 INFO - Running pre-action listener: _resource_record_pre_action 12:22:52 INFO - Running main action method: download_and_extract 12:22:52 INFO - mkdir: /builds/slave/test/build/tests 12:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:52 INFO - trying https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:22:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:22:53 INFO - Downloaded 1361 bytes. 12:22:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:22:53 INFO - Using the following test package requirements: 12:22:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:22:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'jsshell-linux-x86_64.zip'], 12:22:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:22:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:22:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:22:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:22:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22: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:22:53 INFO - trying https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:22:55 INFO - Downloaded 20335050 bytes. 12:22:55 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:22:59 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:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:22:59 INFO - trying https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:22:59 INFO - Downloading https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:23:00 INFO - Downloaded 20335050 bytes. 12:23:00 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:23: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:23:04 INFO - trying https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:23:04 INFO - Downloading https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:23:06 INFO - Downloaded 14413998 bytes. 12:23:06 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:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:06 INFO - trying https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:23:06 INFO - Downloading https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:23:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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:23:08 INFO - Downloaded 55883846 bytes. 12:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:23:08 INFO - mkdir: /builds/slave/test/properties 12:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 12:23:08 INFO - Contents: 12:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:23:09 INFO - Running post-action listener: _resource_record_post_action 12:23:09 INFO - Running post-action listener: set_extra_try_arguments 12:23:09 INFO - [mozharness: 2016-09-02 19:23:09.380669Z] Finished download-and-extract step (success) 12:23:09 INFO - [mozharness: 2016-09-02 19:23:09.380895Z] Running populate-webroot step. 12:23:09 INFO - Running pre-action listener: _resource_record_pre_action 12:23:09 INFO - Running main action method: populate_webroot 12:23:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:23:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:23:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:23:09 INFO - '--tppagecycles', 12:23:09 INFO - '7'], 12:23:09 INFO - 'tests': ['tsvgm']}}, 12:23:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:23:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:23:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:23:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:23:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:23:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['damp', 'tps']}, 12:23:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'tests': ['damp', 'tps']}, 12:23:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['dromaeo_dom']}, 12:23:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:23:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['basic_compositor_video']}, 12:23:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:23:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['a11yr', 12:23:09 INFO - 'ts_paint', 12:23:09 INFO - 'tpaint', 12:23:09 INFO - 'sessionrestore', 12:23:09 INFO - 'sessionrestore_no_auto_restore', 12:23:09 INFO - 'tabpaint']}, 12:23:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tsvgx', 12:23:09 INFO - 'tsvgr_opacity', 12:23:09 INFO - 'tart', 12:23:09 INFO - 'tscrollx', 12:23:09 INFO - 'cart']}, 12:23:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:23:09 INFO - 'tsvgr_opacity', 12:23:09 INFO - 'tart', 12:23:09 INFO - 'tscrollx', 12:23:09 INFO - 'cart']}, 12:23:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s'], 12:23:09 INFO - 'tests': ['tp5o']}, 12:23:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'tests': ['tp5o']}, 12:23:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'talos_options': ['--disable-e10s', 12:23:09 INFO - '--xperf_path', 12:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:09 INFO - 'tests': ['tp5n']}, 12:23:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:23:09 INFO - 'talos_options': ['--xperf_path', 12:23:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:23:09 INFO - 'tests': ['tp5n']}}, 12:23:09 INFO - 'talos.zip': {'path': '', 12:23:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:23:09 INFO - Running post-action listener: _resource_record_post_action 12:23:09 INFO - [mozharness: 2016-09-02 19:23:09.397570Z] Finished populate-webroot step (success) 12:23:09 INFO - [mozharness: 2016-09-02 19:23:09.397661Z] Running create-virtualenv step. 12:23:09 INFO - Running pre-action listener: _resource_record_pre_action 12:23:09 INFO - Running main action method: create_virtualenv 12:23:09 INFO - Creating virtualenv /builds/slave/test/build/venv 12:23:09 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:23:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:23:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:23:09 INFO - Using real prefix '/usr' 12:23:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:23:10 INFO - Installing distribute.............................................................................................................................................................................................done. 12:23:11 INFO - Installing pip.................done. 12:23:11 INFO - Return code: 0 12:23:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:23:11 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:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:11 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:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:11 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:11 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:23:11 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:23:11 INFO - Using env: {'DISPLAY': ':0', 12:23:11 INFO - 'HOME': '/home/cltbld', 12:23:11 INFO - 'LANG': 'en_US.UTF-8', 12:23:11 INFO - 'LANGUAGE': 'en_US:en', 12:23:11 INFO - 'LOGNAME': 'cltbld', 12:23:11 INFO - 'MAIL': '/var/mail/cltbld', 12:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:11 INFO - 'MOZ_NO_REMOTE': '1', 12:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:11 INFO - 'NO_EM_RESTART': '1', 12:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:11 INFO - 'PWD': '/builds/slave/test', 12:23:11 INFO - 'SHELL': '/bin/bash', 12:23:11 INFO - 'SHLVL': '1', 12:23:11 INFO - 'TERM': 'linux', 12:23:11 INFO - 'TMOUT': '86400', 12:23:11 INFO - 'USER': 'cltbld', 12:23:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:11 INFO - '_': '/tools/buildbot/bin/python'} 12:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:12 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:23:12 INFO - Cleaning up... 12:23:12 INFO - Return code: 0 12:23:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:23:12 INFO - Using env: {'DISPLAY': ':0', 12:23:12 INFO - 'HOME': '/home/cltbld', 12:23:12 INFO - 'LANG': 'en_US.UTF-8', 12:23:12 INFO - 'LANGUAGE': 'en_US:en', 12:23:12 INFO - 'LOGNAME': 'cltbld', 12:23:12 INFO - 'MAIL': '/var/mail/cltbld', 12:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:12 INFO - 'MOZ_NO_REMOTE': '1', 12:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:12 INFO - 'NO_EM_RESTART': '1', 12:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:12 INFO - 'PWD': '/builds/slave/test', 12:23:12 INFO - 'SHELL': '/bin/bash', 12:23:12 INFO - 'SHLVL': '1', 12:23:12 INFO - 'TERM': 'linux', 12:23:12 INFO - 'TMOUT': '86400', 12:23:12 INFO - 'USER': 'cltbld', 12:23:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:12 INFO - '_': '/tools/buildbot/bin/python'} 12:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:12 INFO - Downloading/unpacking psutil>=3.1.1 12:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:14 INFO - Installing collected packages: psutil 12:23:14 INFO - Running setup.py install for psutil 12:23:14 INFO - building 'psutil._psutil_linux' extension 12:23:14 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:23:14 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:23:14 INFO - building 'psutil._psutil_posix' extension 12:23:14 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:23:14 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:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:23:14 INFO - Successfully installed psutil 12:23:14 INFO - Cleaning up... 12:23:14 INFO - Return code: 0 12:23:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:23:14 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:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:14 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:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:14 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:14 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:23:14 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:23:14 INFO - Using env: {'DISPLAY': ':0', 12:23:14 INFO - 'HOME': '/home/cltbld', 12:23:14 INFO - 'LANG': 'en_US.UTF-8', 12:23:14 INFO - 'LANGUAGE': 'en_US:en', 12:23:14 INFO - 'LOGNAME': 'cltbld', 12:23:14 INFO - 'MAIL': '/var/mail/cltbld', 12:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:14 INFO - 'MOZ_NO_REMOTE': '1', 12:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:14 INFO - 'NO_EM_RESTART': '1', 12:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:14 INFO - 'PWD': '/builds/slave/test', 12:23:14 INFO - 'SHELL': '/bin/bash', 12:23:14 INFO - 'SHLVL': '1', 12:23:14 INFO - 'TERM': 'linux', 12:23:14 INFO - 'TMOUT': '86400', 12:23:14 INFO - 'USER': 'cltbld', 12:23:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:14 INFO - '_': '/tools/buildbot/bin/python'} 12:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:23:17 INFO - Installing collected packages: mozsystemmonitor 12:23:17 INFO - Running setup.py install for mozsystemmonitor 12:23:17 INFO - Successfully installed mozsystemmonitor 12:23:17 INFO - Cleaning up... 12:23:17 INFO - Return code: 0 12:23:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:17 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:17 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:23:17 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:23:17 INFO - Using env: {'DISPLAY': ':0', 12:23:17 INFO - 'HOME': '/home/cltbld', 12:23:17 INFO - 'LANG': 'en_US.UTF-8', 12:23:17 INFO - 'LANGUAGE': 'en_US:en', 12:23:17 INFO - 'LOGNAME': 'cltbld', 12:23:17 INFO - 'MAIL': '/var/mail/cltbld', 12:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:17 INFO - 'MOZ_NO_REMOTE': '1', 12:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:17 INFO - 'NO_EM_RESTART': '1', 12:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:17 INFO - 'PWD': '/builds/slave/test', 12:23:17 INFO - 'SHELL': '/bin/bash', 12:23:17 INFO - 'SHLVL': '1', 12:23:17 INFO - 'TERM': 'linux', 12:23:17 INFO - 'TMOUT': '86400', 12:23:17 INFO - 'USER': 'cltbld', 12:23:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:17 INFO - '_': '/tools/buildbot/bin/python'} 12:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:17 INFO - Downloading/unpacking jsonschema==2.5.1 12:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:23:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:23:19 INFO - warning: no files found matching '*.txt' 12:23:19 INFO - no previously-included directories found matching 'build' 12:23:19 INFO - no previously-included directories found matching 'dist' 12:23:19 INFO - no previously-included directories found matching '.git*' 12:23:19 INFO - Installing collected packages: jsonschema, functools32 12:23:19 INFO - Running setup.py install for functools32 12:23:19 INFO - warning: no files found matching '*.txt' 12:23:19 INFO - no previously-included directories found matching 'build' 12:23:19 INFO - no previously-included directories found matching 'dist' 12:23:19 INFO - no previously-included directories found matching '.git*' 12:23:19 INFO - Successfully installed jsonschema functools32 12:23:19 INFO - Cleaning up... 12:23:19 INFO - Return code: 0 12:23:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:19 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:19 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:23:19 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:23:19 INFO - Using env: {'DISPLAY': ':0', 12:23:19 INFO - 'HOME': '/home/cltbld', 12:23:19 INFO - 'LANG': 'en_US.UTF-8', 12:23:19 INFO - 'LANGUAGE': 'en_US:en', 12:23:19 INFO - 'LOGNAME': 'cltbld', 12:23:19 INFO - 'MAIL': '/var/mail/cltbld', 12:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:19 INFO - 'MOZ_NO_REMOTE': '1', 12:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:19 INFO - 'NO_EM_RESTART': '1', 12:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:19 INFO - 'PWD': '/builds/slave/test', 12:23:19 INFO - 'SHELL': '/bin/bash', 12:23:19 INFO - 'SHLVL': '1', 12:23:19 INFO - 'TERM': 'linux', 12:23:19 INFO - 'TMOUT': '86400', 12:23:19 INFO - 'USER': 'cltbld', 12:23:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:19 INFO - '_': '/tools/buildbot/bin/python'} 12:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:23:20 INFO - Cleaning up... 12:23:20 INFO - Return code: 0 12:23:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:23:20 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:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:20 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:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:20 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:20 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:23:20 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:23:20 INFO - Using env: {'DISPLAY': ':0', 12:23:20 INFO - 'HOME': '/home/cltbld', 12:23:20 INFO - 'LANG': 'en_US.UTF-8', 12:23:20 INFO - 'LANGUAGE': 'en_US:en', 12:23:20 INFO - 'LOGNAME': 'cltbld', 12:23:20 INFO - 'MAIL': '/var/mail/cltbld', 12:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:20 INFO - 'MOZ_NO_REMOTE': '1', 12:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:20 INFO - 'NO_EM_RESTART': '1', 12:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:20 INFO - 'PWD': '/builds/slave/test', 12:23:20 INFO - 'SHELL': '/bin/bash', 12:23:20 INFO - 'SHLVL': '1', 12:23:20 INFO - 'TERM': 'linux', 12:23:20 INFO - 'TMOUT': '86400', 12:23:20 INFO - 'USER': 'cltbld', 12:23:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:20 INFO - '_': '/tools/buildbot/bin/python'} 12:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:23:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:23:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:23:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:22 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:23:23 INFO - Downloading docopt-0.6.1.tar.gz 12:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:23:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:23:23 INFO - Running setup.py install for blobuploader 12:23:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:23:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:23:23 INFO - Running setup.py install for requests 12:23:23 INFO - Running setup.py install for docopt 12:23:23 INFO - Successfully installed blobuploader requests docopt 12:23:23 INFO - Cleaning up... 12:23:23 INFO - Return code: 0 12:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:23 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:23 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:23:23 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:23:23 INFO - Using env: {'DISPLAY': ':0', 12:23:23 INFO - 'HOME': '/home/cltbld', 12:23:23 INFO - 'LANG': 'en_US.UTF-8', 12:23:23 INFO - 'LANGUAGE': 'en_US:en', 12:23:23 INFO - 'LOGNAME': 'cltbld', 12:23:23 INFO - 'MAIL': '/var/mail/cltbld', 12:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:23 INFO - 'MOZ_NO_REMOTE': '1', 12:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:23 INFO - 'NO_EM_RESTART': '1', 12:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:23 INFO - 'PWD': '/builds/slave/test', 12:23:23 INFO - 'SHELL': '/bin/bash', 12:23:23 INFO - 'SHLVL': '1', 12:23:23 INFO - 'TERM': 'linux', 12:23:23 INFO - 'TMOUT': '86400', 12:23:23 INFO - 'USER': 'cltbld', 12:23:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:23 INFO - '_': '/tools/buildbot/bin/python'} 12:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:23 INFO - Running setup.py (path:/tmp/pip-GwizhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:24 INFO - Running setup.py (path:/tmp/pip-75O3Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:24 INFO - Running setup.py (path:/tmp/pip-emJ6mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:24 INFO - Running setup.py (path:/tmp/pip-WeEomu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:24 INFO - Running setup.py (path:/tmp/pip-_88GCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:24 INFO - Running setup.py (path:/tmp/pip-ClK2IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:24 INFO - Running setup.py (path:/tmp/pip-nRB8Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:24 INFO - Running setup.py (path:/tmp/pip-aGKkBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:24 INFO - Running setup.py (path:/tmp/pip-23lNAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:24 INFO - Running setup.py (path:/tmp/pip-tEtrwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:24 INFO - Running setup.py (path:/tmp/pip-mtzuuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:24 INFO - Running setup.py (path:/tmp/pip-bfJbgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:24 INFO - Running setup.py (path:/tmp/pip-osHhXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:24 INFO - Running setup.py (path:/tmp/pip-4AKc2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:25 INFO - Running setup.py (path:/tmp/pip-FzneMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:25 INFO - Running setup.py (path:/tmp/pip-HCtV5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:25 INFO - Running setup.py (path:/tmp/pip-gOZJVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:23:25 INFO - Running setup.py install for manifestparser 12:23:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozcrash 12:23:25 INFO - Running setup.py install for mozdebug 12:23:25 INFO - Running setup.py install for mozdevice 12:23:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozfile 12:23:25 INFO - Running setup.py install for mozhttpd 12:23:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozinfo 12:23:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:23:25 INFO - Running setup.py install for mozInstall 12:23:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozleak 12:23:26 INFO - Running setup.py install for mozlog 12:23:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for moznetwork 12:23:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozprocess 12:23:26 INFO - Running setup.py install for mozprofile 12:23:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozrunner 12:23:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Running setup.py install for mozscreenshot 12:23:26 INFO - Running setup.py install for moztest 12:23:26 INFO - Running setup.py install for mozversion 12:23:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:23:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:23:26 INFO - Cleaning up... 12:23:26 INFO - Return code: 0 12:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:27 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:27 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:23:27 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:23:27 INFO - Using env: {'DISPLAY': ':0', 12:23:27 INFO - 'HOME': '/home/cltbld', 12:23:27 INFO - 'LANG': 'en_US.UTF-8', 12:23:27 INFO - 'LANGUAGE': 'en_US:en', 12:23:27 INFO - 'LOGNAME': 'cltbld', 12:23:27 INFO - 'MAIL': '/var/mail/cltbld', 12:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:27 INFO - 'MOZ_NO_REMOTE': '1', 12:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:27 INFO - 'NO_EM_RESTART': '1', 12:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:27 INFO - 'PWD': '/builds/slave/test', 12:23:27 INFO - 'SHELL': '/bin/bash', 12:23:27 INFO - 'SHLVL': '1', 12:23:27 INFO - 'TERM': 'linux', 12:23:27 INFO - 'TMOUT': '86400', 12:23:27 INFO - 'USER': 'cltbld', 12:23:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:27 INFO - '_': '/tools/buildbot/bin/python'} 12:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:23:27 INFO - Running setup.py (path:/tmp/pip-81JHAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:23:27 INFO - Running setup.py (path:/tmp/pip-kRB5kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:23:27 INFO - Running setup.py (path:/tmp/pip-3FHOE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:23:27 INFO - Running setup.py (path:/tmp/pip-sP_Yxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:23:27 INFO - Running setup.py (path:/tmp/pip-rCdmFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:23:27 INFO - Running setup.py (path:/tmp/pip-XV0Flo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:23:27 INFO - Running setup.py (path:/tmp/pip-6dvPbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:23:27 INFO - Running setup.py (path:/tmp/pip-dIjeUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:23:27 INFO - Running setup.py (path:/tmp/pip-vAgPpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:23:27 INFO - Running setup.py (path:/tmp/pip-6FAqsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:23:27 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:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:23:27 INFO - Running setup.py (path:/tmp/pip-MiZ1Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:23:28 INFO - Running setup.py (path:/tmp/pip-gf2c7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:23:28 INFO - Running setup.py (path:/tmp/pip-lQZreI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:23:28 INFO - Running setup.py (path:/tmp/pip-_cPw6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:28 INFO - Running setup.py (path:/tmp/pip-hvrvbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:23:28 INFO - Running setup.py (path:/tmp/pip-1FnDWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:23:28 INFO - Running setup.py (path:/tmp/pip-n3hFXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:30 INFO - Downloading blessings-1.6.tar.gz 12:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:23:30 INFO - Installing collected packages: blessings 12:23:30 INFO - Running setup.py install for blessings 12:23:30 INFO - Successfully installed blessings 12:23:30 INFO - Cleaning up... 12:23:30 INFO - Return code: 0 12:23:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:30 INFO - Reading from file tmpfile_stdout 12:23:30 INFO - Current package versions: 12:23:30 INFO - argparse == 1.2.1 12:23:30 INFO - blessings == 1.6 12:23:30 INFO - blobuploader == 1.2.4 12:23:30 INFO - docopt == 0.6.1 12:23:30 INFO - functools32 == 3.2.3-2 12:23:30 INFO - jsonschema == 2.5.1 12:23:30 INFO - manifestparser == 1.1 12:23:30 INFO - mozInstall == 1.12 12:23:30 INFO - mozcrash == 0.17 12:23:30 INFO - mozdebug == 0.1 12:23:30 INFO - mozdevice == 0.48 12:23:30 INFO - mozfile == 1.2 12:23:30 INFO - mozhttpd == 0.7 12:23:30 INFO - mozinfo == 0.9 12:23:30 INFO - mozleak == 0.1 12:23:30 INFO - mozlog == 3.3 12:23:30 INFO - moznetwork == 0.27 12:23:30 INFO - mozprocess == 0.23 12:23:30 INFO - mozprofile == 0.28 12:23:30 INFO - mozrunner == 6.12 12:23:30 INFO - mozscreenshot == 0.1 12:23:30 INFO - mozsystemmonitor == 0.3 12:23:30 INFO - moztest == 0.7 12:23:30 INFO - mozversion == 1.4 12:23:30 INFO - psutil == 3.1.1 12:23:30 INFO - requests == 1.2.3 12:23:30 INFO - wsgiref == 0.1.2 12:23:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:30 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:23:30 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:23:30 INFO - Using env: {'DISPLAY': ':0', 12:23:30 INFO - 'HOME': '/home/cltbld', 12:23:30 INFO - 'LANG': 'en_US.UTF-8', 12:23:30 INFO - 'LANGUAGE': 'en_US:en', 12:23:30 INFO - 'LOGNAME': 'cltbld', 12:23:30 INFO - 'MAIL': '/var/mail/cltbld', 12:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:30 INFO - 'MOZ_NO_REMOTE': '1', 12:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:30 INFO - 'NO_EM_RESTART': '1', 12:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:30 INFO - 'PWD': '/builds/slave/test', 12:23:30 INFO - 'SHELL': '/bin/bash', 12:23:30 INFO - 'SHLVL': '1', 12:23:30 INFO - 'TERM': 'linux', 12:23:30 INFO - 'TMOUT': '86400', 12:23:30 INFO - 'USER': 'cltbld', 12:23:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:30 INFO - '_': '/tools/buildbot/bin/python'} 12:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 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:23:30 INFO - Cleaning up... 12:23:30 INFO - Return code: 0 12:23:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:23:30 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 0x7f77d84dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, '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': '4300f881736b422476174874000001bc-1472843764.257459-281163976', '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:23:30 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:23:30 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:23:30 INFO - Using env: {'DISPLAY': ':0', 12:23:30 INFO - 'HOME': '/home/cltbld', 12:23:30 INFO - 'LANG': 'en_US.UTF-8', 12:23:30 INFO - 'LANGUAGE': 'en_US:en', 12:23:30 INFO - 'LOGNAME': 'cltbld', 12:23:30 INFO - 'MAIL': '/var/mail/cltbld', 12:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:30 INFO - 'MOZ_NO_REMOTE': '1', 12:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:30 INFO - 'NO_EM_RESTART': '1', 12:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:30 INFO - 'PWD': '/builds/slave/test', 12:23:30 INFO - 'SHELL': '/bin/bash', 12:23:30 INFO - 'SHLVL': '1', 12:23:30 INFO - 'TERM': 'linux', 12:23:30 INFO - 'TMOUT': '86400', 12:23:30 INFO - 'USER': 'cltbld', 12:23:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:30 INFO - '_': '/tools/buildbot/bin/python'} 12:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:23:31 INFO - Cleaning up... 12:23:31 INFO - Return code: 0 12:23:31 INFO - Running post-action listener: _resource_record_post_action 12:23:31 INFO - Running post-action listener: _start_resource_monitoring 12:23:31 INFO - Starting resource monitoring. 12:23:31 INFO - [mozharness: 2016-09-02 19:23:31.231715Z] Finished create-virtualenv step (success) 12:23:31 INFO - [mozharness: 2016-09-02 19:23:31.232218Z] Running install step. 12:23:31 INFO - Running pre-action listener: _resource_record_pre_action 12:23:31 INFO - Running main action method: install 12:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:23:31 INFO - Reading from file tmpfile_stdout 12:23:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:23:31 INFO - Reading from file tmpfile_stdout 12:23:31 INFO - Output received: 12:23:31 INFO - Usage: mozinstall [options] installer 12:23:31 INFO - Options: 12:23:31 INFO - -h, --help show this help message and exit 12:23:31 INFO - -d DEST, --destination=DEST 12:23:31 INFO - Directory to install application into. [default: 12:23:31 INFO - "/builds/slave/test"] 12:23:31 INFO - --app=APP Application being installed. [default: firefox] 12:23:31 INFO - mkdir: /builds/slave/test/build/application 12:23:31 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:23:31 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:23:47 INFO - Reading from file tmpfile_stdout 12:23:47 INFO - Output received: 12:23:47 INFO - /builds/slave/test/build/application/firefox/firefox 12:23:47 INFO - Running post-action listener: _resource_record_post_action 12:23:47 INFO - [mozharness: 2016-09-02 19:23:47.654979Z] Finished install step (success) 12:23:47 INFO - [mozharness: 2016-09-02 19:23:47.655261Z] Running run-tests step. 12:23:47 INFO - Running pre-action listener: _resource_record_pre_action 12:23:47 INFO - Running main action method: run_tests 12:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:23:47 INFO - Python 2.7.3 12:23:47 INFO - Return code: 0 12:23:47 INFO - grabbing minidump binary from tooltool 12:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:23:47 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 0x2728090>, '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 0x272b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:23:47 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:23:47 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:23:47 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:23:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:23:47 INFO - Return code: 0 12:23:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:23:47 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/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:23:47 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/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:23:47 INFO - Using env: {'DISPLAY': ':0', 12:23:47 INFO - 'HOME': '/home/cltbld', 12:23:47 INFO - 'LANG': 'en_US.UTF-8', 12:23:47 INFO - 'LANGUAGE': 'en_US:en', 12:23:47 INFO - 'LOGNAME': 'cltbld', 12:23:47 INFO - 'MAIL': '/var/mail/cltbld', 12:23:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:23:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:23:47 INFO - 'MOZ_NO_REMOTE': '1', 12:23:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:23:47 INFO - 'NO_EM_RESTART': '1', 12:23:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:23:47 INFO - 'PWD': '/builds/slave/test', 12:23:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:23:47 INFO - 'SHELL': '/bin/bash', 12:23:47 INFO - 'SHLVL': '1', 12:23:47 INFO - 'TERM': 'linux', 12:23:47 INFO - 'TMOUT': '86400', 12:23:47 INFO - 'USER': 'cltbld', 12:23:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472843764.257459-281163976', 12:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:23:47 INFO - '_': '/tools/buildbot/bin/python'} 12:23:47 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/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:23:47 INFO - mozversion application_buildid: 20160902104649 12:23:47 INFO - mozversion application_changeset: 97471e6c4d4c67339d3896f7df36b02e1d570105 12:23:47 INFO - mozversion application_display_name: Nightly 12:23:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:23:47 INFO - mozversion application_name: Firefox 12:23:47 INFO - mozversion application_remotingname: firefox 12:23:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:23:47 INFO - mozversion application_vendor: Mozilla 12:23:47 INFO - mozversion application_version: 51.0a1 12:23:47 INFO - mozversion platform_buildid: 20160902104649 12:23:47 INFO - mozversion platform_changeset: 97471e6c4d4c67339d3896f7df36b02e1d570105 12:23:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:23:47 INFO - mozversion platform_version: 51.0a1 12:23:47 INFO - using testdate: 1472844227 12:23:47 INFO - actual date: 1472844227 12:23:47 INFO - starting webserver on 'localhost:59192' 12:23:47 INFO - SUITE-START | Running 2 tests 12:23:47 INFO - TEST-START | dromaeo_css 12:23:47 INFO - operating with platform_type : linux_ 12:23:47 INFO - Initialising browser for dromaeo_css test... 12:23:47 INFO - TEST-INFO | started process 4352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHTU1M/profile http://localhost:59192/getInfo.html) 12:23:52 INFO - PROCESS | 4352 | __metrics Screen width/height:1600/1200 12:23:52 INFO - PROCESS | 4352 | colorDepth:24 12:23:52 INFO - PROCESS | 4352 | Browser inner width/height: 1024/697 12:23:52 INFO - PROCESS | 4352 | __metrics 12:23:53 INFO - PROCESS | 4352 | 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:23:53 INFO - PROCESS | 4352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:23:53 INFO - PROCESS | 4352 | console.error: PushService: 12:23:53 INFO - PROCESS | 4352 | stateChangeProcessEnqueue: Error transitioning state 12:23:53 INFO - PROCESS | 4352 | UnknownError 12:23:54 INFO - TEST-INFO | 4352: exit 0 12:23:54 INFO - Browser initialized. 12:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:23:54 INFO - TEST-INFO | started process 4434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHTU1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:24:06 INFO - PROCESS | 4434 | RSS: Main: 181252096 12:24:06 INFO - PROCESS | 4434 | 12:24:58 INFO - PROCESS | 4434 | 1472844298409 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:27:12 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59192/tests/dromaeo/cssquery-ext.html) 12:27:13 INFO - PROCESS | 4434 | RSS: Main: 283504640 12:27:13 INFO - PROCESS | 4434 | 12:30:15 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-ext.html (next: http://localhost:59192/tests/dromaeo/cssquery-jquery.html) 12:30:16 INFO - PROCESS | 4434 | RSS: Main: 277819392 12:30:16 INFO - PROCESS | 4434 | 12:33:18 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59192/tests/dromaeo/cssquery-mootools.html) 12:33:19 INFO - PROCESS | 4434 | RSS: Main: 220172288 12:33:19 INFO - PROCESS | 4434 | 12:36:21 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59192/tests/dromaeo/cssquery-prototype.html) 12:36:22 INFO - PROCESS | 4434 | RSS: Main: 217903104 12:36:22 INFO - PROCESS | 4434 | 12:39:25 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59192/tests/dromaeo/cssquery-yui.html) 12:39:26 INFO - PROCESS | 4434 | RSS: Main: 219516928 12:39:26 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | Cycle 1(1): loaded http://localhost:59192/tests/dromaeo/cssquery-yui.html (next: http://localhost:59192/tests/dromaeo/cssquery-dojo.html) 12:42:29 INFO - PROCESS | 4434 | RSS: Main: 314056704 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | __start_tp_report 12:42:29 INFO - PROCESS | 4434 | _x_x_mozilla_page_load 12:42:29 INFO - PROCESS | 4434 | _x_x_mozilla_page_load_details 12:42:29 INFO - PROCESS | 4434 | |i|pagename|runs| 12:42:29 INFO - PROCESS | 4434 | |0;dojo.html;2574.8068894832886;2590.2358804152773;2605.5700809366454;2613.7778288845448;2643.7224091470407;4538.7503687297185;4623.398958135442;4641.489436162028;4700.341952126705;4762.261849413342;4632.583067523922;4677.321788340689;4680.789364478598;4698.788554515047;4700.130475861968;4311.1808756336195;4373.497047839492;4376.256036473791;4381.211381951248;4383;4282.400463935036;4364.912701745963;4384.517703052662;4403.911921761563;4456.242438785414;4368.759718215497;4436.112777444508;4444.622207112399;4445.666575006888;4450.26570615848;4191.140816132685;4235.9364609530885;4333.1766964277;4384.9561504384865;4398.120375924827;4185.602367775056;4206.074663574009;4266.338717498793;4275.444192255018;4310.116426132635;4535.229011068126;4599.264117741145;4604.723716577016;4611.792469338888;4616.561426664462;4830.058138662962;4913.115639184945;4933.827316043921;4938.506149385069;4944.035912996967;4903.607711383081;5023.095842748304;5031.52200540948;5031.52200540948;5034.622403319729;4647.092847926316;4679;4679.578837904537;4687.343771871941;4750.7387093709485;5008.323876276729;5128.9230661540105;5134.204198349262;5140.897182056413;5141.665791723526;4957.950420495821;4966.15575352191;4991.675541089818;5051.570616497565;5051.595872330205;5070.746462676925;5079.3650793650795;5084.059449001872;5084.211947148198;5143.5113664201845;4829.299751536078;4896.779644915988;5015.874603134951;5030.949690503121;5040.395152581714;4959.677620954626;4969.428515720666;4970.17992031318;4973.055119527278;4976.178930476431;4208.6633069354375;4209.1792100540715;4238.300680387763;4282.957170428318;4289.871303860889;3682.9447558286647;3690.464882592009;3727.925441491155;3733.8506459741848;3769.076576238839;4312.956870431255;4337.674674399433;4356.477222733292;4407.889802754957;4411.955880441219;4872.585830204473;4880.560749532559;5003.7998480061115;5006.599472042228;5018.422881368616;4282.464691913511;4294.6993710439965;4316.5467625899455;4338.978305108454;4406.228909940747;4489.079738653568;4491.708038977456;4497.392851965008;4504.48198457175;4548.95451045492;4506.752128632957;4687.320338550891;4687.3906392170165;4689.6248300136585;4736.8578942631775;4920.261960705922;5023;5024.447310795883;5029.9245511318095;5103.387593488805;4654.37165982588;4657.46439159501;4660.091282199938;4666.300054991779;4727.905441891212;4784.40194975628;4881.072596206709;4887.413510378778;4889.413270407574;4948.134076536664;4950.133726597903;4956.826511072095;4964.528369804862;4986.775595098156;5075.6193285502995;4844.273358996179;4860.052289803454;4860.659753817199;4861.878453038702;4922.237053256751;4746.572808447257;4836.879078023077;4848;4853.4418541868135;4909.705417674951;4827.444843843003;4848.418189817245;4920.286558448934;4926.802927882844;4930.309756634002;4934.136526107988;4935.62982776286;4951.405831300123;4959.9008019838675;5017.046761115376;4695.178343789891;4733.431988161443;4736;4800.519948005312;4858.975705121452 12:42:29 INFO - PROCESS | 4434 | |1;ext.html;565.2087078090673;578.7308901360864;579.94200579942;581.1515187825775;588.6762280745589;28049.859750701242;38320.61679383205;39626;39760.40359394608;43255.56744432563;39803.800980995125;39912.40131398024;39922.40116398256;39949;39978;7355.742549010785;7487.138979017428;7506.43701722373;7507.849843003137;7509.9624501877415;7414.147373052114;7506.474546781727;7512.962435187844;7534.359579435754;7539;7153.928460715379;7506.099268087837;7554.471187016884;7562.924370756277;7590.734324298651;7521.887171692429;7529.585872776995;7553.622318884089;7559.5464272143845;7561.810954726121;7476.1776204617445;7540.811479713051;7542.849143017109;7557.773266802004;7559.58422286774;37118.4432233514;37222.4416633748;37505.06237344061;37520;37542.62457375418;2999.505081661523;3014.231371000381;3059.8623061962267;3062.2803641144314;3107.7513798896034;27443;28303.292417689518;28304;28564.14307570776;28806.423871522453;3322.5680661513848;3359.6472370401;3406.9488957665653;3407.114150320934;3437.071990562534;263064;264990;265154;265334;265450;30774.38451230963;49312.75343623331;49627.25559116544;49634.75182624064;49661.75169124203;31077.533836992465;32983.83508082492;33050.83474582612;33093.17267068294;33097.17257068593;13737.725245495034;13788.241646709326;13791.896648268115;13882.236476993863;13891.4443422264;11487.0810335173;11521.942390287995;11522.76954460906;11527;11538.250013749079;7635.389168866477;7680.34717049046;7732.922670773332;7736.6518506667335;7755.650995705207;3001.474741920199;3013.322002549409;3036.16505461;3055.801372910754;3075.6309242890998;775.716863344875;881.453498830729;893.9374243803002;918.7151982885327;941.7786820097272;26854.5971810423;27580.310492237855;28023.299417514318;28345.881952985153;28401.147965561067;904.7511934218143;961.2022021721954;963.8457846744487;969.060011788564;983.2772911909741;14563.126212427289;14988.325525351385;15907.443239486562;16307.59231019234;16653.833461665472;394473;398555;399499;402523;402670;49357.25964110541;49823.50176498261;49826;49865.75067124641;49895.50104498908;1160.222650823933;1168.1705988747915;1197.3235122155954;1201.129181343519;1201.1771936223715;26909.86545067262;28464.715352847034;29024.727952533427;29213;29568.260793480335;40913.13608047527;46090.769546152056;48036;48156.27765583589;52873.7356313216;378334;380213;381219;381581;383976;37573.87278381544;37693.62306377011;37815.810920945216;37943.43084853785;38631;41558;41733.37399938943;42049.15901681888;42375.788121059195;42438.57561424346;35378.85566046687;35433.46849797203;35873.103172420895;35905.82047089748;36302;35660.46509302311;35723.28553428969;35996;36298.092547686516;36373.27253454863;34939;35111.64888351084;35236.823815881784;35298.29403411866;36185.45721814228;31317.8434107828;32923.835380822944;33012.66987330192;33055.8347208272;33084.33831323312;24600.384990374667;24930.127445539318;24940.127095552296;25242.24273271805;25443.36391590151 12:42:29 INFO - PROCESS | 4434 | |2;jquery.html;345.97924124552515;355.8078637535729;359.67269784496114;364.89053284014796;379.85375630382293;11723.237989530686;15737.763933541006;15750.606234844134;16300.510984670478;17176.57058573533;16252.674946501063;16394.344226230965;16608.169591520407;17012.48962531126;17153.57116072099;4921.581665558432;4974.1295273327205;5116.590672746172;5207.270982062514;5238.161894096946;3444.431668774649;3616.041748936534;5199.064168449678;5232.8691782705355;5245.265662807191;3592.335417947675;3620.81895905205;3626.8367923443507;4889.559939605435;5975.402459754033;5890.676012819294;6059.303180134297;6061.090836374535;6061.181740465025;6065.514758819284;5109.821156259551;5318.73406329682;5324.840254792362;5333.866653333697;5394.865128371783;11564.53741850325;12143.332116733576;12226.327551984637;12452.439640216122;12487.188332758342;1789.5078853315313;1818.5362732503258;1823.088455772114;1867.5891303913118;1940.2917934953782;9013.774655633597;9130;9137.629355596713;9295.11696388842;12581.874181258254;1675.9329626814913;1677.7147884859603;1686.0810858082375;1724.767156433878;1760.4102625620433;65064;68590.65704671445;69205.65397173032;70353;71503.28496715019;8846.557672116369;9079.81840363189;9236.8614470783;9411.764705882408;9518.238540916711;12234.571789987307;12248;12248.75502489963;12251.387430628432;12255.325957072268;6841.342682554512;7193.9280607194305;7313.48805583604;7326.560406375635;7368.189499155089;7115.181754098345;7128.180259270147;7168.139823221247;7335.669894854745;7347.595882226529;3815.8664446744233;3842.56038167178;3850.8844734658005;3851.9422208666892;3914.236723838824;1832.8075552067107;1868.3274021352302;1869.9719504207449;1874.22219778793;1916.9904150479438;796.1759578835877;798.8362385710915;807.3379828540658;823.0822632764424;878.3675753457501;16010.599735006717;16282.75575866363;16632.667346652997;16684.33262669504;17382.478525644252;818.4802650316973;837.2590257622048;843.4391129898548;848.4485084694998;861.4099341950658;9272.907270927204;9393.060693930553;9622.51887405641;9684.32209745311;9708.563114659857;362498;363160;363651;365254;368063;72272.99999999895;76041.61979190068;77251;77655.22344776592;78133.60933195411;891.2290868398788;917.0874979395411;921.0237148622615;922.2161163011386;922.6678395777515;15187.392504299703;15291.541253762405;15765.132917689638;16219.918900405895;16465.506034818976;27594.724052759215;28596.142115736562;36643.63356366402;37569.607598100476;37769.81115094407;46664.7666761664;48659.270110947655;48991.75504122599;49431.50568494413;51831.74084129706;7233.204347521873;7497.512661676974;7626.9618651906385;7903.84192316139;7973.242541958504;9861.309708320348;11753.353565553634;11995.520179192734;12209.96215321672;12253.326067066397;9901.900980990098;10130.594776208869;10233.283670143019;10284.640037598649;10575.048245657928;10061.295709300279;10221.795564088825;10231.079202871777;10298.742531436774;10603.89396106029;10242.59029638836;10379.429131397847;10545.683629491128;10627.840582391116;10930.672079837617;7607.885881711668;7767.961160194162;7868.685252589832;7908.4464087513325;8079.111297757359;9158.496282704515;10127.89872101299;10199.28604997643;10324.43215623118;10499.055085042077 12:42:29 INFO - PROCESS | 4434 | |3;mootools.html;1209.6854817747383;1326.615281568345;1366.3304980559526;1378.9931050344746;1602.9198540072994;7460.142083660381;7860.371170306369;7893.3685305175595;8101.108878023413;8119.553424561646;7988.0828601135745;8092.757217283491;8093.473924194923;8105.189481051892;8105.432619716607;2182.574397992388;2203.77690381838;2206.1396055538353;2210.0938615167784;2211.1929145861727;2136.7435907691097;2193.5722534105857;2217.800397964183;2219.9334019979347;2221.322496638533;2131.1049359269145;2153.5262242306667;2170.305502239284;2182.8035476807086;2217.3347995601334;2136.7756385579523;2162.178372218563;2172.532905425341;2173.402314363555;2173.71741673583;2072.0986370928695;2118.1950858673604;2130.2331160782105;2134.249915069628;2137.465633591602;7788.766337009899;7972.920270797334;8045.356371490267;8048.396370272253;8111.107778144399;4601.148787474328;4717.221658426355;4720.480747117815;4726.621870250372;4760.833370832039;2833.631627888382;2912.694167112465;2964.7183517565795;2979.0467050543834;2984;937.2408349237139;945.8864936207631;963.8698775665266;969.5394687523441;985.522021819417;10298.639547615798;10389.740256493647;10394.740131496697;10395.740106497322;10395.896041039645;4047.817848196838;4048.777317247521;4204.2432362175105;4224.831006759695;4242.575742425733;8337.499750015018;8340.37447191463;8348.373871959628;8349.4155409122;8350.70772522971;4598.425196850394;4599.678022538457;4599.724016559017;4600.838970636079;4601.8849528761375;3788.9431658525145;4116.4648595682365;4242.745435273893;4281.678874084456;4282.785860706952;3382.9661703383144;3408.199073217792;3516.5604299462566;3524.524189234472;3527.647235276503;1026.6919924022764;1066.4934156275863;1068.2041878800344;1075.8171110911164;1076.8653918260218;790.9723159689498;815.8123631564773;818.2799136759733;819.5492479136451;834.6536187482249;5321.068812957717;5507.411516587197;5762.481376676119;5821.126830975303;5923.822285331447;834.1866679986964;853.8591132463198;859.441363113981;866.8309679612415;869.8695195720693;3612.566492020922;3724.888253352404;3726.2174943261675;3856.4793752843566;3876.108495046155;9712.75718107053;10087.949560252151;10098.394096354243;10103.09072183507;10113;9986;10007.349522281029;10023.14803241718;10031.448270345056;10038.548265328078;7249.673764680602;7342.082239720035;7348.669309881068;7350;7351.081114860643;5184.922226166686;5326.201069839555;5335.759890804846;5483.177523371367;5619.887602247851;8782.516961567175;8792.252658524098;8804.735857924272;8812.118788121137;8847.823043539222;8668.653253869774;8966.462012279284;9097.818043639223;9164.083591640783;9176.816463670822;5958.702064896651;6399.968000159969;6475.643839588868;6631.071649969104;6683.365080317362;7577.393808495417;7825.960870195612;7838.686452541834;7840.451168418156;7855.5286682799215;6704.927211646308;6897.241303456515;6906.792796216121;6941.791746247621;7170.641467926687;6823.624700641512;6902.792916212522;6913.343232392915;6916.723331066701;6916.861662766817;6428.903566446601;6435;6454.064160696579;6488.286288508166;6522.412982831568;4495.842645507522;4545;4602.562756538124;4751.144793936986;4791.928121078117;4470.552944705503;4546.136234115507;4609;4616.976915115403;4725.9291110632685 12:42:29 INFO - PROCESS | 4434 | |4;prototype.html;299;302.34994761263283;302.75628119363915;311.7848684407757;311.93137509747874;4766.404199475066;4781.5218478152165;4798.328234047236;4800.807967681293;4833.903321933563;4719.764011799405;4723.551262630053;4725.291206319054;4727.338172655831;4746.525347465252;3535.9469607955966;3635.236600313924;3636.709063274945;3643.2531331077066;3655.232401195752;3623.8188090595495;3742.6257374262627;3768.547774267092;3769.18962423079;3787.734858559902;3733.2346868891814;3739.7195210359196;3740.2145549434517;3740.8403394947654;3750.1937083527037;3563.94654080189;3643.8178091095474;3661.6338366163172;3710.2764960832646;3737.9813100934593;3300.950485742716;3312.8840490582716;3323.3685599735973;3326.600807903043;3326.8170250636203;4578.313253012042;4580.808989662678;4582.679212455129;4583.495815460296;4587.380703605004;4244.3209086546;4255.468066491689;4257.233697934371;4260.424842646234;4265.616094551505;4719.221328480797;4876.390451193601;4920.852374428773;4925.802967881281;4931.358923339979;3603.5135256740527;3605.5757975599754;3608.260306637133;3615.8305016989857;3621.6559426854406;5117.820876269313;5143.562797162245;5162.6700777997985;5164.727519891236;5169.224616307546;3429.2112814052907;3596.730245231618;3715.405535114423;3719.8512059517316;3724.2551489701627;3648.908777280589;3653.5250417446096;3660.670539651444;3662.304162209225;3680.9631903681156;4137.97931010343;4161.0637606538285;4165.500139983161;4171.97914010428;4181.393697913785;4956.801727930914;4960.826371076995;4967.652264341534;4982.302477653131;4998.775055122455;1218.6344096770933;1256.9692851861569;1262.9810552841714;1267.619714085789;1278.9168704034207;782.4092809928468;813.4875028731861;824.674253669797;827.8302947895787;828.5235989306173;4023.539755810001;4274.444322238089;4324.437823082979;4469.307257375112;4507.549245075532;5132.769025393866;5152.330197074356;5164.1995490699;5186.351706036746;5193.5585475234275;4439.933400998988;4507.183010618363;4510.729356238636;4512.2329204035395;4516.706414083074;2582.341502916744;2676.7055623881356;2677.9732202678115;2686.570148776186;2696.2720065582184;4759.88185257564;4772.618190544748;4773.618110551217;4780.450248221429;4796.208625576741;5154.402135338058;5163.302954101224;5165.560927321145;5166.173412254097;5180.300659410931;4606.378138951266;4728.40894888139;4757.167495688241;4762.714237145782;4790.401199849949;5080.593552515864;5088.821891233789;5099.11899776625;5120.513551212629;5122.180451127951;4986.576141028053;5032.370953630796;5039.622028347815;5044.218146187347;5044.621653376085;4597.402337696078;4801.839172372376;4810.254410566367;4813.253945638432;4833.3958255218095;3515.648435156464;3571.339302229096;3578.606353301187;3583.7849729016343;3584.623614520438;5055.87360315995;5058.519440653132;5059.620528460307;5083.949160508348;5090.974545127251;4735.958089220366;4908.239222920453;4917.58200552957;4927.28554359623;4935.4570997190995;4902.289168070681;4910.779014944407;4922.237053256751;4926.48271931442;4934.5312195341385;4876.756162191948;4877.219644856806;4896.804127834846;4898.21628539432;4903.901921961612;4754.619630429488;4761.666683332133;4868.3427737255015;4956.628252880976;4972.129877271391;4682.906341873211;4762.333273341805;4767.356406885026;4774.427068751633;4912.336834527293 12:42:29 INFO - PROCESS | 4434 | |5;yui.html;633.1831936801526;643.4787821864287;679.894616334468;704.7145905908109;735.8822588385859;12452.750944981106;13625.386857591408;13647.249401282914;13662.863371366284;13687;12583.811242831365;13254.602361929157;13363.398647060882;13390.330483475836;13422.194668319908;603.604638961481;725.1624373848214;734.7538574577522;747.3722073458293;749.9212582678822;737.3437640499959;741;741.3957624535985;741.5402450480683;742.1428250370831;783.4711569690464;783.5298820707587;783.5807842804101;783.8079670480712;784.0826233307045;624.0981781325986;640.2668944059026;776.7397921696239;777.0442355902215;778.8052986753312;462.53746253746255;463.83765682011364;547.6467678347443;563.8167595531469;566.7308028686382;12432.502699891993;12456.564020259339;12457.75084498314;12461;12479;12356.814647780291;12727.299998500172;13101.606951791462;13523.32383380827;13557;11093.83359249612;11345.546178152947;11534.307941523452;11563;11964.880351196463;3910.7262491625597;3952.940705889414;3963.861264855745;3997.900052498711;4036.253293140778;67207.66396168037;67902.9814552787;68694;69726;69762.30237697609;10277.537510812032;10350.120239779702;10402.739931501774;10637.680869573926;10721.249512534048;19782;19800.801991980185;19815.207391704458;19850;19876.10557524915;6614.603123812491;6686.765963191362;6845.8973115403305;6896.517243792886;7017.92982070183;3552.1474846036767;3636.381815091388;3652.8356223969986;3721.4603882436895;3728.067983004249;2811.718828117213;2920.2261400728826;2930.7508861746564;2931.6628587712685;2932.9560056599166;482.3102962763212;496.6473803599413;500.314569040417;502.31434092463525;507.14545990006957;531.160765989743;551.0769461152554;556.3379578301889;558.2243903406317;563.613924461745;7221.42228621709;7374.889376659355;7889.723859664884;7926.960365198137;7947.443678942419;417.6763008668246;453.9989323541583;522.9215617657381;537.5323468582359;550.6668465578348;3441.8451169697423;3524.339123961444;3748.7938163401277;3850.210706805098;3902.5316961964745;53615.463845361824;53682.19476707852;79593;86147.13852861391;101718.49140754397;88346;89167.55416222877;90482.09517904869;92591.0740892596;92791.53604231936;80656.59671701604;81474.18525814785;81852.59073704593;81939.18060819316;83780;6924.169099708067;6995.230524642184;7129.7861064168155;7362.484626076123;7392.593407362647;44524.55475445204;45875.311870321304;46017.53982460133;46157.538424615326;46429.303560445944;50974;53911.73044134754;54464;59969;60407.69796150991;11502.309861408343;11522.942385288019;11734.237274577124;11769.705757356134;11998.64004079879;12594.307313097868;13219.933900330438;13916.721665566429;14257;14373.856261437251;12102.334371609646;12360.44378002974;12807.551735689207;13131.803022954855;13415.614179556213;12417.31704756211;12484.875151248734;12981.480740770263;13488.393022313823;13630.454781809014;11676.708082297671;11761.000314973324;11892.464839082435;12979.091463597835;13120.01599880032;9744.707658770249;9760.951195244263;10047.246456515644;10518.579256829642;10943.233973621771;9832.410055396698;10329.276950613685;10506.527206275583;10631.308964917256;10684.305520141477 12:42:29 INFO - PROCESS | 4434 | __end_tp_report 12:42:29 INFO - PROCESS | 4434 | __start_cc_report 12:42:29 INFO - PROCESS | 4434 | _x_x_mozilla_cycle_collect,1016 12:42:29 INFO - PROCESS | 4434 | __end_cc_report 12:42:29 INFO - PROCESS | 4434 | __startTimestamp1472845349579__endTimestamp 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | ------- Summary: start ------- 12:42:29 INFO - PROCESS | 4434 | Number of tests: 6 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#0] dojo.html Cycles:165 Average:4626.40 Median:4727.91 stddev:479.15 (10.1%) stddev-sans-first:452.78 12:42:29 INFO - PROCESS | 4434 | Values: 2574.8 2590.2 2605.6 2613.8 2643.7 4538.8 4623.4 4641.5 4700.3 4762.3 4632.6 4677.3 4680.8 4698.8 4700.1 4311.2 4373.5 4376.3 4381.2 4383.0 4282.4 4364.9 4384.5 4403.9 4456.2 4368.8 4436.1 4444.6 4445.7 4450.3 4191.1 4235.9 4333.2 4385.0 4398.1 4185.6 4206.1 4266.3 4275.4 4310.1 4535.2 4599.3 4604.7 4611.8 4616.6 4830.1 4913.1 4933.8 4938.5 4944.0 4903.6 5023.1 5031.5 5031.5 5034.6 4647.1 4679.0 4679.6 4687.3 4750.7 5008.3 5128.9 5134.2 5140.9 5141.7 4958.0 4966.2 4991.7 5051.6 5051.6 5070.7 5079.4 5084.1 5084.2 5143.5 4829.3 4896.8 5015.9 5030.9 5040.4 4959.7 4969.4 4970.2 4973.1 4976.2 4208.7 4209.2 4238.3 4283.0 4289.9 3682.9 3690.5 3727.9 3733.9 3769.1 4313.0 4337.7 4356.5 4407.9 4412.0 4872.6 4880.6 5003.8 5006.6 5018.4 4282.5 4294.7 4316.5 4339.0 4406.2 4489.1 4491.7 4497.4 4504.5 4549.0 4506.8 4687.3 4687.4 4689.6 4736.9 4920.3 5023.0 5024.4 5029.9 5103.4 4654.4 4657.5 4660.1 4666.3 4727.9 4784.4 4881.1 4887.4 4889.4 4948.1 4950.1 4956.8 4964.5 4986.8 5075.6 4844.3 4860.1 4860.7 4861.9 4922.2 4746.6 4836.9 4848.0 4853.4 4909.7 4827.4 4848.4 4920.3 4926.8 4930.3 4934.1 4935.6 4951.4 4959.9 5017.0 4695.2 4733.4 4736.0 4800.5 4859.0 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#1] ext.html Cycles:180 Average:49023.50 Median:37531.31 stddev:93491.33 (249.1%) stddev-sans-first:93682.81 12:42:29 INFO - PROCESS | 4434 | Values: 565.2 578.7 579.9 581.2 588.7 28049.9 38320.6 39626.0 39760.4 43255.6 39803.8 39912.4 39922.4 39949.0 39978.0 7355.7 7487.1 7506.4 7507.8 7510.0 7414.1 7506.5 7513.0 7534.4 7539.0 7153.9 7506.1 7554.5 7562.9 7590.7 7521.9 7529.6 7553.6 7559.5 7561.8 7476.2 7540.8 7542.8 7557.8 7559.6 37118.4 37222.4 37505.1 37520.0 37542.6 2999.5 3014.2 3059.9 3062.3 3107.8 27443.0 28303.3 28304.0 28564.1 28806.4 3322.6 3359.6 3406.9 3407.1 3437.1 263064.0 264990.0 265154.0 265334.0 265450.0 30774.4 49312.8 49627.3 49634.8 49661.8 31077.5 32983.8 33050.8 33093.2 33097.2 13737.7 13788.2 13791.9 13882.2 13891.4 11487.1 11521.9 11522.8 11527.0 11538.3 7635.4 7680.3 7732.9 7736.7 7755.7 3001.5 3013.3 3036.2 3055.8 3075.6 775.7 881.5 893.9 918.7 941.8 26854.6 27580.3 28023.3 28345.9 28401.1 904.8 961.2 963.8 969.1 983.3 14563.1 14988.3 15907.4 16307.6 16653.8 394473.0 398555.0 399499.0 402523.0 402670.0 49357.3 49823.5 49826.0 49865.8 49895.5 1160.2 1168.2 1197.3 1201.1 1201.2 26909.9 28464.7 29024.7 29213.0 29568.3 40913.1 46090.8 48036.0 48156.3 52873.7 378334.0 380213.0 381219.0 381581.0 383976.0 37573.9 37693.6 37815.8 37943.4 38631.0 41558.0 41733.4 42049.2 42375.8 42438.6 35378.9 35433.5 35873.1 35905.8 36302.0 35660.5 35723.3 35996.0 36298.1 36373.3 34939.0 35111.6 35236.8 35298.3 36185.5 31317.8 32923.8 33012.7 33055.8 33084.3 24600.4 24930.1 24940.1 25242.2 25443.4 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#2] jquery.html Cycles:180 Average:23057.77 Median:3851.41 stddev:60363.54 (1567.3%) stddev-sans-first:60508.79 12:42:29 INFO - PROCESS | 4434 | Values: 346.0 355.8 359.7 364.9 379.9 11723.2 15737.8 15750.6 16300.5 17176.6 16252.7 16394.3 16608.2 17012.5 17153.6 4921.6 4974.1 5116.6 5207.3 5238.2 3444.4 3616.0 5199.1 5232.9 5245.3 3592.3 3620.8 3626.8 4889.6 5975.4 5890.7 6059.3 6061.1 6061.2 6065.5 5109.8 5318.7 5324.8 5333.9 5394.9 11564.5 12143.3 12226.3 12452.4 12487.2 1789.5 1818.5 1823.1 1867.6 1940.3 9013.8 9130.0 9137.6 9295.1 12581.9 1675.9 1677.7 1686.1 1724.8 1760.4 65064.0 68590.7 69205.7 70353.0 71503.3 8846.6 9079.8 9236.9 9411.8 9518.2 12234.6 12248.0 12248.8 12251.4 12255.3 6841.3 7193.9 7313.5 7326.6 7368.2 7115.2 7128.2 7168.1 7335.7 7347.6 3815.9 3842.6 3850.9 3851.9 3914.2 1832.8 1868.3 1870.0 1874.2 1917.0 796.2 798.8 807.3 823.1 878.4 16010.6 16282.8 16632.7 16684.3 17382.5 818.5 837.3 843.4 848.4 861.4 9272.9 9393.1 9622.5 9684.3 9708.6 362498.0 363160.0 363651.0 365254.0 368063.0 72273.0 76041.6 77251.0 77655.2 78133.6 891.2 917.1 921.0 922.2 922.7 15187.4 15291.5 15765.1 16219.9 16465.5 27594.7 28596.1 36643.6 37569.6 37769.8 46664.8 48659.3 48991.8 49431.5 51831.7 7233.2 7497.5 7627.0 7903.8 7973.2 9861.3 11753.4 11995.5 12210.0 12253.3 9901.9 10130.6 10233.3 10284.6 10575.0 10061.3 10221.8 10231.1 10298.7 10603.9 10242.6 10379.4 10545.7 10627.8 10930.7 7607.9 7768.0 7868.7 7908.4 8079.1 9158.5 10127.9 10199.3 10324.4 10499.1 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#3] mootools.html Cycles:180 Average:5176.48 Median:4755.99 stddev:2905.44 (61.1%) stddev-sans-first:2898.30 12:42:29 INFO - PROCESS | 4434 | Values: 1209.7 1326.6 1366.3 1379.0 1602.9 7460.1 7860.4 7893.4 8101.1 8119.6 7988.1 8092.8 8093.5 8105.2 8105.4 2182.6 2203.8 2206.1 2210.1 2211.2 2136.7 2193.6 2217.8 2219.9 2221.3 2131.1 2153.5 2170.3 2182.8 2217.3 2136.8 2162.2 2172.5 2173.4 2173.7 2072.1 2118.2 2130.2 2134.2 2137.5 7788.8 7972.9 8045.4 8048.4 8111.1 4601.1 4717.2 4720.5 4726.6 4760.8 2833.6 2912.7 2964.7 2979.0 2984.0 937.2 945.9 963.9 969.5 985.5 10298.6 10389.7 10394.7 10395.7 10395.9 4047.8 4048.8 4204.2 4224.8 4242.6 8337.5 8340.4 8348.4 8349.4 8350.7 4598.4 4599.7 4599.7 4600.8 4601.9 3788.9 4116.5 4242.7 4281.7 4282.8 3383.0 3408.2 3516.6 3524.5 3527.6 1026.7 1066.5 1068.2 1075.8 1076.9 791.0 815.8 818.3 819.5 834.7 5321.1 5507.4 5762.5 5821.1 5923.8 834.2 853.9 859.4 866.8 869.9 3612.6 3724.9 3726.2 3856.5 3876.1 9712.8 10087.9 10098.4 10103.1 10113.0 9986.0 10007.3 10023.1 10031.4 10038.5 7249.7 7342.1 7348.7 7350.0 7351.1 5184.9 5326.2 5335.8 5483.2 5619.9 8782.5 8792.3 8804.7 8812.1 8847.8 8668.7 8966.5 9097.8 9164.1 9176.8 5958.7 6400.0 6475.6 6631.1 6683.4 7577.4 7826.0 7838.7 7840.5 7855.5 6704.9 6897.2 6906.8 6941.8 7170.6 6823.6 6902.8 6913.3 6916.7 6916.9 6428.9 6435.0 6454.1 6488.3 6522.4 4495.8 4545.0 4602.6 4751.1 4791.9 4470.6 4546.1 4609.0 4617.0 4725.9 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#4] prototype.html Cycles:180 Average:4113.66 Median:4724.42 stddev:1191.21 (25.2%) stddev-sans-first:1159.63 12:42:29 INFO - PROCESS | 4434 | Values: 299.0 302.3 302.8 311.8 311.9 4766.4 4781.5 4798.3 4800.8 4833.9 4719.8 4723.6 4725.3 4727.3 4746.5 3535.9 3635.2 3636.7 3643.3 3655.2 3623.8 3742.6 3768.5 3769.2 3787.7 3733.2 3739.7 3740.2 3740.8 3750.2 3563.9 3643.8 3661.6 3710.3 3738.0 3301.0 3312.9 3323.4 3326.6 3326.8 4578.3 4580.8 4582.7 4583.5 4587.4 4244.3 4255.5 4257.2 4260.4 4265.6 4719.2 4876.4 4920.9 4925.8 4931.4 3603.5 3605.6 3608.3 3615.8 3621.7 5117.8 5143.6 5162.7 5164.7 5169.2 3429.2 3596.7 3715.4 3719.9 3724.3 3648.9 3653.5 3660.7 3662.3 3681.0 4138.0 4161.1 4165.5 4172.0 4181.4 4956.8 4960.8 4967.7 4982.3 4998.8 1218.6 1257.0 1263.0 1267.6 1278.9 782.4 813.5 824.7 827.8 828.5 4023.5 4274.4 4324.4 4469.3 4507.5 5132.8 5152.3 5164.2 5186.4 5193.6 4439.9 4507.2 4510.7 4512.2 4516.7 2582.3 2676.7 2678.0 2686.6 2696.3 4759.9 4772.6 4773.6 4780.5 4796.2 5154.4 5163.3 5165.6 5166.2 5180.3 4606.4 4728.4 4757.2 4762.7 4790.4 5080.6 5088.8 5099.1 5120.5 5122.2 4986.6 5032.4 5039.6 5044.2 5044.6 4597.4 4801.8 4810.3 4813.3 4833.4 3515.6 3571.3 3578.6 3583.8 3584.6 5055.9 5058.5 5059.6 5083.9 5091.0 4736.0 4908.2 4917.6 4927.3 4935.5 4902.3 4910.8 4922.2 4926.5 4934.5 4876.8 4877.2 4896.8 4898.2 4903.9 4754.6 4761.7 4868.3 4956.6 4972.1 4682.9 4762.3 4767.4 4774.4 4912.3 12:42:29 INFO - PROCESS | 4434 | 12:42:29 INFO - PROCESS | 4434 | [#5] yui.html Cycles:180 Average:17708.57 Median:23164.66 stddev:24861.36 (107.3%) stddev-sans-first:24898.04 12:42:29 INFO - PROCESS | 4434 | Values: 633.2 643.5 679.9 704.7 735.9 12452.8 13625.4 13647.2 13662.9 13687.0 12583.8 13254.6 13363.4 13390.3 13422.2 603.6 725.2 734.8 747.4 749.9 737.3 741.0 741.4 741.5 742.1 783.5 783.5 783.6 783.8 784.1 624.1 640.3 776.7 777.0 778.8 462.5 463.8 547.6 563.8 566.7 12432.5 12456.6 12457.8 12461.0 12479.0 12356.8 12727.3 13101.6 13523.3 13557.0 11093.8 11345.5 11534.3 11563.0 11964.9 3910.7 3952.9 3963.9 3997.9 4036.3 67207.7 67903.0 68694.0 69726.0 69762.3 10277.5 10350.1 10402.7 10637.7 10721.2 19782.0 19800.8 19815.2 19850.0 19876.1 6614.6 6686.8 6845.9 6896.5 7017.9 3552.1 3636.4 3652.8 3721.5 3728.1 2811.7 2920.2 2930.8 2931.7 2933.0 482.3 496.6 500.3 502.3 507.1 531.2 551.1 556.3 558.2 563.6 7221.4 7374.9 7889.7 7927.0 7947.4 417.7 454.0 522.9 537.5 550.7 3441.8 3524.3 3748.8 3850.2 3902.5 53615.5 53682.2 79593.0 86147.1 101718.5 88346.0 89167.6 90482.1 92591.1 92791.5 80656.6 81474.2 81852.6 81939.2 83780.0 6924.2 6995.2 7129.8 7362.5 7392.6 44524.6 45875.3 46017.5 46157.5 46429.3 50974.0 53911.7 54464.0 59969.0 60407.7 11502.3 11522.9 11734.2 11769.7 11998.6 12594.3 13219.9 13916.7 14257.0 14373.9 12102.3 12360.4 12807.6 13131.8 13415.6 12417.3 12484.9 12981.5 13488.4 13630.5 11676.7 11761.0 11892.5 12979.1 13120.0 9744.7 9761.0 10047.2 10518.6 10943.2 9832.4 10329.3 10506.5 10631.3 10684.3 12:42:29 INFO - PROCESS | 4434 | -------- Summary: end -------- 12:42:29 INFO - PROCESS | 4434 | 12:42:30 INFO - TEST-INFO | 4434: exit 0 12:42:30 INFO - TEST-OK | dromaeo_css | took 1122645ms 12:42:30 INFO - TEST-START | kraken 12:42:30 INFO - operating with platform_type : linux_ 12:42:30 INFO - Initialising browser for kraken test... 12:42:30 INFO - TEST-INFO | started process 4737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkuUAR/profile http://localhost:59192/getInfo.html) 12:42:35 INFO - PROCESS | 4737 | __metrics Screen width/height:1600/1200 12:42:35 INFO - PROCESS | 4737 | colorDepth:24 12:42:35 INFO - PROCESS | 4737 | Browser inner width/height: 1024/697 12:42:35 INFO - PROCESS | 4737 | __metrics 12:42:35 INFO - PROCESS | 4737 | 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:42:35 INFO - PROCESS | 4737 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:42:36 INFO - PROCESS | 4737 | console.error: PushService: 12:42:36 INFO - PROCESS | 4737 | stateChangeProcessEnqueue: Error transitioning state 12:42:36 INFO - PROCESS | 4737 | UnknownError 12:42:37 INFO - TEST-INFO | 4737: exit 0 12:42:37 INFO - Browser initialized. 12:42:37 INFO - Running cycle 1/1 for kraken test... 12:42:37 INFO - TEST-INFO | started process 4817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkuUAR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:49 INFO - PROCESS | 4817 | RSS: Main: 180895744 12:42:49 INFO - PROCESS | 4817 | 12:42:52 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59192/tests/kraken/driver.html?testName=audio-beat-detection) 12:42:53 INFO - PROCESS | 4817 | RSS: Main: 235622400 12:42:53 INFO - PROCESS | 4817 | 12:42:55 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59192/tests/kraken/driver.html?testName=audio-dft) 12:42:56 INFO - PROCESS | 4817 | RSS: Main: 225665024 12:42:56 INFO - PROCESS | 4817 | 12:42:59 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59192/tests/kraken/driver.html?testName=audio-fft) 12:43:00 INFO - PROCESS | 4817 | RSS: Main: 302751744 12:43:00 INFO - PROCESS | 4817 | 12:43:02 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59192/tests/kraken/driver.html?testName=audio-oscillator) 12:43:03 INFO - PROCESS | 4817 | RSS: Main: 213303296 12:43:03 INFO - PROCESS | 4817 | 12:43:05 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:43:05 INFO - PROCESS | 4817 | RSS: Main: 215359488 12:43:05 INFO - PROCESS | 4817 | 12:43:09 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59192/tests/kraken/driver.html?testName=imaging-darkroom) 12:43:09 INFO - PROCESS | 4817 | RSS: Main: 253587456 12:43:09 INFO - PROCESS | 4817 | 12:43:13 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59192/tests/kraken/driver.html?testName=imaging-desaturate) 12:43:13 INFO - PROCESS | 4817 | RSS: Main: 247767040 12:43:13 INFO - PROCESS | 4817 | 12:43:16 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59192/tests/kraken/driver.html?testName=json-parse-financial) 12:43:17 INFO - PROCESS | 4817 | RSS: Main: 250519552 12:43:17 INFO - PROCESS | 4817 | 12:43:19 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:43:19 INFO - PROCESS | 4817 | RSS: Main: 214433792 12:43:19 INFO - PROCESS | 4817 | 12:43:21 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:43:22 INFO - PROCESS | 4817 | RSS: Main: 222892032 12:43:22 INFO - PROCESS | 4817 | 12:43:24 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:43:25 INFO - PROCESS | 4817 | RSS: Main: 223186944 12:43:25 INFO - PROCESS | 4817 | 12:43:27 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:43:28 INFO - PROCESS | 4817 | RSS: Main: 224800768 12:43:28 INFO - PROCESS | 4817 | 12:43:31 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:43:32 INFO - PROCESS | 4817 | RSS: Main: 222126080 12:43:32 INFO - PROCESS | 4817 | 12:43:33 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:59192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59192/tests/kraken/driver.html?testName=ai-astar) 12:43:34 INFO - PROCESS | 4817 | RSS: Main: 273477632 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | __start_tp_report 12:43:34 INFO - PROCESS | 4817 | _x_x_mozilla_page_load 12:43:34 INFO - PROCESS | 4817 | _x_x_mozilla_page_load_details 12:43:34 INFO - PROCESS | 4817 | |i|pagename|runs| 12:43:34 INFO - PROCESS | 4817 | |0;ai-astar;113;113;117;114;115;115;114;113;114;129 12:43:34 INFO - PROCESS | 4817 | |1;audio-beat-detection;151;122;147;180;133;152;144;126;190;123 12:43:34 INFO - PROCESS | 4817 | |2;audio-dft;161;162;161;162;163;161;161;162;161;164 12:43:34 INFO - PROCESS | 4817 | |3;audio-fft;77;75;75;185;77;77;75;77;166;76 12:43:34 INFO - PROCESS | 4817 | |4;audio-oscillator;84;85;145;82;85;83;144;83;82;139 12:43:34 INFO - PROCESS | 4817 | |5;imaging-gaussian-blur;117;117;116;117;116;118;118;117;119;118 12:43:34 INFO - PROCESS | 4817 | |6;imaging-darkroom;146;147;147;146;147;146;147;146;147;146 12:43:34 INFO - PROCESS | 4817 | |7;imaging-desaturate;95;95;96;95;96;96;96;96;95;95 12:43:34 INFO - PROCESS | 4817 | |8;json-parse-financial;64;63;65;64;64;65;65;66;64;65 12:43:34 INFO - PROCESS | 4817 | |9;json-stringify-tinderbox;64;66;65;67;65;66;67;66;65;65 12:43:34 INFO - PROCESS | 4817 | |10;stanford-crypto-aes;83;82;84;83;83;82;82;83;82;83 12:43:34 INFO - PROCESS | 4817 | |11;stanford-crypto-ccm;135;143;130;141;138;133;131;133;177;132 12:43:34 INFO - PROCESS | 4817 | |12;stanford-crypto-pbkdf2;175;177;175;173;177;175;174;179;178;178 12:43:34 INFO - PROCESS | 4817 | |13;stanford-crypto-sha256-iterative;70;69;71;69;68;69;68;68;67;68 12:43:34 INFO - PROCESS | 4817 | __end_tp_report 12:43:34 INFO - PROCESS | 4817 | __start_cc_report 12:43:34 INFO - PROCESS | 4817 | _x_x_mozilla_cycle_collect,2001 12:43:34 INFO - PROCESS | 4817 | __end_cc_report 12:43:34 INFO - PROCESS | 4817 | __startTimestamp1472845414154__endTimestamp 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | ------- Summary: start ------- 12:43:34 INFO - PROCESS | 4817 | Number of tests: 14 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#0] ai-astar Cycles:10 Average:115.70 Median:114.50 stddev:4.83 (4.2%) stddev-sans-first:5.02 12:43:34 INFO - PROCESS | 4817 | Values: 113.0 113.0 117.0 114.0 115.0 115.0 114.0 113.0 114.0 129.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:149.00 stddev:23.16 (15.5%) stddev-sans-first:24.51 12:43:34 INFO - PROCESS | 4817 | Values: 151.0 122.0 147.0 180.0 133.0 152.0 144.0 126.0 190.0 123.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 12:43:34 INFO - PROCESS | 4817 | Values: 161.0 162.0 161.0 162.0 163.0 161.0 161.0 162.0 161.0 164.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.50 stddev:42.15 (55.1%) stddev-sans-first:44.14 12:43:34 INFO - PROCESS | 4817 | Values: 77.0 75.0 75.0 185.0 77.0 77.0 75.0 77.0 166.0 76.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.00 stddev:28.67 (34.5%) stddev-sans-first:29.73 12:43:34 INFO - PROCESS | 4817 | Values: 84.0 85.0 145.0 82.0 85.0 83.0 144.0 83.0 82.0 139.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 12:43:34 INFO - PROCESS | 4817 | Values: 117.0 117.0 116.0 117.0 116.0 118.0 118.0 117.0 119.0 118.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:43:34 INFO - PROCESS | 4817 | Values: 146.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:43:34 INFO - PROCESS | 4817 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 12:43:34 INFO - PROCESS | 4817 | Values: 64.0 63.0 65.0 64.0 64.0 65.0 65.0 66.0 64.0 65.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 12:43:34 INFO - PROCESS | 4817 | Values: 64.0 66.0 65.0 67.0 65.0 66.0 67.0 66.0 65.0 65.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 12:43:34 INFO - PROCESS | 4817 | Values: 83.0 82.0 84.0 83.0 83.0 82.0 82.0 83.0 82.0 83.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:136.50 stddev:13.93 (10.2%) stddev-sans-first:14.69 12:43:34 INFO - PROCESS | 4817 | Values: 135.0 143.0 130.0 141.0 138.0 133.0 131.0 133.0 177.0 132.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:177.00 stddev:1.97 (1.1%) stddev-sans-first:2.05 12:43:34 INFO - PROCESS | 4817 | Values: 175.0 177.0 175.0 173.0 177.0 175.0 174.0 179.0 178.0 178.0 12:43:34 INFO - PROCESS | 4817 | 12:43:34 INFO - PROCESS | 4817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.13 12:43:34 INFO - PROCESS | 4817 | Values: 70.0 69.0 71.0 69.0 68.0 69.0 68.0 68.0 67.0 68.0 12:43:34 INFO - PROCESS | 4817 | -------- Summary: end -------- 12:43:34 INFO - PROCESS | 4817 | 12:43:35 INFO - TEST-INFO | 4817: exit 0 12:43:35 INFO - TEST-OK | kraken | took 64970ms 12:43:35 INFO - SUITE-END | took 1187s 12:43:35 INFO - Completed test suite (00:19:47) 12:43:35 INFO - javascript benchmark 12:43:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.8068894832886, 2590.2358804152773, 2605.5700809366454, 2613.7778288845448, 2643.7224091470407, 4538.7503687297185, 4623.398958135442, 4641.489436162028, 4700.341952126705, 4762.261849413342, 4632.583067523922, 4677.321788340689, 4680.789364478598, 4698.788554515047, 4700.130475861968, 4311.1808756336195, 4373.497047839492, 4376.256036473791, 4381.211381951248, 4383.0, 4282.400463935036, 4364.912701745963, 4384.517703052662, 4403.911921761563, 4456.242438785414, 4368.759718215497, 4436.112777444508, 4444.622207112399, 4445.666575006888, 4450.26570615848, 4191.140816132685, 4235.9364609530885, 4333.1766964277, 4384.9561504384865, 4398.120375924827, 4185.602367775056, 4206.074663574009, 4266.338717498793, 4275.444192255018, 4310.116426132635, 4535.229011068126, 4599.264117741145, 4604.723716577016, 4611.792469338888, 4616.561426664462, 4830.058138662962, 4913.115639184945, 4933.827316043921, 4938.506149385069, 4944.035912996967, 4903.607711383081, 5023.095842748304, 5031.52200540948, 5031.52200540948, 5034.622403319729, 4647.092847926316, 4679.0, 4679.578837904537, 4687.343771871941, 4750.7387093709485, 5008.323876276729, 5128.9230661540105, 5134.204198349262, 5140.897182056413, 5141.665791723526, 4957.950420495821, 4966.15575352191, 4991.675541089818, 5051.570616497565, 5051.595872330205, 5070.746462676925, 5079.3650793650795, 5084.059449001872, 5084.211947148198, 5143.5113664201845, 4829.299751536078, 4896.779644915988, 5015.874603134951, 5030.949690503121, 5040.395152581714, 4959.677620954626, 4969.428515720666, 4970.17992031318, 4973.055119527278, 4976.178930476431, 4208.6633069354375, 4209.1792100540715, 4238.300680387763, 4282.957170428318, 4289.871303860889, 3682.9447558286647, 3690.464882592009, 3727.925441491155, 3733.8506459741848, 3769.076576238839, 4312.956870431255, 4337.674674399433, 4356.477222733292, 4407.889802754957, 4411.955880441219, 4872.585830204473, 4880.560749532559, 5003.7998480061115, 5006.599472042228, 5018.422881368616, 4282.464691913511, 4294.6993710439965, 4316.5467625899455, 4338.978305108454, 4406.228909940747, 4489.079738653568, 4491.708038977456, 4497.392851965008, 4504.48198457175, 4548.95451045492, 4506.752128632957, 4687.320338550891, 4687.3906392170165, 4689.6248300136585, 4736.8578942631775, 4920.261960705922, 5023.0, 5024.447310795883, 5029.9245511318095, 5103.387593488805, 4654.37165982588, 4657.46439159501, 4660.091282199938, 4666.300054991779, 4727.905441891212, 4784.40194975628, 4881.072596206709, 4887.413510378778, 4889.413270407574, 4948.134076536664, 4950.133726597903, 4956.826511072095, 4964.528369804862, 4986.775595098156, 5075.6193285502995, 4844.273358996179, 4860.052289803454, 4860.659753817199, 4861.878453038702, 4922.237053256751, 4746.572808447257, 4836.879078023077, 4848.0, 4853.4418541868135, 4909.705417674951, 4827.444843843003, 4848.418189817245, 4920.286558448934, 4926.802927882844, 4930.309756634002, 4934.136526107988, 4935.62982776286, 4951.405831300123, 4959.9008019838675, 5017.046761115376, 4695.178343789891, 4733.431988161443, 4736.0, 4800.519948005312, 4858.975705121452], "value": 4595.98926571226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2087078090673, 578.7308901360864, 579.94200579942, 581.1515187825775, 588.6762280745589, 28049.859750701242, 38320.61679383205, 39626.0, 39760.40359394608, 43255.56744432563, 39803.800980995125, 39912.40131398024, 39922.40116398256, 39949.0, 39978.0, 7355.742549010785, 7487.138979017428, 7506.43701722373, 7507.849843003137, 7509.9624501877415, 7414.147373052114, 7506.474546781727, 7512.962435187844, 7534.359579435754, 7539.0, 7153.928460715379, 7506.099268087837, 7554.471187016884, 7562.924370756277, 7590.734324298651, 7521.887171692429, 7529.585872776995, 7553.622318884089, 7559.5464272143845, 7561.810954726121, 7476.1776204617445, 7540.811479713051, 7542.849143017109, 7557.773266802004, 7559.58422286774, 37118.4432233514, 37222.4416633748, 37505.06237344061, 37520.0, 37542.62457375418, 2999.505081661523, 3014.231371000381, 3059.8623061962267, 3062.2803641144314, 3107.7513798896034, 27443.0, 28303.292417689518, 28304.0, 28564.14307570776, 28806.423871522453, 3322.5680661513848, 3359.6472370401, 3406.9488957665653, 3407.114150320934, 3437.071990562534, 263064.0, 264990.0, 265154.0, 265334.0, 265450.0, 30774.38451230963, 49312.75343623331, 49627.25559116544, 49634.75182624064, 49661.75169124203, 31077.533836992465, 32983.83508082492, 33050.83474582612, 33093.17267068294, 33097.17257068593, 13737.725245495034, 13788.241646709326, 13791.896648268115, 13882.236476993863, 13891.4443422264, 11487.0810335173, 11521.942390287995, 11522.76954460906, 11527.0, 11538.250013749079, 7635.389168866477, 7680.34717049046, 7732.922670773332, 7736.6518506667335, 7755.650995705207, 3001.474741920199, 3013.322002549409, 3036.16505461, 3055.801372910754, 3075.6309242890998, 775.716863344875, 881.453498830729, 893.9374243803002, 918.7151982885327, 941.7786820097272, 26854.5971810423, 27580.310492237855, 28023.299417514318, 28345.881952985153, 28401.147965561067, 904.7511934218143, 961.2022021721954, 963.8457846744487, 969.060011788564, 983.2772911909741, 14563.126212427289, 14988.325525351385, 15907.443239486562, 16307.59231019234, 16653.833461665472, 394473.0, 398555.0, 399499.0, 402523.0, 402670.0, 49357.25964110541, 49823.50176498261, 49826.0, 49865.75067124641, 49895.50104498908, 1160.222650823933, 1168.1705988747915, 1197.3235122155954, 1201.129181343519, 1201.1771936223715, 26909.86545067262, 28464.715352847034, 29024.727952533427, 29213.0, 29568.260793480335, 40913.13608047527, 46090.769546152056, 48036.0, 48156.27765583589, 52873.7356313216, 378334.0, 380213.0, 381219.0, 381581.0, 383976.0, 37573.87278381544, 37693.62306377011, 37815.810920945216, 37943.43084853785, 38631.0, 41558.0, 41733.37399938943, 42049.15901681888, 42375.788121059195, 42438.57561424346, 35378.85566046687, 35433.46849797203, 35873.103172420895, 35905.82047089748, 36302.0, 35660.46509302311, 35723.28553428969, 35996.0, 36298.092547686516, 36373.27253454863, 34939.0, 35111.64888351084, 35236.823815881784, 35298.29403411866, 36185.45721814228, 31317.8434107828, 32923.835380822944, 33012.66987330192, 33055.8347208272, 33084.33831323312, 24600.384990374667, 24930.127445539318, 24940.127095552296, 25242.24273271805, 25443.36391590151], "value": 16629.831329470588, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.97924124552515, 355.8078637535729, 359.67269784496114, 364.89053284014796, 379.85375630382293, 11723.237989530686, 15737.763933541006, 15750.606234844134, 16300.510984670478, 17176.57058573533, 16252.674946501063, 16394.344226230965, 16608.169591520407, 17012.48962531126, 17153.57116072099, 4921.581665558432, 4974.1295273327205, 5116.590672746172, 5207.270982062514, 5238.161894096946, 3444.431668774649, 3616.041748936534, 5199.064168449678, 5232.8691782705355, 5245.265662807191, 3592.335417947675, 3620.81895905205, 3626.8367923443507, 4889.559939605435, 5975.402459754033, 5890.676012819294, 6059.303180134297, 6061.090836374535, 6061.181740465025, 6065.514758819284, 5109.821156259551, 5318.73406329682, 5324.840254792362, 5333.866653333697, 5394.865128371783, 11564.53741850325, 12143.332116733576, 12226.327551984637, 12452.439640216122, 12487.188332758342, 1789.5078853315313, 1818.5362732503258, 1823.088455772114, 1867.5891303913118, 1940.2917934953782, 9013.774655633597, 9130.0, 9137.629355596713, 9295.11696388842, 12581.874181258254, 1675.9329626814913, 1677.7147884859603, 1686.0810858082375, 1724.767156433878, 1760.4102625620433, 65064.0, 68590.65704671445, 69205.65397173032, 70353.0, 71503.28496715019, 8846.557672116369, 9079.81840363189, 9236.8614470783, 9411.764705882408, 9518.238540916711, 12234.571789987307, 12248.0, 12248.75502489963, 12251.387430628432, 12255.325957072268, 6841.342682554512, 7193.9280607194305, 7313.48805583604, 7326.560406375635, 7368.189499155089, 7115.181754098345, 7128.180259270147, 7168.139823221247, 7335.669894854745, 7347.595882226529, 3815.8664446744233, 3842.56038167178, 3850.8844734658005, 3851.9422208666892, 3914.236723838824, 1832.8075552067107, 1868.3274021352302, 1869.9719504207449, 1874.22219778793, 1916.9904150479438, 796.1759578835877, 798.8362385710915, 807.3379828540658, 823.0822632764424, 878.3675753457501, 16010.599735006717, 16282.75575866363, 16632.667346652997, 16684.33262669504, 17382.478525644252, 818.4802650316973, 837.2590257622048, 843.4391129898548, 848.4485084694998, 861.4099341950658, 9272.907270927204, 9393.060693930553, 9622.51887405641, 9684.32209745311, 9708.563114659857, 362498.0, 363160.0, 363651.0, 365254.0, 368063.0, 72272.99999999895, 76041.61979190068, 77251.0, 77655.22344776592, 78133.60933195411, 891.2290868398788, 917.0874979395411, 921.0237148622615, 922.2161163011386, 922.6678395777515, 15187.392504299703, 15291.541253762405, 15765.132917689638, 16219.918900405895, 16465.506034818976, 27594.724052759215, 28596.142115736562, 36643.63356366402, 37569.607598100476, 37769.81115094407, 46664.7666761664, 48659.270110947655, 48991.75504122599, 49431.50568494413, 51831.74084129706, 7233.204347521873, 7497.512661676974, 7626.9618651906385, 7903.84192316139, 7973.242541958504, 9861.309708320348, 11753.353565553634, 11995.520179192734, 12209.96215321672, 12253.326067066397, 9901.900980990098, 10130.594776208869, 10233.283670143019, 10284.640037598649, 10575.048245657928, 10061.295709300279, 10221.795564088825, 10231.079202871777, 10298.742531436774, 10603.89396106029, 10242.59029638836, 10379.429131397847, 10545.683629491128, 10627.840582391116, 10930.672079837617, 7607.885881711668, 7767.961160194162, 7868.685252589832, 7908.4464087513325, 8079.111297757359, 9158.496282704515, 10127.89872101299, 10199.28604997643, 10324.43215623118, 10499.055085042077], "value": 7876.877008300673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.6854817747383, 1326.615281568345, 1366.3304980559526, 1378.9931050344746, 1602.9198540072994, 7460.142083660381, 7860.371170306369, 7893.3685305175595, 8101.108878023413, 8119.553424561646, 7988.0828601135745, 8092.757217283491, 8093.473924194923, 8105.189481051892, 8105.432619716607, 2182.574397992388, 2203.77690381838, 2206.1396055538353, 2210.0938615167784, 2211.1929145861727, 2136.7435907691097, 2193.5722534105857, 2217.800397964183, 2219.9334019979347, 2221.322496638533, 2131.1049359269145, 2153.5262242306667, 2170.305502239284, 2182.8035476807086, 2217.3347995601334, 2136.7756385579523, 2162.178372218563, 2172.532905425341, 2173.402314363555, 2173.71741673583, 2072.0986370928695, 2118.1950858673604, 2130.2331160782105, 2134.249915069628, 2137.465633591602, 7788.766337009899, 7972.920270797334, 8045.356371490267, 8048.396370272253, 8111.107778144399, 4601.148787474328, 4717.221658426355, 4720.480747117815, 4726.621870250372, 4760.833370832039, 2833.631627888382, 2912.694167112465, 2964.7183517565795, 2979.0467050543834, 2984.0, 937.2408349237139, 945.8864936207631, 963.8698775665266, 969.5394687523441, 985.522021819417, 10298.639547615798, 10389.740256493647, 10394.740131496697, 10395.740106497322, 10395.896041039645, 4047.817848196838, 4048.777317247521, 4204.2432362175105, 4224.831006759695, 4242.575742425733, 8337.499750015018, 8340.37447191463, 8348.373871959628, 8349.4155409122, 8350.70772522971, 4598.425196850394, 4599.678022538457, 4599.724016559017, 4600.838970636079, 4601.8849528761375, 3788.9431658525145, 4116.4648595682365, 4242.745435273893, 4281.678874084456, 4282.785860706952, 3382.9661703383144, 3408.199073217792, 3516.5604299462566, 3524.524189234472, 3527.647235276503, 1026.6919924022764, 1066.4934156275863, 1068.2041878800344, 1075.8171110911164, 1076.8653918260218, 790.9723159689498, 815.8123631564773, 818.2799136759733, 819.5492479136451, 834.6536187482249, 5321.068812957717, 5507.411516587197, 5762.481376676119, 5821.126830975303, 5923.822285331447, 834.1866679986964, 853.8591132463198, 859.441363113981, 866.8309679612415, 869.8695195720693, 3612.566492020922, 3724.888253352404, 3726.2174943261675, 3856.4793752843566, 3876.108495046155, 9712.75718107053, 10087.949560252151, 10098.394096354243, 10103.09072183507, 10113.0, 9986.0, 10007.349522281029, 10023.14803241718, 10031.448270345056, 10038.548265328078, 7249.673764680602, 7342.082239720035, 7348.669309881068, 7350.0, 7351.081114860643, 5184.922226166686, 5326.201069839555, 5335.759890804846, 5483.177523371367, 5619.887602247851, 8782.516961567175, 8792.252658524098, 8804.735857924272, 8812.118788121137, 8847.823043539222, 8668.653253869774, 8966.462012279284, 9097.818043639223, 9164.083591640783, 9176.816463670822, 5958.702064896651, 6399.968000159969, 6475.643839588868, 6631.071649969104, 6683.365080317362, 7577.393808495417, 7825.960870195612, 7838.686452541834, 7840.451168418156, 7855.5286682799215, 6704.927211646308, 6897.241303456515, 6906.792796216121, 6941.791746247621, 7170.641467926687, 6823.624700641512, 6902.792916212522, 6913.343232392915, 6916.723331066701, 6916.861662766817, 6428.903566446601, 6435.0, 6454.064160696579, 6488.286288508166, 6522.412982831568, 4495.842645507522, 4545.0, 4602.562756538124, 4751.144793936986, 4791.928121078117, 4470.552944705503, 4546.136234115507, 4609.0, 4616.976915115403, 4725.9291110632685], "value": 4148.547576059954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.0, 302.34994761263283, 302.75628119363915, 311.7848684407757, 311.93137509747874, 4766.404199475066, 4781.5218478152165, 4798.328234047236, 4800.807967681293, 4833.903321933563, 4719.764011799405, 4723.551262630053, 4725.291206319054, 4727.338172655831, 4746.525347465252, 3535.9469607955966, 3635.236600313924, 3636.709063274945, 3643.2531331077066, 3655.232401195752, 3623.8188090595495, 3742.6257374262627, 3768.547774267092, 3769.18962423079, 3787.734858559902, 3733.2346868891814, 3739.7195210359196, 3740.2145549434517, 3740.8403394947654, 3750.1937083527037, 3563.94654080189, 3643.8178091095474, 3661.6338366163172, 3710.2764960832646, 3737.9813100934593, 3300.950485742716, 3312.8840490582716, 3323.3685599735973, 3326.600807903043, 3326.8170250636203, 4578.313253012042, 4580.808989662678, 4582.679212455129, 4583.495815460296, 4587.380703605004, 4244.3209086546, 4255.468066491689, 4257.233697934371, 4260.424842646234, 4265.616094551505, 4719.221328480797, 4876.390451193601, 4920.852374428773, 4925.802967881281, 4931.358923339979, 3603.5135256740527, 3605.5757975599754, 3608.260306637133, 3615.8305016989857, 3621.6559426854406, 5117.820876269313, 5143.562797162245, 5162.6700777997985, 5164.727519891236, 5169.224616307546, 3429.2112814052907, 3596.730245231618, 3715.405535114423, 3719.8512059517316, 3724.2551489701627, 3648.908777280589, 3653.5250417446096, 3660.670539651444, 3662.304162209225, 3680.9631903681156, 4137.97931010343, 4161.0637606538285, 4165.500139983161, 4171.97914010428, 4181.393697913785, 4956.801727930914, 4960.826371076995, 4967.652264341534, 4982.302477653131, 4998.775055122455, 1218.6344096770933, 1256.9692851861569, 1262.9810552841714, 1267.619714085789, 1278.9168704034207, 782.4092809928468, 813.4875028731861, 824.674253669797, 827.8302947895787, 828.5235989306173, 4023.539755810001, 4274.444322238089, 4324.437823082979, 4469.307257375112, 4507.549245075532, 5132.769025393866, 5152.330197074356, 5164.1995490699, 5186.351706036746, 5193.5585475234275, 4439.933400998988, 4507.183010618363, 4510.729356238636, 4512.2329204035395, 4516.706414083074, 2582.341502916744, 2676.7055623881356, 2677.9732202678115, 2686.570148776186, 2696.2720065582184, 4759.88185257564, 4772.618190544748, 4773.618110551217, 4780.450248221429, 4796.208625576741, 5154.402135338058, 5163.302954101224, 5165.560927321145, 5166.173412254097, 5180.300659410931, 4606.378138951266, 4728.40894888139, 4757.167495688241, 4762.714237145782, 4790.401199849949, 5080.593552515864, 5088.821891233789, 5099.11899776625, 5120.513551212629, 5122.180451127951, 4986.576141028053, 5032.370953630796, 5039.622028347815, 5044.218146187347, 5044.621653376085, 4597.402337696078, 4801.839172372376, 4810.254410566367, 4813.253945638432, 4833.3958255218095, 3515.648435156464, 3571.339302229096, 3578.606353301187, 3583.7849729016343, 3584.623614520438, 5055.87360315995, 5058.519440653132, 5059.620528460307, 5083.949160508348, 5090.974545127251, 4735.958089220366, 4908.239222920453, 4917.58200552957, 4927.28554359623, 4935.4570997190995, 4902.289168070681, 4910.779014944407, 4922.237053256751, 4926.48271931442, 4934.5312195341385, 4876.756162191948, 4877.219644856806, 4896.804127834846, 4898.21628539432, 4903.901921961612, 4754.619630429488, 4761.666683332133, 4868.3427737255015, 4956.628252880976, 4972.129877271391, 4682.906341873211, 4762.333273341805, 4767.356406885026, 4774.427068751633, 4912.336834527293], "value": 3735.86571653973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1831936801526, 643.4787821864287, 679.894616334468, 704.7145905908109, 735.8822588385859, 12452.750944981106, 13625.386857591408, 13647.249401282914, 13662.863371366284, 13687.0, 12583.811242831365, 13254.602361929157, 13363.398647060882, 13390.330483475836, 13422.194668319908, 603.604638961481, 725.1624373848214, 734.7538574577522, 747.3722073458293, 749.9212582678822, 737.3437640499959, 741.0, 741.3957624535985, 741.5402450480683, 742.1428250370831, 783.4711569690464, 783.5298820707587, 783.5807842804101, 783.8079670480712, 784.0826233307045, 624.0981781325986, 640.2668944059026, 776.7397921696239, 777.0442355902215, 778.8052986753312, 462.53746253746255, 463.83765682011364, 547.6467678347443, 563.8167595531469, 566.7308028686382, 12432.502699891993, 12456.564020259339, 12457.75084498314, 12461.0, 12479.0, 12356.814647780291, 12727.299998500172, 13101.606951791462, 13523.32383380827, 13557.0, 11093.83359249612, 11345.546178152947, 11534.307941523452, 11563.0, 11964.880351196463, 3910.7262491625597, 3952.940705889414, 3963.861264855745, 3997.900052498711, 4036.253293140778, 67207.66396168037, 67902.9814552787, 68694.0, 69726.0, 69762.30237697609, 10277.537510812032, 10350.120239779702, 10402.739931501774, 10637.680869573926, 10721.249512534048, 19782.0, 19800.801991980185, 19815.207391704458, 19850.0, 19876.10557524915, 6614.603123812491, 6686.765963191362, 6845.8973115403305, 6896.517243792886, 7017.92982070183, 3552.1474846036767, 3636.381815091388, 3652.8356223969986, 3721.4603882436895, 3728.067983004249, 2811.718828117213, 2920.2261400728826, 2930.7508861746564, 2931.6628587712685, 2932.9560056599166, 482.3102962763212, 496.6473803599413, 500.314569040417, 502.31434092463525, 507.14545990006957, 531.160765989743, 551.0769461152554, 556.3379578301889, 558.2243903406317, 563.613924461745, 7221.42228621709, 7374.889376659355, 7889.723859664884, 7926.960365198137, 7947.443678942419, 417.6763008668246, 453.9989323541583, 522.9215617657381, 537.5323468582359, 550.6668465578348, 3441.8451169697423, 3524.339123961444, 3748.7938163401277, 3850.210706805098, 3902.5316961964745, 53615.463845361824, 53682.19476707852, 79593.0, 86147.13852861391, 101718.49140754397, 88346.0, 89167.55416222877, 90482.09517904869, 92591.0740892596, 92791.53604231936, 80656.59671701604, 81474.18525814785, 81852.59073704593, 81939.18060819316, 83780.0, 6924.169099708067, 6995.230524642184, 7129.7861064168155, 7362.484626076123, 7392.593407362647, 44524.55475445204, 45875.311870321304, 46017.53982460133, 46157.538424615326, 46429.303560445944, 50974.0, 53911.73044134754, 54464.0, 59969.0, 60407.69796150991, 11502.309861408343, 11522.942385288019, 11734.237274577124, 11769.705757356134, 11998.64004079879, 12594.307313097868, 13219.933900330438, 13916.721665566429, 14257.0, 14373.856261437251, 12102.334371609646, 12360.44378002974, 12807.551735689207, 13131.803022954855, 13415.614179556213, 12417.31704756211, 12484.875151248734, 12981.480740770263, 13488.393022313823, 13630.454781809014, 11676.708082297671, 11761.000314973324, 11892.464839082435, 12979.091463597835, 13120.01599880032, 9744.707658770249, 9760.951195244263, 10047.246456515644, 10518.579256829642, 10943.233973621771, 9832.410055396698, 10329.276950613685, 10506.527206275583, 10631.308964917256, 10684.305520141477], "value": 6513.124268505716, "unit": "score"}], "name": "dromaeo_css", "value": 6270.337218647626, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 117.0, 114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 129.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 147.0, 180.0, 133.0, 152.0, 144.0, 126.0, 190.0, 123.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 164.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 185.0, 77.0, 77.0, 75.0, 77.0, 166.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 145.0, 82.0, 85.0, 83.0, 144.0, 83.0, 82.0, 139.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 67.0, 65.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 83.0, 83.0, 82.0, 82.0, 83.0, 82.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 130.0, 141.0, 138.0, 133.0, 131.0, 133.0, 177.0, 132.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 175.0, 173.0, 177.0, 175.0, 174.0, 179.0, 178.0, 178.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 69.0, 68.0, 69.0, 68.0, 68.0, 67.0, 68.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1577.6999999999998, "alertThreshold": 2.0}]} 12:43:35 INFO - Return code: 0 12:43:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:43:35 INFO - # TBPL SUCCESS # 12:43:35 INFO - Running post-action listener: _resource_record_post_action 12:43:35 INFO - [mozharness: 2016-09-02 19:43:35.949396Z] Finished run-tests step (success) 12:43:35 INFO - Running post-run listener: _resource_record_post_run 12:43:36 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 405893120; Read time: 0; Write time: 357532 12:43:36 INFO - TinderboxPrint: CPU usage
13.0% 12:43:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:43:36 INFO - TinderboxPrint: I/O write bytes / time
405,893,120 / 357,532 12:43:36 INFO - TinderboxPrint: CPU idle
8,353.2 (86.9%) 12:43:36 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 12:43:36 INFO - TinderboxPrint: Swap in / out
0 / 0 12:43:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114061312; Read time: 0; Write time: 142404 12:43:36 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291459072; Read time: 0; Write time: 215128 12:43:36 INFO - Running post-run listener: _upload_blobber_files 12:43:36 INFO - Blob upload gear active. 12:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:43:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:43:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:43:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:43:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:37 INFO - (blobuploader) - INFO - Done attempting. 12:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:44 INFO - (blobuploader) - INFO - Done attempting. 12:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:43:45 INFO - (blobuploader) - INFO - Done attempting. 12:43:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:43:45 INFO - Return code: 0 12:43:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:43:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:43:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d825db040894bfe6db8e4684f35c33d25f31491e174b4b9c75d2003264a91ca94e1713fa7e507f5dd9df87e869e12cc86cab1d9e29651e140b473f895288b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0821655cfcdc902166ce9dbace63c2f5c30631fa06239a9c124d57db96cd63da43c6420f1e035db0d6e42ab119ea0e4af17894bd031614fa5bbb07cf435a5c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac5e5b3fa73ccd3c3b21a66e474c43712a57de24a159e51543719a84064f5c0110801a9d3969523acebc3ad774f5cf1f1a30f6db5086e1072280403e043080b8"} 12:43:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:43:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:43:45 INFO - Contents: 12:43:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1d825db040894bfe6db8e4684f35c33d25f31491e174b4b9c75d2003264a91ca94e1713fa7e507f5dd9df87e869e12cc86cab1d9e29651e140b473f895288b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0821655cfcdc902166ce9dbace63c2f5c30631fa06239a9c124d57db96cd63da43c6420f1e035db0d6e42ab119ea0e4af17894bd031614fa5bbb07cf435a5c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac5e5b3fa73ccd3c3b21a66e474c43712a57de24a159e51543719a84064f5c0110801a9d3969523acebc3ad774f5cf1f1a30f6db5086e1072280403e043080b8"} 12:43:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:43:45 INFO - Copying logs to upload dir... 12:43:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:43:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.140716 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-09-02 12:43:45.064219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 12:43:45.067439) ========= 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=4300f881736b422476174874000001bc-1472843764.257459-281163976 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/1d825db040894bfe6db8e4684f35c33d25f31491e174b4b9c75d2003264a91ca94e1713fa7e507f5dd9df87e869e12cc86cab1d9e29651e140b473f895288b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0821655cfcdc902166ce9dbace63c2f5c30631fa06239a9c124d57db96cd63da43c6420f1e035db0d6e42ab119ea0e4af17894bd031614fa5bbb07cf435a5c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac5e5b3fa73ccd3c3b21a66e474c43712a57de24a159e51543719a84064f5c0110801a9d3969523acebc3ad774f5cf1f1a30f6db5086e1072280403e043080b8"} build_url:https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/UPkJfTk3QNCh5s_GSXSbug/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/1d825db040894bfe6db8e4684f35c33d25f31491e174b4b9c75d2003264a91ca94e1713fa7e507f5dd9df87e869e12cc86cab1d9e29651e140b473f895288b31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0821655cfcdc902166ce9dbace63c2f5c30631fa06239a9c124d57db96cd63da43c6420f1e035db0d6e42ab119ea0e4af17894bd031614fa5bbb07cf435a5c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ac5e5b3fa73ccd3c3b21a66e474c43712a57de24a159e51543719a84064f5c0110801a9d3969523acebc3ad774f5cf1f1a30f6db5086e1072280403e043080b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 12:43:45.092632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:43:45.092950) ========= 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=4300f881736b422476174874000001bc-1472843764.257459-281163976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 12:43:45.177014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 12:43:45.177338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 12:43:45.177626) ========= ========= Total master_lag: 0.30 =========