builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1471549945.19 results: success (0) buildid: 20160818123355 builduid: fe78a431ec07471699acb0c72bcf5f3b revision: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.194705) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.195708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.196382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.213611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.214250) ========= 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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 12:52:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-08-18 12:52:25 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.352920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.353674) ========= 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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.405135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:25.405529) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0c135a70a81ae0c7dd714ea93ff45300f69ad475 --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 0c135a70a81ae0c7dd714ea93ff45300f69ad475 --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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 12:52:25,801 truncating revision to first 12 chars 2016-08-18 12:52:25,801 Setting DEBUG logging. 2016-08-18 12:52:25,801 attempt 1/10 2016-08-18 12:52:25,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0c135a70a81a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 12:52:26,145 unpacking tar archive at: autoland-0c135a70a81a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:26.104241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:26.104607) ========= script_repo_revision: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:26.105053) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:26.105355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 12:52:26.116244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-18 12:52:26.116671) ========= /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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:52:26 INFO - MultiFileLogger online at 20160818 12:52:26 in /builds/slave/test 12:52:26 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:52:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:52:26 INFO - {'append_to_log': False, 12:52:26 INFO - 'base_work_dir': '/builds/slave/test', 12:52:26 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 12:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:52:26 INFO - 'branch': 'Autoland-Non-PGO', 12:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:52:26 INFO - 'config_files': ('talos/linux_config.py',), 12:52:26 INFO - 'default_actions': ('clobber', 12:52:26 INFO - 'read-buildbot-config', 12:52:26 INFO - 'download-and-extract', 12:52:26 INFO - 'populate-webroot', 12:52:26 INFO - 'create-virtualenv', 12:52:26 INFO - 'install', 12:52:26 INFO - 'run-tests'), 12:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:52:26 INFO - 'download_minidump_stackwalk': True, 12:52:26 INFO - 'download_symbols': 'ondemand', 12:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:52:26 INFO - 'installer_path': 'installer.exe', 12:52:26 INFO - 'log_level': 'info', 12:52:26 INFO - 'log_name': 'talos', 12:52:26 INFO - 'log_to_console': True, 12:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:52:26 INFO - 'opt_config_files': (), 12:52:26 INFO - 'pip_index': False, 12:52:26 INFO - 'sps_profile': False, 12:52:26 INFO - 'sps_profile_interval': 0, 12:52:26 INFO - 'suite': 'dromaeojs', 12:52:26 INFO - 'system_bits': '32', 12:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:52:26 INFO - 'title': 'talos-linux64-ix-026', 12:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:52:26 INFO - 'use_talos_json': True, 12:52:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:52:26 INFO - 'work_dir': 'build'} 12:52:26 INFO - [mozharness: 2016-08-18 19:52:26.617142Z] Running clobber step. 12:52:26 INFO - Running pre-action listener: _resource_record_pre_action 12:52:26 INFO - Running main action method: clobber 12:52:26 INFO - rmtree: /builds/slave/test/build 12:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:52:27 INFO - Running post-action listener: _resource_record_post_action 12:52:27 INFO - [mozharness: 2016-08-18 19:52:27.593828Z] Finished clobber step (success) 12:52:27 INFO - [mozharness: 2016-08-18 19:52:27.593927Z] Running read-buildbot-config step. 12:52:27 INFO - Running pre-action listener: _resource_record_pre_action 12:52:27 INFO - Running main action method: read_buildbot_config 12:52:27 INFO - Using buildbot properties: 12:52:27 INFO - { 12:52:27 INFO - "project": "", 12:52:27 INFO - "product": "firefox", 12:52:27 INFO - "script_repo_revision": "production", 12:52:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 12:52:27 INFO - "repository": "", 12:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 12:52:27 INFO - "buildid": "20160818123355", 12:52:27 INFO - "pgo_build": "False", 12:52:27 INFO - "basedir": "/builds/slave/test", 12:52:27 INFO - "buildnumber": 413, 12:52:27 INFO - "slavename": "talos-linux64-ix-026", 12:52:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:52:27 INFO - "platform": "ubuntu64_hw", 12:52:27 INFO - "scheduler": "tests-autoland-linux64-talos", 12:52:27 INFO - "branch": "autoland", 12:52:27 INFO - "repo_path": "integration/autoland", 12:52:27 INFO - "revision": "0c135a70a81ae0c7dd714ea93ff45300f69ad475", 12:52:27 INFO - "stage_platform": "linux64", 12:52:27 INFO - "builduid": "fe78a431ec07471699acb0c72bcf5f3b", 12:52:27 INFO - "slavebuilddir": "test" 12:52:27 INFO - } 12:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 12:52:27 INFO - Running post-action listener: _resource_record_post_action 12:52:27 INFO - [mozharness: 2016-08-18 19:52:27.596338Z] Finished read-buildbot-config step (success) 12:52:27 INFO - [mozharness: 2016-08-18 19:52:27.596426Z] Running download-and-extract step. 12:52:27 INFO - Running pre-action listener: _resource_record_pre_action 12:52:27 INFO - Running main action method: download_and_extract 12:52:27 INFO - mkdir: /builds/slave/test/build/tests 12:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:27 INFO - trying https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:28 INFO - Downloaded 1361 bytes. 12:52:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 12:52:28 INFO - Using the following test package requirements: 12:52:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:52:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:52:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'jsshell-linux-x86_64.zip'], 12:52:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:52:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 12:52:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:52:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:52:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:52:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 12:52:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:52:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:28 INFO - trying https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:52:28 INFO - Downloading https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:29 INFO - Downloaded 20317507 bytes. 12:52:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:52:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:33 INFO - trying https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 12:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:34 INFO - Downloaded 20317507 bytes. 12:52:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 12:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:39 INFO - trying https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:39 INFO - Downloading https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:39 INFO - Downloaded 14413981 bytes. 12:52:39 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:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:40 INFO - trying https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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:52:41 INFO - Downloaded 55768562 bytes. 12:52:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:52:41 INFO - mkdir: /builds/slave/test/properties 12:52:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:52:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:52:41 INFO - Contents: 12:52:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 12:52:41 INFO - Running post-action listener: _resource_record_post_action 12:52:41 INFO - Running post-action listener: set_extra_try_arguments 12:52:41 INFO - [mozharness: 2016-08-18 19:52:41.979473Z] Finished download-and-extract step (success) 12:52:41 INFO - [mozharness: 2016-08-18 19:52:41.979696Z] Running populate-webroot step. 12:52:41 INFO - Running pre-action listener: _resource_record_pre_action 12:52:41 INFO - Running main action method: populate_webroot 12:52:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:41 INFO - '--tppagecycles', 12:52:41 INFO - '7'], 12:52:41 INFO - 'tests': ['tsvgm']}}, 12:52:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:52:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:52:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:52:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['damp', 'tps']}, 12:52:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'tests': ['damp', 'tps']}, 12:52:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['dromaeo_dom']}, 12:52:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['basic_compositor_video']}, 12:52:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:52:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['a11yr', 12:52:41 INFO - 'ts_paint', 12:52:41 INFO - 'tpaint', 12:52:41 INFO - 'sessionrestore', 12:52:41 INFO - 'sessionrestore_no_auto_restore', 12:52:41 INFO - 'tabpaint']}, 12:52:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['tsvgx', 12:52:41 INFO - 'tsvgr_opacity', 12:52:41 INFO - 'tart', 12:52:41 INFO - 'tscrollx', 12:52:41 INFO - 'cart']}, 12:52:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:52:41 INFO - 'tsvgr_opacity', 12:52:41 INFO - 'tart', 12:52:41 INFO - 'tscrollx', 12:52:41 INFO - 'cart']}, 12:52:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'talos_options': ['--disable-e10s'], 12:52:41 INFO - 'tests': ['tp5o']}, 12:52:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'tests': ['tp5o']}, 12:52:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'talos_options': ['--disable-e10s', 12:52:41 INFO - '--xperf_path', 12:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:41 INFO - 'tests': ['tp5n']}, 12:52:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:41 INFO - 'talos_options': ['--xperf_path', 12:52:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:41 INFO - 'tests': ['tp5n']}}, 12:52:41 INFO - 'talos.zip': {'path': '', 12:52:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:41 INFO - Running post-action listener: _resource_record_post_action 12:52:41 INFO - [mozharness: 2016-08-18 19:52:41.998924Z] Finished populate-webroot step (success) 12:52:41 INFO - [mozharness: 2016-08-18 19:52:41.999012Z] Running create-virtualenv step. 12:52:41 INFO - Running pre-action listener: _resource_record_pre_action 12:52:41 INFO - Running main action method: create_virtualenv 12:52:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:52:41 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:52:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:42 INFO - Using real prefix '/usr' 12:52:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:52:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:44 INFO - Installing pip.................done. 12:52:44 INFO - Return code: 0 12:52:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:52:44 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:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:44 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:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:44 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:44 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:52:44 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:52:44 INFO - Using env: {'DISPLAY': ':0', 12:52:44 INFO - 'HOME': '/home/cltbld', 12:52:44 INFO - 'LANG': 'en_US.UTF-8', 12:52:44 INFO - 'LANGUAGE': 'en_US:en', 12:52:44 INFO - 'LOGNAME': 'cltbld', 12:52:44 INFO - 'MAIL': '/var/mail/cltbld', 12:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:44 INFO - 'MOZ_NO_REMOTE': '1', 12:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:44 INFO - 'NO_EM_RESTART': '1', 12:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:44 INFO - 'PWD': '/builds/slave/test', 12:52:44 INFO - 'SHELL': '/bin/bash', 12:52:44 INFO - 'SHLVL': '1', 12:52:44 INFO - 'TERM': 'linux', 12:52:44 INFO - 'TMOUT': '86400', 12:52:44 INFO - 'USER': 'cltbld', 12:52:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:44 INFO - '_': '/tools/buildbot/bin/python'} 12:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:44 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:52:44 INFO - Cleaning up... 12:52:44 INFO - Return code: 0 12:52:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:52:44 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:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:44 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:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:44 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:44 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:52:44 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:52:44 INFO - Using env: {'DISPLAY': ':0', 12:52:44 INFO - 'HOME': '/home/cltbld', 12:52:44 INFO - 'LANG': 'en_US.UTF-8', 12:52:44 INFO - 'LANGUAGE': 'en_US:en', 12:52:44 INFO - 'LOGNAME': 'cltbld', 12:52:44 INFO - 'MAIL': '/var/mail/cltbld', 12:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:44 INFO - 'MOZ_NO_REMOTE': '1', 12:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:44 INFO - 'NO_EM_RESTART': '1', 12:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:44 INFO - 'PWD': '/builds/slave/test', 12:52:44 INFO - 'SHELL': '/bin/bash', 12:52:44 INFO - 'SHLVL': '1', 12:52:44 INFO - 'TERM': 'linux', 12:52:44 INFO - 'TMOUT': '86400', 12:52:44 INFO - 'USER': 'cltbld', 12:52:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:44 INFO - '_': '/tools/buildbot/bin/python'} 12:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:44 INFO - Downloading/unpacking psutil>=3.1.1 12:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:47 INFO - Installing collected packages: psutil 12:52:47 INFO - Running setup.py install for psutil 12:52:47 INFO - building 'psutil._psutil_linux' extension 12:52:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:52:47 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:52:47 INFO - building 'psutil._psutil_posix' extension 12:52:47 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:52:47 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:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:47 INFO - Successfully installed psutil 12:52:47 INFO - Cleaning up... 12:52:47 INFO - Return code: 0 12:52:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:52: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:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:47 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:47 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:52:47 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:52:47 INFO - Using env: {'DISPLAY': ':0', 12:52:47 INFO - 'HOME': '/home/cltbld', 12:52:47 INFO - 'LANG': 'en_US.UTF-8', 12:52:47 INFO - 'LANGUAGE': 'en_US:en', 12:52:47 INFO - 'LOGNAME': 'cltbld', 12:52:47 INFO - 'MAIL': '/var/mail/cltbld', 12:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:47 INFO - 'MOZ_NO_REMOTE': '1', 12:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:47 INFO - 'NO_EM_RESTART': '1', 12:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:47 INFO - 'PWD': '/builds/slave/test', 12:52:47 INFO - 'SHELL': '/bin/bash', 12:52:47 INFO - 'SHLVL': '1', 12:52:47 INFO - 'TERM': 'linux', 12:52:47 INFO - 'TMOUT': '86400', 12:52:47 INFO - 'USER': 'cltbld', 12:52:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:47 INFO - '_': '/tools/buildbot/bin/python'} 12:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:47 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:52:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:52:49 INFO - Installing collected packages: mozsystemmonitor 12:52:49 INFO - Running setup.py install for mozsystemmonitor 12:52:49 INFO - Successfully installed mozsystemmonitor 12:52:49 INFO - Cleaning up... 12:52:49 INFO - Return code: 0 12:52:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:52:49 INFO - Using env: {'DISPLAY': ':0', 12:52:49 INFO - 'HOME': '/home/cltbld', 12:52:49 INFO - 'LANG': 'en_US.UTF-8', 12:52:49 INFO - 'LANGUAGE': 'en_US:en', 12:52:49 INFO - 'LOGNAME': 'cltbld', 12:52:49 INFO - 'MAIL': '/var/mail/cltbld', 12:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:49 INFO - 'MOZ_NO_REMOTE': '1', 12:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:49 INFO - 'NO_EM_RESTART': '1', 12:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:49 INFO - 'PWD': '/builds/slave/test', 12:52:49 INFO - 'SHELL': '/bin/bash', 12:52:49 INFO - 'SHLVL': '1', 12:52:49 INFO - 'TERM': 'linux', 12:52:49 INFO - 'TMOUT': '86400', 12:52:49 INFO - 'USER': 'cltbld', 12:52:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:49 INFO - '_': '/tools/buildbot/bin/python'} 12:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:52 INFO - warning: no files found matching '*.txt' 12:52:52 INFO - no previously-included directories found matching 'build' 12:52:52 INFO - no previously-included directories found matching 'dist' 12:52:52 INFO - no previously-included directories found matching '.git*' 12:52:52 INFO - Installing collected packages: jsonschema, functools32 12:52:52 INFO - Running setup.py install for functools32 12:52:52 INFO - warning: no files found matching '*.txt' 12:52:52 INFO - no previously-included directories found matching 'build' 12:52:52 INFO - no previously-included directories found matching 'dist' 12:52:52 INFO - no previously-included directories found matching '.git*' 12:52:52 INFO - Successfully installed jsonschema functools32 12:52:52 INFO - Cleaning up... 12:52:52 INFO - Return code: 0 12:52:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52: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:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:52:52 INFO - Using env: {'DISPLAY': ':0', 12:52:52 INFO - 'HOME': '/home/cltbld', 12:52:52 INFO - 'LANG': 'en_US.UTF-8', 12:52:52 INFO - 'LANGUAGE': 'en_US:en', 12:52:52 INFO - 'LOGNAME': 'cltbld', 12:52:52 INFO - 'MAIL': '/var/mail/cltbld', 12:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:52 INFO - 'MOZ_NO_REMOTE': '1', 12:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:52 INFO - 'NO_EM_RESTART': '1', 12:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:52 INFO - 'PWD': '/builds/slave/test', 12:52:52 INFO - 'SHELL': '/bin/bash', 12:52:52 INFO - 'SHLVL': '1', 12:52:52 INFO - 'TERM': 'linux', 12:52:52 INFO - 'TMOUT': '86400', 12:52:52 INFO - 'USER': 'cltbld', 12:52:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:52 INFO - '_': '/tools/buildbot/bin/python'} 12:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:52 INFO - Cleaning up... 12:52:52 INFO - Return code: 0 12:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52: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:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:52:52 INFO - Using env: {'DISPLAY': ':0', 12:52:52 INFO - 'HOME': '/home/cltbld', 12:52:52 INFO - 'LANG': 'en_US.UTF-8', 12:52:52 INFO - 'LANGUAGE': 'en_US:en', 12:52:52 INFO - 'LOGNAME': 'cltbld', 12:52:52 INFO - 'MAIL': '/var/mail/cltbld', 12:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:52 INFO - 'MOZ_NO_REMOTE': '1', 12:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:52 INFO - 'NO_EM_RESTART': '1', 12:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:52 INFO - 'PWD': '/builds/slave/test', 12:52:52 INFO - 'SHELL': '/bin/bash', 12:52:52 INFO - 'SHLVL': '1', 12:52:52 INFO - 'TERM': 'linux', 12:52:52 INFO - 'TMOUT': '86400', 12:52:52 INFO - 'USER': 'cltbld', 12:52:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:52 INFO - '_': '/tools/buildbot/bin/python'} 12:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:52 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:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:55 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:52:55 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:52:55 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:52:55 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:52:55 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:52:55 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:52:55 INFO - Downloading docopt-0.6.1.tar.gz 12:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:55 INFO - Running setup.py install for blobuploader 12:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:55 INFO - Running setup.py install for requests 12:52:55 INFO - Running setup.py install for docopt 12:52:56 INFO - Successfully installed blobuploader requests docopt 12:52:56 INFO - Cleaning up... 12:52:56 INFO - Return code: 0 12:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:56 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:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:56 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:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:56 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:56 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:52:56 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:52:56 INFO - Using env: {'DISPLAY': ':0', 12:52:56 INFO - 'HOME': '/home/cltbld', 12:52:56 INFO - 'LANG': 'en_US.UTF-8', 12:52:56 INFO - 'LANGUAGE': 'en_US:en', 12:52:56 INFO - 'LOGNAME': 'cltbld', 12:52:56 INFO - 'MAIL': '/var/mail/cltbld', 12:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:56 INFO - 'MOZ_NO_REMOTE': '1', 12:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:56 INFO - 'NO_EM_RESTART': '1', 12:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:56 INFO - 'PWD': '/builds/slave/test', 12:52:56 INFO - 'SHELL': '/bin/bash', 12:52:56 INFO - 'SHLVL': '1', 12:52:56 INFO - 'TERM': 'linux', 12:52:56 INFO - 'TMOUT': '86400', 12:52:56 INFO - 'USER': 'cltbld', 12:52:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:56 INFO - '_': '/tools/buildbot/bin/python'} 12:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:56 INFO - Running setup.py (path:/tmp/pip-K5yWFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:56 INFO - Running setup.py (path:/tmp/pip-1nquuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:56 INFO - Running setup.py (path:/tmp/pip-Ej6dTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:56 INFO - Running setup.py (path:/tmp/pip-AiVO87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:56 INFO - Running setup.py (path:/tmp/pip-MokHxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:56 INFO - Running setup.py (path:/tmp/pip-vSV1mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:56 INFO - Running setup.py (path:/tmp/pip-vzPBoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:56 INFO - Running setup.py (path:/tmp/pip-4QxvYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:56 INFO - Running setup.py (path:/tmp/pip-g4ebJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:56 INFO - Running setup.py (path:/tmp/pip-plvuCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:57 INFO - Running setup.py (path:/tmp/pip-O0qJnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:57 INFO - Running setup.py (path:/tmp/pip-XALrKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:57 INFO - Running setup.py (path:/tmp/pip-3uTZeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:57 INFO - Running setup.py (path:/tmp/pip-0tyENw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:57 INFO - Running setup.py (path:/tmp/pip-JnB25u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:57 INFO - Running setup.py (path:/tmp/pip-ztEp3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:57 INFO - Running setup.py (path:/tmp/pip-3Qd0nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:57 INFO - Running setup.py install for manifestparser 12:52:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:57 INFO - Running setup.py install for mozcrash 12:52:57 INFO - Running setup.py install for mozdebug 12:52:57 INFO - Running setup.py install for mozdevice 12:52:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:52:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:57 INFO - Running setup.py install for mozfile 12:52:58 INFO - Running setup.py install for mozhttpd 12:52:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for mozinfo 12:52:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for mozInstall 12:52:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for mozleak 12:52:58 INFO - Running setup.py install for mozlog 12:52:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for moznetwork 12:52:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for mozprocess 12:52:58 INFO - Running setup.py install for mozprofile 12:52:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:58 INFO - Running setup.py install for mozrunner 12:52:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:59 INFO - Running setup.py install for mozscreenshot 12:52:59 INFO - Running setup.py install for moztest 12:52:59 INFO - Running setup.py install for mozversion 12:52:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:59 INFO - Cleaning up... 12:52:59 INFO - Return code: 0 12:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52: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:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:59 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:52:59 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:52:59 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:52:59 INFO - Using env: {'DISPLAY': ':0', 12:52:59 INFO - 'HOME': '/home/cltbld', 12:52:59 INFO - 'LANG': 'en_US.UTF-8', 12:52:59 INFO - 'LANGUAGE': 'en_US:en', 12:52:59 INFO - 'LOGNAME': 'cltbld', 12:52:59 INFO - 'MAIL': '/var/mail/cltbld', 12:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:59 INFO - 'MOZ_NO_REMOTE': '1', 12:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:59 INFO - 'NO_EM_RESTART': '1', 12:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:59 INFO - 'PWD': '/builds/slave/test', 12:52:59 INFO - 'SHELL': '/bin/bash', 12:52:59 INFO - 'SHLVL': '1', 12:52:59 INFO - 'TERM': 'linux', 12:52:59 INFO - 'TMOUT': '86400', 12:52:59 INFO - 'USER': 'cltbld', 12:52:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:59 INFO - '_': '/tools/buildbot/bin/python'} 12:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:59 INFO - Running setup.py (path:/tmp/pip-mByQh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:59 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:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:59 INFO - Running setup.py (path:/tmp/pip-W7pLS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:59 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:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:59 INFO - Running setup.py (path:/tmp/pip-vOQMbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:59 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:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:59 INFO - Running setup.py (path:/tmp/pip-PmOyLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:59 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:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:59 INFO - Running setup.py (path:/tmp/pip-miEqjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:59 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:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:59 INFO - Running setup.py (path:/tmp/pip-f6QPzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:00 INFO - Running setup.py (path:/tmp/pip-X20Q9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:00 INFO - Running setup.py (path:/tmp/pip-vJymzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:00 INFO - Running setup.py (path:/tmp/pip-NMQcoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:00 INFO - Running setup.py (path:/tmp/pip-ShMUv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:00 INFO - Running setup.py (path:/tmp/pip-ti3Ocs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:00 INFO - Running setup.py (path:/tmp/pip-EqdEjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:00 INFO - Running setup.py (path:/tmp/pip-PT6vOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:00 INFO - Running setup.py (path:/tmp/pip-6kDQQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:00 INFO - Running setup.py (path:/tmp/pip-0CS2vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:00 INFO - Running setup.py (path:/tmp/pip-XJkrx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:00 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:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:00 INFO - Running setup.py (path:/tmp/pip-QsIVfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:02 INFO - Downloading blessings-1.6.tar.gz 12:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:02 INFO - Installing collected packages: blessings 12:53:02 INFO - Running setup.py install for blessings 12:53:02 INFO - Successfully installed blessings 12:53:02 INFO - Cleaning up... 12:53:02 INFO - Return code: 0 12:53:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:03 INFO - Reading from file tmpfile_stdout 12:53:03 INFO - Current package versions: 12:53:03 INFO - argparse == 1.2.1 12:53:03 INFO - blessings == 1.6 12:53:03 INFO - blobuploader == 1.2.4 12:53:03 INFO - docopt == 0.6.1 12:53:03 INFO - functools32 == 3.2.3-2 12:53:03 INFO - jsonschema == 2.5.1 12:53:03 INFO - manifestparser == 1.1 12:53:03 INFO - mozInstall == 1.12 12:53:03 INFO - mozcrash == 0.17 12:53:03 INFO - mozdebug == 0.1 12:53:03 INFO - mozdevice == 0.48 12:53:03 INFO - mozfile == 1.2 12:53:03 INFO - mozhttpd == 0.7 12:53:03 INFO - mozinfo == 0.9 12:53:03 INFO - mozleak == 0.1 12:53:03 INFO - mozlog == 3.3 12:53:03 INFO - moznetwork == 0.27 12:53:03 INFO - mozprocess == 0.23 12:53:03 INFO - mozprofile == 0.28 12:53:03 INFO - mozrunner == 6.12 12:53:03 INFO - mozscreenshot == 0.1 12:53:03 INFO - mozsystemmonitor == 0.3 12:53:03 INFO - moztest == 0.7 12:53:03 INFO - mozversion == 1.4 12:53:03 INFO - psutil == 3.1.1 12:53:03 INFO - requests == 1.2.3 12:53:03 INFO - wsgiref == 0.1.2 12:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:03 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:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:53:03 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:53:03 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:53:03 INFO - Using env: {'DISPLAY': ':0', 12:53:03 INFO - 'HOME': '/home/cltbld', 12:53:03 INFO - 'LANG': 'en_US.UTF-8', 12:53:03 INFO - 'LANGUAGE': 'en_US:en', 12:53:03 INFO - 'LOGNAME': 'cltbld', 12:53:03 INFO - 'MAIL': '/var/mail/cltbld', 12:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:03 INFO - 'MOZ_NO_REMOTE': '1', 12:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:03 INFO - 'NO_EM_RESTART': '1', 12:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:03 INFO - 'PWD': '/builds/slave/test', 12:53:03 INFO - 'SHELL': '/bin/bash', 12:53:03 INFO - 'SHLVL': '1', 12:53:03 INFO - 'TERM': 'linux', 12:53:03 INFO - 'TMOUT': '86400', 12:53:03 INFO - 'USER': 'cltbld', 12:53:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:03 INFO - '_': '/tools/buildbot/bin/python'} 12:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 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:53:03 INFO - Cleaning up... 12:53:03 INFO - Return code: 0 12:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:53:03 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:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:03 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 0x7f1285e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2878230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, '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': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', '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:53:03 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:53:03 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:53:03 INFO - Using env: {'DISPLAY': ':0', 12:53:03 INFO - 'HOME': '/home/cltbld', 12:53:03 INFO - 'LANG': 'en_US.UTF-8', 12:53:03 INFO - 'LANGUAGE': 'en_US:en', 12:53:03 INFO - 'LOGNAME': 'cltbld', 12:53:03 INFO - 'MAIL': '/var/mail/cltbld', 12:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:03 INFO - 'MOZ_NO_REMOTE': '1', 12:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:03 INFO - 'NO_EM_RESTART': '1', 12:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:03 INFO - 'PWD': '/builds/slave/test', 12:53:03 INFO - 'SHELL': '/bin/bash', 12:53:03 INFO - 'SHLVL': '1', 12:53:03 INFO - 'TERM': 'linux', 12:53:03 INFO - 'TMOUT': '86400', 12:53:03 INFO - 'USER': 'cltbld', 12:53:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:03 INFO - '_': '/tools/buildbot/bin/python'} 12:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:53:03 INFO - Cleaning up... 12:53:03 INFO - Return code: 0 12:53:03 INFO - Running post-action listener: _resource_record_post_action 12:53:03 INFO - Running post-action listener: _start_resource_monitoring 12:53:03 INFO - Starting resource monitoring. 12:53:03 INFO - [mozharness: 2016-08-18 19:53:03.607283Z] Finished create-virtualenv step (success) 12:53:03 INFO - [mozharness: 2016-08-18 19:53:03.607790Z] Running install step. 12:53:03 INFO - Running pre-action listener: _resource_record_pre_action 12:53:03 INFO - Running main action method: install 12:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:03 INFO - Reading from file tmpfile_stdout 12:53:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:53:03 INFO - Reading from file tmpfile_stdout 12:53:03 INFO - Output received: 12:53:03 INFO - Usage: mozinstall [options] installer 12:53:03 INFO - Options: 12:53:03 INFO - -h, --help show this help message and exit 12:53:03 INFO - -d DEST, --destination=DEST 12:53:03 INFO - Directory to install application into. [default: 12:53:03 INFO - "/builds/slave/test"] 12:53:03 INFO - --app=APP Application being installed. [default: firefox] 12:53:03 INFO - mkdir: /builds/slave/test/build/application 12:53:03 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:53:03 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:53:20 INFO - Reading from file tmpfile_stdout 12:53:20 INFO - Output received: 12:53:20 INFO - /builds/slave/test/build/application/firefox/firefox 12:53:20 INFO - Running post-action listener: _resource_record_post_action 12:53:20 INFO - [mozharness: 2016-08-18 19:53:20.079739Z] Finished install step (success) 12:53:20 INFO - [mozharness: 2016-08-18 19:53:20.079985Z] Running run-tests step. 12:53:20 INFO - Running pre-action listener: _resource_record_pre_action 12:53:20 INFO - Running main action method: run_tests 12:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:53:20 INFO - Python 2.7.3 12:53:20 INFO - Return code: 0 12:53:20 INFO - grabbing minidump binary from tooltool 12:53: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:53:20 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 0x2872090>, '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 0x28759b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:53:20 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:53:20 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:53:20 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:53:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:20 INFO - Return code: 0 12:53:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:53:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:53:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:53:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:53:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:53:20 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/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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:53:20 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/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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:53:20 INFO - Using env: {'DISPLAY': ':0', 12:53:20 INFO - 'HOME': '/home/cltbld', 12:53:20 INFO - 'LANG': 'en_US.UTF-8', 12:53:20 INFO - 'LANGUAGE': 'en_US:en', 12:53:20 INFO - 'LOGNAME': 'cltbld', 12:53:20 INFO - 'MAIL': '/var/mail/cltbld', 12:53:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:53:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:20 INFO - 'MOZ_NO_REMOTE': '1', 12:53:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:20 INFO - 'NO_EM_RESTART': '1', 12:53:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:20 INFO - 'PWD': '/builds/slave/test', 12:53:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:53:20 INFO - 'SHELL': '/bin/bash', 12:53:20 INFO - 'SHLVL': '1', 12:53:20 INFO - 'TERM': 'linux', 12:53:20 INFO - 'TMOUT': '86400', 12:53:20 INFO - 'USER': 'cltbld', 12:53:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194', 12:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:20 INFO - '_': '/tools/buildbot/bin/python'} 12:53:20 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/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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:53:20 INFO - mozversion application_buildid: 20160818123355 12:53:20 INFO - mozversion application_changeset: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 12:53:20 INFO - mozversion application_display_name: Nightly 12:53:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:20 INFO - mozversion application_name: Firefox 12:53:20 INFO - mozversion application_remotingname: firefox 12:53:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:53:20 INFO - mozversion application_vendor: Mozilla 12:53:20 INFO - mozversion application_version: 51.0a1 12:53:20 INFO - mozversion platform_buildid: 20160818123355 12:53:20 INFO - mozversion platform_changeset: 0c135a70a81ae0c7dd714ea93ff45300f69ad475 12:53:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:53:20 INFO - mozversion platform_version: 51.0a1 12:53:20 INFO - using testdate: 1471550000 12:53:20 INFO - actual date: 1471550000 12:53:20 INFO - starting webserver on 'localhost:54201' 12:53:20 INFO - SUITE-START | Running 2 tests 12:53:20 INFO - TEST-START | dromaeo_css 12:53:20 INFO - operating with platform_type : linux_ 12:53:20 INFO - Initialising browser for dromaeo_css test... 12:53:20 INFO - TEST-INFO | started process 1597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP97jSp/profile http://localhost:54201/getInfo.html) 12:53:24 INFO - PROCESS | 1597 | __metrics Screen width/height:1600/1200 12:53:24 INFO - PROCESS | 1597 | colorDepth:24 12:53:24 INFO - PROCESS | 1597 | Browser inner width/height: 1024/697 12:53:24 INFO - PROCESS | 1597 | __metrics 12:53:24 INFO - PROCESS | 1597 | 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:53:24 INFO - PROCESS | 1597 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:25 INFO - PROCESS | 1597 | console.error: PushService: 12:53:25 INFO - PROCESS | 1597 | stateChangeProcessEnqueue: Error transitioning state 12:53:25 INFO - PROCESS | 1597 | UnknownError 12:53:26 INFO - TEST-INFO | 1597: exit 0 12:53:26 INFO - Browser initialized. 12:53:26 INFO - Running cycle 1/1 for dromaeo_css test... 12:53:26 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP97jSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:38 INFO - PROCESS | 1679 | RSS: Main: 157360128 12:53:38 INFO - PROCESS | 1679 | 12:54:30 INFO - PROCESS | 1679 | 1471550070407 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:56:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54201/tests/dromaeo/cssquery-ext.html) 12:56:43 INFO - PROCESS | 1679 | RSS: Main: 245088256 12:56:43 INFO - PROCESS | 1679 | 12:59:45 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-ext.html (next: http://localhost:54201/tests/dromaeo/cssquery-jquery.html) 12:59:46 INFO - PROCESS | 1679 | RSS: Main: 239140864 12:59:46 INFO - PROCESS | 1679 | 13:02:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54201/tests/dromaeo/cssquery-mootools.html) 13:02:49 INFO - PROCESS | 1679 | RSS: Main: 187920384 13:02:49 INFO - PROCESS | 1679 | 13:05:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54201/tests/dromaeo/cssquery-prototype.html) 13:05:52 INFO - PROCESS | 1679 | RSS: Main: 193265664 13:05:52 INFO - PROCESS | 1679 | 13:08:55 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54201/tests/dromaeo/cssquery-yui.html) 13:08:55 INFO - PROCESS | 1679 | RSS: Main: 188338176 13:08:55 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:54201/tests/dromaeo/cssquery-yui.html (next: http://localhost:54201/tests/dromaeo/cssquery-dojo.html) 13:11:59 INFO - PROCESS | 1679 | RSS: Main: 273588224 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | __start_tp_report 13:11:59 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 13:11:59 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 13:11:59 INFO - PROCESS | 1679 | |i|pagename|runs| 13:11:59 INFO - PROCESS | 1679 | |0;dojo.html;2549.8980040798365;2590.6502622146004;2600.9869950650245;2606.869656517175;2608.1002054291275;4529.297958816381;4622.0524792417555;4656.7671616419175;4700.976495117524;4704.952950470494;4511.819527218916;4572.131295053938;4585.977070114644;4611.146937816507;4674.789634466449;4200.642945349649;4224.408582798395;4290.935635965463;4336.241157797373;4396.670249731267;4353.891152721191;4368.781560921957;4410.007748256633;4423.823047078129;4429.180601588717;4198.727082739612;4245.150969806051;4279.2083464559155;4279.422277992462;4357;4259.595338442843;4272.850450234227;4299.50555686097;4302.440682711259;4315.503717072545;4257.425247591566;4307.504636966758;4323.329883868006;4330.501992270866;4376.846810361654;4536.909261814745;4734.313524538957;4761.381020467352;4764.595009424203;4792.9281060784115;4861.927071093936;4915.410150781893;4923.212286034253;4966.279889416014;4966.975165124188;4914.508549145057;4954.702717836942;4988.052270068712;5005.02402031604;5013.824516141917;4534.115847409789;4578.221702310615;4631.675782695246;4666.510016448292;4672.275797251432;4973.35346404965;5002.974985125051;5033.874153146201;5048.066107770001;5061.797528098835;4813.831515896927;4820.301056346881;4859.22252439615;4863.975680121577;4868.464468908417;4799.088173247072;4856.732879691651;4900.215965445512;4930.2358134488495;4940.061388336205;4844.636652251095;4888.511148885154;4918.213085906238;4942.579880710108;4944.480829512921;4883.145449546315;4896.996115796253;4897.534382356585;4900.926486102711;4937.703737775673;4083.8774836754947;4114.5679703630685;4172.061286210578;4178.770167640809;4220.092680073737;3603.94594081089;3644.9976256529135;3647.379945409287;3682.6869716073898;3746.6815320698047;4316.093620339764;4322.8703138905885;4324.589164029412;4325.697201195949;4376.409184760017;4835.081334546425;4963.553280204799;4966.03162383339;4969.403671559436;4996.7501624918605;4281.764502952367;4308.073764140725;4329.220740266782;4348.695591308641;4378.978105109454;4443.777811109431;4449.599536041772;4461.732296062247;4464.15181115587;4514.210013247669;4560.452745670408;4721.433427988663;4735.810567577259;4736.715797052119;4759.119562880809;4869.586085182657;4924.606031517398;4932.753362331798;4936.4569897311985;4997.225430058346;4671.322658214608;4690.061987602425;4700.482946875909;4702.576768090888;4741.170295198395;4721.952780472151;4836.177849765478;4879.926801097916;4883.853484395474;4884.926726099183;4909.361782968192;4957.4794646561595;4972.055309491185;4994.126027945168;5047.722375269395;4836.975815120902;4847.612191024639;4848.24281150171;4865.318855360181;4896.853094407174;4620.237660785932;4815.012922350979;4858.004109157685;4866.586340161126;4900.313956046085;4694.389729335165;4736.407949006374;4751.691140075884;4801.135795556834;4802.727277271456;4893.975530122327;4895.8041678332465;4900.460949295503;4932.161532539549;4935.309056732132;4604.723716577016;4727.550882666142;4728.810847566059;4729.219678753105;4730.787114579921 13:11:59 INFO - PROCESS | 1679 | |1;ext.html;561.2703485468891;564.9180868774026;578.1847594891204;579.7941730685609;588.9663640311255;28943.565846512294;31763.04710858675;31882.20294492639;40841.387379189335;42186;40584.797076014576;41040.17919641613;41045.38431923516;41092.58907410925;41241.58758412415;7636.427267954912;7758.301752842243;7774.805629859242;7779;7782.883256751154;7530.924690753077;7605.581693006882;7610.39116870649;7611.124720657112;7611.353034992005;7628.389728821709;7661.3487853532515;7667.118281397655;7672.731454399097;7850.568218747967;7589.848203035936;7621.31408173267;7624.618769061524;7628.771136865847;7629.389648828108;7613.200613935513;7661;7673.808154796119;7676.424268179909;7683.1548529661695;37460;37949.24101517954;37979.24041519154;37997;38034;3049.9542506862413;3167.081546351555;3230.96769032309;3316.9220003498717;3374.645662205482;28932.421351573063;29067.70932290671;29659.55510667342;30248.54627180594;30269.848650756827;3180.204948762809;3205.9198520036953;3218.839058047088;3220.91947701307;3279.8688052477873;251184;252483.99999999817;253427;253728;254027;31774;51410.742946285776;51618;51684.74157629263;51746.22380664293;32297.51553726696;33752;33791.66208337934;33804.83097584496;33817.83091084529;12600.558980435824;12676.556320528738;12727.045471589669;12740.681482962815;12747.171433856769;9885.25860560461;9932.255080868963;9935.403875767477;9935.503224838729;9941.80116397668;7700.884486732703;7754.806129846799;7778.338841198448;7817.843643127219;7835.960820195863;2974.479466093425;3031.060371284909;3032.272254658866;3058.6788387219467;3115.12776422602;823.7775800533823;859.1580251353708;904.7738065483629;924.3991405586422;941.9011003844635;27107.45785084287;27790.86104569464;27981.40994448829;28078.578821317697;28214.29464263369;901.6753968571309;956.5695437053354;1008.0977525114981;1014.6955913226003;1052.321252791945;14569.198694071716;14613.853861461463;14644.853551464348;14729.116253024853;14861.777073343908;373590;374950;375411;375926;378277;48382.5161748378;48930.75534622304;49012.754936225094;49060;49116.50883491119;1043.796459690353;1102.6416414665105;1110.7667389848223;1134.6539305511567;1173.1494666366816;27189.72810271951;28712.569311459927;29282.267943301587;29671.851640741657;29759.702402975694;41369;42059.369109463994;42090.368644469745;42192.578074218865;42228.78885605552;282056;284235;285127;285456;286616;22271;22888.31335059951;23388;25514.617280740433;25896.727040038182;36118.27763444769;41537;41715.882200878965;41985.370219447344;43295.350569742106;36239.81880090583;37058.8147059263;37511;40654.39018414785;41564.58435415607;36261.27477450489;36369.454458183674;36499;36535.26929461343;36643.81678091593;35709.1072723184;35962.28075438529;39491.80254098826;39742.80128599339;40138.39792403058;29941;32195.195120122185;33653.663463365054;33760.831195843864;33904;24556.877215613807;25468.108616198344;25503.36241593975;25865.612015820156;26062.609060863724 13:11:59 INFO - PROCESS | 1679 | |2;jquery.html;366.56195845964066;366.5802655958927;368.8745826419018;379.98100094995243;390.9452676625271;16108.597285067879;16651.916740416294;17373.739393909087;17473.864198827097;17500.737488937644;15393.69212615747;15809.841901580981;16139.515814525583;16244.593885152877;16275;4986.800527978886;5243.292155558989;5243.475652434764;5243.711595862226;5250;3746.6253374662588;3908.687305015592;3930.764154150746;3933.3509970854775;5186.377634683843;6039.818805435822;6117.44942955134;6147.077938309245;6147.7233524491285;6151.72317245725;5978.192943952554;6059.303180134275;6079.361667024965;6096.055111457731;6120.540959428016;5178.689278643294;5345.786168553253;5350.785968561292;5352.464753524655;5364.7317634118135;21041;21231.893840530855;21467.67798483024;21472.463188420257;21474.78525214759;1896;1916.5400303926958;2003.889786061766;2007.8114558118116;2013.6375452418558;13474.326283685874;13502.729945401135;13626.318684065856;13734.45062197511;14239.216843073627;1699.3882202407124;1707.8036025857061;1728.2654871679485;1766.381766381769;1800.261892624031;43527.56472435267;64615.67692161556;64979;65294.673526633014;65579;9157.771055723528;9280.72157835266;9475.668351607661;9728.075832795874;9867.259955503223;13154.144980576231;13242;13284.933575332061;13414.12808167466;13426.865731342561;7068.893966590505;7470.140933792574;7505;7611.695532178762;7659.540427574363;7147.6068816214565;7160.10498687664;7329.560226386434;7356;7380.926190738024;5968;6042.425969532887;6110.633361998294;6124;6183.721732522047;1610.5168449465114;1702.7020271452693;1728.6283449058262;1730.0484733396581;1761.8854774439621;645.714824164208;760.7147319755092;781.316348195329;816.6692489541745;894.7584152278848;18504.907475462536;18804.529886752665;19346.4196074118;19394.903025485066;19549.51126221856;803.6263137641025;815.2988429950238;817.2889586060165;819.4264015189391;836.4981011393115;10040.297179197387;10937.234393592531;10999.560017599366;11022.409733712571;11043.83434248487;335554;338999;352439;353412;356512;77734;78685;79302;79394.20605793984;81407;915.4507295622707;921.9354645174908;927.2767241551601;932.7807965128189;936.5551363102472;16331.59171020734;16574.337026518806;17053.147342632572;17170.39903603368;17666.734998975284;38420;38911.6108838908;40183;40256.798716007404;40813.38779918244;52544;53129.46870531245;53336.73331633317;53891.46108538864;55314.44685553254;6415.332013676384;6739.629320387426;6789.830254243683;7021.789346319619;7083.362497375261;8681.006736901096;11227.395876155628;11374.715632108933;12282.07884408655;12552.87447125517;6478.935210647834;7843.098043724816;10368.326058806455;10720.624778132727;10845.457727113455;10410.947945260225;10532.736681583021;10539.894601053891;10815;10908.61819836302;10549.683509494727;10676.46617669129;10805.45972701346;10825.56697732082;11128.276662016942;7423.814404639711;7552.093748750185;7734.961325193338;7927.762167134995;7948.0859701132795;9927.801443970935;10171.135453486537;10173.898261017295;10196.949015254877;10379.169666426818 13:11:59 INFO - PROCESS | 1679 | |3;mootools.html;1347.1109068015112;1371.8422381426135;1412.7527682655539;1620.5624481390032;1637.35324546804;7469.701211951522;8045.235702608257;8052.557109358991;8058.63736131874;8062.596870156491;6799.864002719943;7448.851022979551;7716.96141519293;7719.266669666386;7873.173316801739;2186.1583290433177;2215.091812356934;2216.2575537195057;2220.822334213267;2221.1004543160047;2150.204424362988;2153.8923053847325;2215.7784221577795;2217.6008318502663;2221.078252525208;2164.891755412231;2170.392290158758;2175.216921908112;2179.3570896585466;2222.4666080140732;2156.967645485319;2160.2115227941845;2163.935081947544;2164.4264269968394;2173.5326904715403;2132.1897678882083;2165.0473791531676;2172.576347612216;2173.6413491773997;2176.1513009926143;7776.65005074773;7949.165337639581;7951.085625153066;7962.601869906482;7987.321077708401;4426.490953540352;4597.839075632337;4606.101810146989;4618.307253911907;4625.745583992879;2762.4889395461705;2839.488891999439;2893.117599132264;2894.942101157965;2909.723576260252;844.7719115838689;868.1448772958631;885.0927799006006;891.5854127830526;892.6964831957101;10811.405372704497;10817.945910270477;10860.076893464066;10925.235233533656;10929.398883061429;3983.7609743415487;4143.81352839117;4242.384854196124;4328.5455027222315;4329.134173165379;9268.814623707623;9271.258299336037;9271.258299336172;9271.443713377219;9273.86089208649;4538.478075021349;4557.02024064821;4565.223911934979;4565.269556870885;4565.292379681155;3618.3848745713294;3909.2963266612282;4116.814743336557;4141.79291035447;4168.458100446983;3534.929301413957;3612.8554857805393;3705.184859330943;3747.2505498900327;3770.3967365221433;1168.3749194181073;1196.4257156564724;1200.5797970710182;1209.7338585511172;1216.853977522703;795.3637090327715;801.3308887079354;809.5790189101634;815.9061707903548;842.0568962761746;4907.975460122677;5020.820107274788;5048.5863958091795;5054.444011158843;5111.642185047085;406.13898535105176;408.244747217645;411.4568769224655;411.77352456149;414.35567692238857;3470.132466883279;3504.5444092267844;3556.448750443685;3597.5143355647174;3600.3879340512176;9512.667056652985;9653.758656033515;9772.267079969031;9776.364536305118;9797.118259356692;9698.418094914186;9703.951480242695;9731.659391921248;9735.464549449707;9751.951240243754;7099;7317.341439270491;7381.372583330477;7390.371818395389;7403.037605111409;5157;5341.225522299323;5420.4037555868035;5487.314085739283;5726.370099289158;9009.594568244314;9031.729048128567;9038.819223615623;9051.230645395215;9069.818603628022;8761.780955476164;9308.115729005734;9317.813643726951;9327.207187389147;9333.719988400358;6068.150458935665;6563.278039415756;6857.5199736019995;7004.264552222147;7015.6842942066705;7267.563946163247;7488.400927925862;7519.097708275042;7539.132999704885;7555.924440755742;6360.236771587439;6574.178227721535;6575.5492868210285;6695.531312808252;6766.7969960901255;6442.838929026624;6458.741650333934;6493.675316234264;6581.440577550962;6615.66921653925;6159.322474527888;6242.906356404566;6247.656378899204;6249.375062493714;6250.687465626609;4572.45130584332;4588.839390621446;4607.677462577587;4643.512431194811;4687.08601822655;4674.11191873543;4698.3657206278085;4735.408073990751;4813.326134341265;4828.155072862165 13:11:59 INFO - PROCESS | 1679 | |4;prototype.html;291.4767991455336;295.55223835888626;306.5539639824056;306.5861087531832;307.25797199762576;4683.625309975202;4723.385959825227;4727.8108875644975;4766.189747742879;4786.56920877121;4457.1977044132045;4565;4584.7478388688605;4604.76976151192;4688.367070445497;3597.370460169473;3642.5446819147605;3642.6903713184347;3669.1377526281303;3694.2426802505556;3686.520752302197;3698.445233215026;3701.703863690912;3713.7214708896804;3731.3097077040834;3617.385044542434;3675.411934090546;3705.8332375043187;3720.5535335759746;3723.8324275407535;3697.815109244527;3706.7590606610484;3713.405855063204;3716.4053751399647;3724.5344331958504;3283.868645254211;3285.195127193853;3298.1424829544253;3302.058913209724;3314.635390107086;4612.846788302924;4619.620895238954;4619.722816631013;4622.537746225385;4632.702843203874;4058.6753059755147;4224.408582798411;4228.112096459748;4239.448871646666;4248.702590818644;4918.729469879156;4921.089598424303;4925.079219104552;4927.260910863363;4933.827316043921;3594.2272411431404;3599.5140656011367;3601.729870259741;3608.657177568127;3609.3864043112735;4805.231163013936;5130.384353877521;5135.871603209912;5143.974280128613;5166.328377310925;3550.8934731958084;3604.9639503605154;3606.85572577094;3613.512175856278;3616.1321282891918;3663.5420572428447;3665.5887483319116;3672.192117734094;3690.6678398944223;3693.1874987502706;4181.968073146944;4193.874183774492;4214.620684138381;4214.768187749703;4218.367244913287;4747.216709243005;4901.705897646081;4921.901561968741;4962.875928101754;4975.353204083446;1239.0892693869998;1253.1666441816271;1258.5343422933572;1259.8425196850394;1260.4328052376468;806.9556174410346;812.3338862133112;845.9425717852685;863.6502216602286;879.1252703559999;4369.497507786582;4377.890552736207;4391.516933137353;4398.296272596369;4452.265376212953;4936.284238785356;5021.748912554358;5042.445331013586;5055.3428054353435;5066.341375621146;4221.366794980716;4374.900047976989;4391.692581519327;4402.6037656610415;4422.977885110554;2671.3054605802245;2675.9732402676113;2681.5441374966304;2681.8793154308105;2693.878775455109;4789.257665061921;4810.63920205986;4813.807447702123;4822.590079843182;4843.418789745253;4966.925496117561;5128.923066153936;5151.175811870083;5153.598624907618;5185.481451854785;4870.09903167915;4875.853724388274;4887.266909963463;4900.43186180426;4910.189818680021;5119.5648369887485;5136.229565565195;5140.532544378644;5151.665141765773;5165.070287348313;4840.322354870392;4989.550940415234;5025.748712564284;5053.671511351898;5059.696418214919;4879.853604391874;4897.485763994871;4903.8528844134735;4904.166291730486;4923.384576927884;3637.418013117888;3667.9266414671024;3673.632636736305;3698.130939229333;3699.186179040607;4905.828296009622;5134.666246693953;5188.714620695898;5213.13983192769;5215.243789650403;4967.751612419437;4982.950170498394;4987.678265259781;4989.800407983786;4990;4985.426675932169;4998.375203099613;5000.574836171673;5014.84955451337;5018.899622007612;4792.7124372537755;4889.975550122226;4933;4934.654574179773;4958.652894297509;4785.545373189541;4855.053264613366;4971.428285747185;4973.776180071833;5032.421271553671;4815.927761083657;4820.662553621353;4844.757762111951;4845.394325709286;4855.562999330077 13:11:59 INFO - PROCESS | 1679 | |5;yui.html;599.3257585216631;612.9570930034894;624.6782906802996;705.1115594351116;730.784418596514;12584.119111662187;13357.933210333958;13385.39765710543;13416.127951683146;13417.932910335434;11589.42052897356;11665.825012624817;11701.7659646807;11704.824427633592;11740.236884602495;624.5721680648747;739.6375775869825;749.494091488246;765.7894079128256;770.0759089093083;765.60188701875;767.808047988003;767.8349154931689;768.6617888129233;768.8116411479167;802.8474589827944;804.7424824056304;807.0436532708759;807.588130053671;807.6284908941893;651.0884761334123;784.7920301120208;800.5836964778312;810.614957895001;813.6175997281268;591.4204080001623;591.8845825064114;595.0152497616451;595.9332794298201;596.2933923300902;11721.29672219661;11722.94138529302;11737.354445505494;11772.587959421464;11798.351090690008;11964.70088247792;12180.330081845495;12245.93877030618;12683.873161268453;12866.228026318357;11785;11926.582569610022;12048.578299759554;12065.939670301681;12713.42789574462;3977.801109944491;3999.6400323970984;4054.493188351456;4190.476190476191;4198.685098617585;65032;65275.3472465274;65672.3432765671;65857.67071164661;65951.67024164849;9862.753431164136;9982.650607228712;9983.400995940267;10160.187185025181;10180.694579162637;20035.39893803188;20046.49883752918;20046.599068018557;20051.29820456277;20054.89972550128;6433.485321174295;6595.868082638321;6706.5640733352175;6875.312468753084;6900.861982760317;3753.474513568103;3796.145867179918;3826.9234615307537;3870.07118291608;3879.282332768447;2846.957295640567;3003.759699224057;3005.3087789808465;3006.428778532072;3007.578938948549;472.1548428313349;479.7361451201825;488.4260993332891;489.2734289579971;495.1112752609075;427.76472939883564;542.5551048140487;550.5595523581119;602.220124938206;617.1668247865346;7505.324520793046;7904.802379940433;7905;8283.337333013344;8754.781130471662;494.90437314596966;544.314164153162;547.9917801232984;559.82085732566;620.9006558950546;3797.2595343907674;3819.3316169670197;3887.2614203301846;3960.1683646433994;4023.4769479968004;103925.48037259765;106546.35438798179;107439.46280268549;108841;111318;91652;91873.54063229775;92950;93171.53414233022;93492.53253733824;49065.509344906095;80140.19859801327;81312.40942568505;83919.58040209759;84014.57992709997;7637.198094200029;7781.416393770377;7974.8006299840645;7981.561014144278;8036.100759727979;44227;45001.77499112483;45332.093358133316;45749.31376029429;45854;53909.46090539044;55026;55890.72054639863;59937.70031149816;60390;10861.45692715377;11034.710215177272;11063.502142403771;11274.943625282149;11376.54493820238;12197.78412404125;12363.196392234477;12658.87341126577;12763.425645845773;12764.936175319064;8158.510489370657;10897.291676041032;10970.780584388109;11234.719132021764;11565.737589396973;11399.715007124556;11433.428328583372;12750.362481875683;12751.426185821474;12758.48966041348;11193.328400296008;11218.775624487627;11724;12129.454174562343;12740.108192426442;9819.312648114563;10440.216983726403;10649.627263045757;10829.350238985686;11006.779864402828;9005.954970225106;10089.848652270075;10121.493925303852;10152.695419137437;10237.129843963048 13:11:59 INFO - PROCESS | 1679 | __end_tp_report 13:11:59 INFO - PROCESS | 1679 | __start_cc_report 13:11:59 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1010 13:11:59 INFO - PROCESS | 1679 | __end_cc_report 13:11:59 INFO - PROCESS | 1679 | __startTimestamp1471551119318__endTimestamp 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | ------- Summary: start ------- 13:11:59 INFO - PROCESS | 1679 | Number of tests: 6 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:4584.46 Median:4728.81 stddev:469.36 (9.9%) stddev-sans-first:442.83 13:11:59 INFO - PROCESS | 1679 | Values: 2549.9 2590.7 2601.0 2606.9 2608.1 4529.3 4622.1 4656.8 4701.0 4705.0 4511.8 4572.1 4586.0 4611.1 4674.8 4200.6 4224.4 4290.9 4336.2 4396.7 4353.9 4368.8 4410.0 4423.8 4429.2 4198.7 4245.2 4279.2 4279.4 4357.0 4259.6 4272.9 4299.5 4302.4 4315.5 4257.4 4307.5 4323.3 4330.5 4376.8 4536.9 4734.3 4761.4 4764.6 4792.9 4861.9 4915.4 4923.2 4966.3 4967.0 4914.5 4954.7 4988.1 5005.0 5013.8 4534.1 4578.2 4631.7 4666.5 4672.3 4973.4 5003.0 5033.9 5048.1 5061.8 4813.8 4820.3 4859.2 4864.0 4868.5 4799.1 4856.7 4900.2 4930.2 4940.1 4844.6 4888.5 4918.2 4942.6 4944.5 4883.1 4897.0 4897.5 4900.9 4937.7 4083.9 4114.6 4172.1 4178.8 4220.1 3603.9 3645.0 3647.4 3682.7 3746.7 4316.1 4322.9 4324.6 4325.7 4376.4 4835.1 4963.6 4966.0 4969.4 4996.8 4281.8 4308.1 4329.2 4348.7 4379.0 4443.8 4449.6 4461.7 4464.2 4514.2 4560.5 4721.4 4735.8 4736.7 4759.1 4869.6 4924.6 4932.8 4936.5 4997.2 4671.3 4690.1 4700.5 4702.6 4741.2 4722.0 4836.2 4879.9 4883.9 4884.9 4909.4 4957.5 4972.1 4994.1 5047.7 4837.0 4847.6 4848.2 4865.3 4896.9 4620.2 4815.0 4858.0 4866.6 4900.3 4694.4 4736.4 4751.7 4801.1 4802.7 4894.0 4895.8 4900.5 4932.2 4935.3 4604.7 4727.6 4728.8 4729.2 4730.8 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:44960.21 Median:36851.32 stddev:81362.40 (220.8%) stddev-sans-first:81522.35 13:11:59 INFO - PROCESS | 1679 | Values: 561.3 564.9 578.2 579.8 589.0 28943.6 31763.0 31882.2 40841.4 42186.0 40584.8 41040.2 41045.4 41092.6 41241.6 7636.4 7758.3 7774.8 7779.0 7782.9 7530.9 7605.6 7610.4 7611.1 7611.4 7628.4 7661.3 7667.1 7672.7 7850.6 7589.8 7621.3 7624.6 7628.8 7629.4 7613.2 7661.0 7673.8 7676.4 7683.2 37460.0 37949.2 37979.2 37997.0 38034.0 3050.0 3167.1 3231.0 3316.9 3374.6 28932.4 29067.7 29659.6 30248.5 30269.8 3180.2 3205.9 3218.8 3220.9 3279.9 251184.0 252484.0 253427.0 253728.0 254027.0 31774.0 51410.7 51618.0 51684.7 51746.2 32297.5 33752.0 33791.7 33804.8 33817.8 12600.6 12676.6 12727.0 12740.7 12747.2 9885.3 9932.3 9935.4 9935.5 9941.8 7700.9 7754.8 7778.3 7817.8 7836.0 2974.5 3031.1 3032.3 3058.7 3115.1 823.8 859.2 904.8 924.4 941.9 27107.5 27790.9 27981.4 28078.6 28214.3 901.7 956.6 1008.1 1014.7 1052.3 14569.2 14613.9 14644.9 14729.1 14861.8 373590.0 374950.0 375411.0 375926.0 378277.0 48382.5 48930.8 49012.8 49060.0 49116.5 1043.8 1102.6 1110.8 1134.7 1173.1 27189.7 28712.6 29282.3 29671.9 29759.7 41369.0 42059.4 42090.4 42192.6 42228.8 282056.0 284235.0 285127.0 285456.0 286616.0 22271.0 22888.3 23388.0 25514.6 25896.7 36118.3 41537.0 41715.9 41985.4 43295.4 36239.8 37058.8 37511.0 40654.4 41564.6 36261.3 36369.5 36499.0 36535.3 36643.8 35709.1 35962.3 39491.8 39742.8 40138.4 29941.0 32195.2 33653.7 33760.8 33904.0 24556.9 25468.1 25503.4 25865.6 26062.6 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:23366.05 Median:3932.06 stddev:57605.19 (1465.0%) stddev-sans-first:57740.90 13:11:59 INFO - PROCESS | 1679 | Values: 366.6 366.6 368.9 380.0 390.9 16108.6 16651.9 17373.7 17473.9 17500.7 15393.7 15809.8 16139.5 16244.6 16275.0 4986.8 5243.3 5243.5 5243.7 5250.0 3746.6 3908.7 3930.8 3933.4 5186.4 6039.8 6117.4 6147.1 6147.7 6151.7 5978.2 6059.3 6079.4 6096.1 6120.5 5178.7 5345.8 5350.8 5352.5 5364.7 21041.0 21231.9 21467.7 21472.5 21474.8 1896.0 1916.5 2003.9 2007.8 2013.6 13474.3 13502.7 13626.3 13734.5 14239.2 1699.4 1707.8 1728.3 1766.4 1800.3 43527.6 64615.7 64979.0 65294.7 65579.0 9157.8 9280.7 9475.7 9728.1 9867.3 13154.1 13242.0 13284.9 13414.1 13426.9 7068.9 7470.1 7505.0 7611.7 7659.5 7147.6 7160.1 7329.6 7356.0 7380.9 5968.0 6042.4 6110.6 6124.0 6183.7 1610.5 1702.7 1728.6 1730.0 1761.9 645.7 760.7 781.3 816.7 894.8 18504.9 18804.5 19346.4 19394.9 19549.5 803.6 815.3 817.3 819.4 836.5 10040.3 10937.2 10999.6 11022.4 11043.8 335554.0 338999.0 352439.0 353412.0 356512.0 77734.0 78685.0 79302.0 79394.2 81407.0 915.5 921.9 927.3 932.8 936.6 16331.6 16574.3 17053.1 17170.4 17666.7 38420.0 38911.6 40183.0 40256.8 40813.4 52544.0 53129.5 53336.7 53891.5 55314.4 6415.3 6739.6 6789.8 7021.8 7083.4 8681.0 11227.4 11374.7 12282.1 12552.9 6478.9 7843.1 10368.3 10720.6 10845.5 10410.9 10532.7 10539.9 10815.0 10908.6 10549.7 10676.5 10805.5 10825.6 11128.3 7423.8 7552.1 7735.0 7927.8 7948.1 9927.8 10171.1 10173.9 10196.9 10379.2 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5137.58 Median:4964.40 stddev:2934.72 (59.1%) stddev-sans-first:2929.13 13:11:59 INFO - PROCESS | 1679 | Values: 1347.1 1371.8 1412.8 1620.6 1637.4 7469.7 8045.2 8052.6 8058.6 8062.6 6799.9 7448.9 7717.0 7719.3 7873.2 2186.2 2215.1 2216.3 2220.8 2221.1 2150.2 2153.9 2215.8 2217.6 2221.1 2164.9 2170.4 2175.2 2179.4 2222.5 2157.0 2160.2 2163.9 2164.4 2173.5 2132.2 2165.0 2172.6 2173.6 2176.2 7776.7 7949.2 7951.1 7962.6 7987.3 4426.5 4597.8 4606.1 4618.3 4625.7 2762.5 2839.5 2893.1 2894.9 2909.7 844.8 868.1 885.1 891.6 892.7 10811.4 10817.9 10860.1 10925.2 10929.4 3983.8 4143.8 4242.4 4328.5 4329.1 9268.8 9271.3 9271.3 9271.4 9273.9 4538.5 4557.0 4565.2 4565.3 4565.3 3618.4 3909.3 4116.8 4141.8 4168.5 3534.9 3612.9 3705.2 3747.3 3770.4 1168.4 1196.4 1200.6 1209.7 1216.9 795.4 801.3 809.6 815.9 842.1 4908.0 5020.8 5048.6 5054.4 5111.6 406.1 408.2 411.5 411.8 414.4 3470.1 3504.5 3556.4 3597.5 3600.4 9512.7 9653.8 9772.3 9776.4 9797.1 9698.4 9704.0 9731.7 9735.5 9752.0 7099.0 7317.3 7381.4 7390.4 7403.0 5157.0 5341.2 5420.4 5487.3 5726.4 9009.6 9031.7 9038.8 9051.2 9069.8 8761.8 9308.1 9317.8 9327.2 9333.7 6068.2 6563.3 6857.5 7004.3 7015.7 7267.6 7488.4 7519.1 7539.1 7555.9 6360.2 6574.2 6575.5 6695.5 6766.8 6442.8 6458.7 6493.7 6581.4 6615.7 6159.3 6242.9 6247.7 6249.4 6250.7 4572.5 4588.8 4607.7 4643.5 4687.1 4674.1 4698.4 4735.4 4813.3 4828.2 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:4121.03 Median:4705.88 stddev:1191.87 (25.3%) stddev-sans-first:1160.04 13:11:59 INFO - PROCESS | 1679 | Values: 291.5 295.6 306.6 306.6 307.3 4683.6 4723.4 4727.8 4766.2 4786.6 4457.2 4565.0 4584.7 4604.8 4688.4 3597.4 3642.5 3642.7 3669.1 3694.2 3686.5 3698.4 3701.7 3713.7 3731.3 3617.4 3675.4 3705.8 3720.6 3723.8 3697.8 3706.8 3713.4 3716.4 3724.5 3283.9 3285.2 3298.1 3302.1 3314.6 4612.8 4619.6 4619.7 4622.5 4632.7 4058.7 4224.4 4228.1 4239.4 4248.7 4918.7 4921.1 4925.1 4927.3 4933.8 3594.2 3599.5 3601.7 3608.7 3609.4 4805.2 5130.4 5135.9 5144.0 5166.3 3550.9 3605.0 3606.9 3613.5 3616.1 3663.5 3665.6 3672.2 3690.7 3693.2 4182.0 4193.9 4214.6 4214.8 4218.4 4747.2 4901.7 4921.9 4962.9 4975.4 1239.1 1253.2 1258.5 1259.8 1260.4 807.0 812.3 845.9 863.7 879.1 4369.5 4377.9 4391.5 4398.3 4452.3 4936.3 5021.7 5042.4 5055.3 5066.3 4221.4 4374.9 4391.7 4402.6 4423.0 2671.3 2676.0 2681.5 2681.9 2693.9 4789.3 4810.6 4813.8 4822.6 4843.4 4966.9 5128.9 5151.2 5153.6 5185.5 4870.1 4875.9 4887.3 4900.4 4910.2 5119.6 5136.2 5140.5 5151.7 5165.1 4840.3 4989.6 5025.7 5053.7 5059.7 4879.9 4897.5 4903.9 4904.2 4923.4 3637.4 3667.9 3673.6 3698.1 3699.2 4905.8 5134.7 5188.7 5213.1 5215.2 4967.8 4983.0 4987.7 4989.8 4990.0 4985.4 4998.4 5000.6 5014.8 5018.9 4792.7 4890.0 4933.0 4934.7 4958.7 4785.5 4855.1 4971.4 4973.8 5032.4 4815.9 4820.7 4844.8 4845.4 4855.6 13:11:59 INFO - PROCESS | 1679 | 13:11:59 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:18251.91 Median:44614.39 stddev:26982.81 (60.5%) stddev-sans-first:27025.95 13:11:59 INFO - PROCESS | 1679 | Values: 599.3 613.0 624.7 705.1 730.8 12584.1 13357.9 13385.4 13416.1 13417.9 11589.4 11665.8 11701.8 11704.8 11740.2 624.6 739.6 749.5 765.8 770.1 765.6 767.8 767.8 768.7 768.8 802.8 804.7 807.0 807.6 807.6 651.1 784.8 800.6 810.6 813.6 591.4 591.9 595.0 595.9 596.3 11721.3 11722.9 11737.4 11772.6 11798.4 11964.7 12180.3 12245.9 12683.9 12866.2 11785.0 11926.6 12048.6 12065.9 12713.4 3977.8 3999.6 4054.5 4190.5 4198.7 65032.0 65275.3 65672.3 65857.7 65951.7 9862.8 9982.7 9983.4 10160.2 10180.7 20035.4 20046.5 20046.6 20051.3 20054.9 6433.5 6595.9 6706.6 6875.3 6900.9 3753.5 3796.1 3826.9 3870.1 3879.3 2847.0 3003.8 3005.3 3006.4 3007.6 472.2 479.7 488.4 489.3 495.1 427.8 542.6 550.6 602.2 617.2 7505.3 7904.8 7905.0 8283.3 8754.8 494.9 544.3 548.0 559.8 620.9 3797.3 3819.3 3887.3 3960.2 4023.5 103925.5 106546.4 107439.5 108841.0 111318.0 91652.0 91873.5 92950.0 93171.5 93492.5 49065.5 80140.2 81312.4 83919.6 84014.6 7637.2 7781.4 7974.8 7981.6 8036.1 44227.0 45001.8 45332.1 45749.3 45854.0 53909.5 55026.0 55890.7 59937.7 60390.0 10861.5 11034.7 11063.5 11274.9 11376.5 12197.8 12363.2 12658.9 12763.4 12764.9 8158.5 10897.3 10970.8 11234.7 11565.7 11399.7 11433.4 12750.4 12751.4 12758.5 11193.3 11218.8 11724.0 12129.5 12740.1 9819.3 10440.2 10649.6 10829.4 11006.8 9006.0 10089.8 10121.5 10152.7 10237.1 13:11:59 INFO - PROCESS | 1679 | -------- Summary: end -------- 13:11:59 INFO - PROCESS | 1679 | 13:12:00 INFO - TEST-INFO | 1679: exit 0 13:12:00 INFO - TEST-OK | dromaeo_css | took 1119769ms 13:12:00 INFO - TEST-START | kraken 13:12:00 INFO - operating with platform_type : linux_ 13:12:00 INFO - Initialising browser for kraken test... 13:12:00 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMV81qc/profile http://localhost:54201/getInfo.html) 13:12:04 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 13:12:04 INFO - PROCESS | 1993 | colorDepth:24 13:12:04 INFO - PROCESS | 1993 | Browser inner width/height: 1024/697 13:12:04 INFO - PROCESS | 1993 | __metrics 13:12:04 INFO - PROCESS | 1993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:12:04 INFO - PROCESS | 1993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:05 INFO - PROCESS | 1993 | console.error: PushService: 13:12:05 INFO - PROCESS | 1993 | stateChangeProcessEnqueue: Error transitioning state 13:12:05 INFO - PROCESS | 1993 | UnknownError 13:12:05 INFO - TEST-INFO | 1993: exit 0 13:12:05 INFO - Browser initialized. 13:12:05 INFO - Running cycle 1/1 for kraken test... 13:12:05 INFO - TEST-INFO | started process 2075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMV81qc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:17 INFO - PROCESS | 2075 | RSS: Main: 157466624 13:12:17 INFO - PROCESS | 2075 | 13:12:20 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54201/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:21 INFO - PROCESS | 2075 | RSS: Main: 204513280 13:12:21 INFO - PROCESS | 2075 | 13:12:24 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54201/tests/kraken/driver.html?testName=audio-dft) 13:12:24 INFO - PROCESS | 2075 | RSS: Main: 196677632 13:12:24 INFO - PROCESS | 2075 | 13:12:28 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54201/tests/kraken/driver.html?testName=audio-fft) 13:12:28 INFO - PROCESS | 2075 | RSS: Main: 277716992 13:12:28 INFO - PROCESS | 2075 | 13:12:30 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54201/tests/kraken/driver.html?testName=audio-oscillator) 13:12:31 INFO - PROCESS | 2075 | RSS: Main: 187580416 13:12:31 INFO - PROCESS | 2075 | 13:12:33 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:34 INFO - PROCESS | 2075 | RSS: Main: 192544768 13:12:34 INFO - PROCESS | 2075 | 13:12:37 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54201/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:38 INFO - PROCESS | 2075 | RSS: Main: 228433920 13:12:38 INFO - PROCESS | 2075 | 13:12:41 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54201/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:42 INFO - PROCESS | 2075 | RSS: Main: 222351360 13:12:42 INFO - PROCESS | 2075 | 13:12:45 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54201/tests/kraken/driver.html?testName=json-parse-financial) 13:12:45 INFO - PROCESS | 2075 | RSS: Main: 225566720 13:12:45 INFO - PROCESS | 2075 | 13:12:47 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:48 INFO - PROCESS | 2075 | RSS: Main: 189214720 13:12:48 INFO - PROCESS | 2075 | 13:12:50 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:50 INFO - PROCESS | 2075 | RSS: Main: 196534272 13:12:50 INFO - PROCESS | 2075 | 13:12:52 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:53 INFO - PROCESS | 2075 | RSS: Main: 193896448 13:12:53 INFO - PROCESS | 2075 | 13:12:56 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:57 INFO - PROCESS | 2075 | RSS: Main: 189005824 13:12:57 INFO - PROCESS | 2075 | 13:12:59 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:00 INFO - PROCESS | 2075 | RSS: Main: 191582208 13:13:00 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | Cycle 1(1): loaded http://localhost:54201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54201/tests/kraken/driver.html?testName=ai-astar) 13:13:02 INFO - PROCESS | 2075 | RSS: Main: 243220480 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | __start_tp_report 13:13:02 INFO - PROCESS | 2075 | _x_x_mozilla_page_load 13:13:02 INFO - PROCESS | 2075 | _x_x_mozilla_page_load_details 13:13:02 INFO - PROCESS | 2075 | |i|pagename|runs| 13:13:02 INFO - PROCESS | 2075 | |0;ai-astar;107;113;116;116;110;115;115;114;114;115 13:13:02 INFO - PROCESS | 2075 | |1;audio-beat-detection;151;121;126;191;129;124;154;121;186;122 13:13:02 INFO - PROCESS | 2075 | |2;audio-dft;162;162;162;162;160;162;162;163;161;161 13:13:02 INFO - PROCESS | 2075 | |3;audio-fft;76;77;76;112;75;77;76;76;99;75 13:13:02 INFO - PROCESS | 2075 | |4;audio-oscillator;87;86;124;86;86;86;114;86;85;143 13:13:02 INFO - PROCESS | 2075 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 13:13:02 INFO - PROCESS | 2075 | |6;imaging-darkroom;147;147;147;146;146;145;146;146;146;146 13:13:02 INFO - PROCESS | 2075 | |7;imaging-desaturate;95;95;95;95;97;95;94;95;95;95 13:13:02 INFO - PROCESS | 2075 | |8;json-parse-financial;66;65;67;64;66;67;64;64;67;66 13:13:02 INFO - PROCESS | 2075 | |9;json-stringify-tinderbox;66;65;66;67;65;66;66;66;65;65 13:13:02 INFO - PROCESS | 2075 | |10;stanford-crypto-aes;84;82;83;83;84;83;82;82;82;83 13:13:02 INFO - PROCESS | 2075 | |11;stanford-crypto-ccm;130;133;141;141;131;129;131;133;156;136 13:13:02 INFO - PROCESS | 2075 | |12;stanford-crypto-pbkdf2;176;176;169;170;170;169;170;171;170;170 13:13:02 INFO - PROCESS | 2075 | |13;stanford-crypto-sha256-iterative;71;74;69;67;68;68;69;68;67;68 13:13:02 INFO - PROCESS | 2075 | __end_tp_report 13:13:02 INFO - PROCESS | 2075 | __start_cc_report 13:13:02 INFO - PROCESS | 2075 | _x_x_mozilla_cycle_collect,1956 13:13:02 INFO - PROCESS | 2075 | __end_cc_report 13:13:02 INFO - PROCESS | 2075 | __startTimestamp1471551182594__endTimestamp 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | ------- Summary: start ------- 13:13:02 INFO - PROCESS | 2075 | Number of tests: 14 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:2.88 (2.5%) stddev-sans-first:1.86 13:13:02 INFO - PROCESS | 2075 | Values: 107.0 113.0 116.0 116.0 110.0 115.0 115.0 114.0 114.0 115.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:140.00 stddev:27.06 (19.3%) stddev-sans-first:28.53 13:13:02 INFO - PROCESS | 2075 | Values: 151.0 121.0 126.0 191.0 129.0 124.0 154.0 121.0 186.0 122.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 13:13:02 INFO - PROCESS | 2075 | Values: 162.0 162.0 162.0 162.0 160.0 162.0 162.0 163.0 161.0 161.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.83 (16.9%) stddev-sans-first:13.43 13:13:02 INFO - PROCESS | 2075 | Values: 76.0 77.0 76.0 112.0 75.0 77.0 76.0 76.0 99.0 75.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.00 stddev:20.99 (24.4%) stddev-sans-first:21.86 13:13:02 INFO - PROCESS | 2075 | Values: 87.0 86.0 124.0 86.0 86.0 86.0 114.0 86.0 85.0 143.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:13:02 INFO - PROCESS | 2075 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:13:02 INFO - PROCESS | 2075 | Values: 147.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 13:13:02 INFO - PROCESS | 2075 | Values: 95.0 95.0 95.0 95.0 97.0 95.0 94.0 95.0 95.0 95.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 13:13:02 INFO - PROCESS | 2075 | Values: 66.0 65.0 67.0 64.0 66.0 67.0 64.0 64.0 67.0 66.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 13:13:02 INFO - PROCESS | 2075 | Values: 66.0 65.0 66.0 67.0 65.0 66.0 66.0 66.0 65.0 65.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 13:13:02 INFO - PROCESS | 2075 | Values: 84.0 82.0 83.0 83.0 84.0 83.0 82.0 82.0 82.0 83.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:134.50 stddev:8.18 (6.1%) stddev-sans-first:8.38 13:13:02 INFO - PROCESS | 2075 | Values: 130.0 133.0 141.0 141.0 131.0 129.0 131.0 133.0 156.0 136.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:170.00 stddev:2.64 (1.6%) stddev-sans-first:2.13 13:13:02 INFO - PROCESS | 2075 | Values: 176.0 176.0 169.0 170.0 170.0 169.0 170.0 171.0 170.0 170.0 13:13:02 INFO - PROCESS | 2075 | 13:13:02 INFO - PROCESS | 2075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.13 (3.1%) stddev-sans-first:2.12 13:13:02 INFO - PROCESS | 2075 | Values: 71.0 74.0 69.0 67.0 68.0 68.0 69.0 68.0 67.0 68.0 13:13:02 INFO - PROCESS | 2075 | -------- Summary: end -------- 13:13:02 INFO - PROCESS | 2075 | 13:13:03 INFO - TEST-INFO | 2075: exit 0 13:13:03 INFO - TEST-OK | kraken | took 63666ms 13:13:03 INFO - SUITE-END | took 1183s 13:13:04 INFO - Completed test suite (00:19:43) 13:13:04 INFO - javascript benchmark 13:13:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2549.8980040798365, 2590.6502622146004, 2600.9869950650245, 2606.869656517175, 2608.1002054291275, 4529.297958816381, 4622.0524792417555, 4656.7671616419175, 4700.976495117524, 4704.952950470494, 4511.819527218916, 4572.131295053938, 4585.977070114644, 4611.146937816507, 4674.789634466449, 4200.642945349649, 4224.408582798395, 4290.935635965463, 4336.241157797373, 4396.670249731267, 4353.891152721191, 4368.781560921957, 4410.007748256633, 4423.823047078129, 4429.180601588717, 4198.727082739612, 4245.150969806051, 4279.2083464559155, 4279.422277992462, 4357.0, 4259.595338442843, 4272.850450234227, 4299.50555686097, 4302.440682711259, 4315.503717072545, 4257.425247591566, 4307.504636966758, 4323.329883868006, 4330.501992270866, 4376.846810361654, 4536.909261814745, 4734.313524538957, 4761.381020467352, 4764.595009424203, 4792.9281060784115, 4861.927071093936, 4915.410150781893, 4923.212286034253, 4966.279889416014, 4966.975165124188, 4914.508549145057, 4954.702717836942, 4988.052270068712, 5005.02402031604, 5013.824516141917, 4534.115847409789, 4578.221702310615, 4631.675782695246, 4666.510016448292, 4672.275797251432, 4973.35346404965, 5002.974985125051, 5033.874153146201, 5048.066107770001, 5061.797528098835, 4813.831515896927, 4820.301056346881, 4859.22252439615, 4863.975680121577, 4868.464468908417, 4799.088173247072, 4856.732879691651, 4900.215965445512, 4930.2358134488495, 4940.061388336205, 4844.636652251095, 4888.511148885154, 4918.213085906238, 4942.579880710108, 4944.480829512921, 4883.145449546315, 4896.996115796253, 4897.534382356585, 4900.926486102711, 4937.703737775673, 4083.8774836754947, 4114.5679703630685, 4172.061286210578, 4178.770167640809, 4220.092680073737, 3603.94594081089, 3644.9976256529135, 3647.379945409287, 3682.6869716073898, 3746.6815320698047, 4316.093620339764, 4322.8703138905885, 4324.589164029412, 4325.697201195949, 4376.409184760017, 4835.081334546425, 4963.553280204799, 4966.03162383339, 4969.403671559436, 4996.7501624918605, 4281.764502952367, 4308.073764140725, 4329.220740266782, 4348.695591308641, 4378.978105109454, 4443.777811109431, 4449.599536041772, 4461.732296062247, 4464.15181115587, 4514.210013247669, 4560.452745670408, 4721.433427988663, 4735.810567577259, 4736.715797052119, 4759.119562880809, 4869.586085182657, 4924.606031517398, 4932.753362331798, 4936.4569897311985, 4997.225430058346, 4671.322658214608, 4690.061987602425, 4700.482946875909, 4702.576768090888, 4741.170295198395, 4721.952780472151, 4836.177849765478, 4879.926801097916, 4883.853484395474, 4884.926726099183, 4909.361782968192, 4957.4794646561595, 4972.055309491185, 4994.126027945168, 5047.722375269395, 4836.975815120902, 4847.612191024639, 4848.24281150171, 4865.318855360181, 4896.853094407174, 4620.237660785932, 4815.012922350979, 4858.004109157685, 4866.586340161126, 4900.313956046085, 4694.389729335165, 4736.407949006374, 4751.691140075884, 4801.135795556834, 4802.727277271456, 4893.975530122327, 4895.8041678332465, 4900.460949295503, 4932.161532539549, 4935.309056732132, 4604.723716577016, 4727.550882666142, 4728.810847566059, 4729.219678753105, 4730.787114579921], "value": 4554.897278767246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2703485468891, 564.9180868774026, 578.1847594891204, 579.7941730685609, 588.9663640311255, 28943.565846512294, 31763.04710858675, 31882.20294492639, 40841.387379189335, 42186.0, 40584.797076014576, 41040.17919641613, 41045.38431923516, 41092.58907410925, 41241.58758412415, 7636.427267954912, 7758.301752842243, 7774.805629859242, 7779.0, 7782.883256751154, 7530.924690753077, 7605.581693006882, 7610.39116870649, 7611.124720657112, 7611.353034992005, 7628.389728821709, 7661.3487853532515, 7667.118281397655, 7672.731454399097, 7850.568218747967, 7589.848203035936, 7621.31408173267, 7624.618769061524, 7628.771136865847, 7629.389648828108, 7613.200613935513, 7661.0, 7673.808154796119, 7676.424268179909, 7683.1548529661695, 37460.0, 37949.24101517954, 37979.24041519154, 37997.0, 38034.0, 3049.9542506862413, 3167.081546351555, 3230.96769032309, 3316.9220003498717, 3374.645662205482, 28932.421351573063, 29067.70932290671, 29659.55510667342, 30248.54627180594, 30269.848650756827, 3180.204948762809, 3205.9198520036953, 3218.839058047088, 3220.91947701307, 3279.8688052477873, 251184.0, 252483.99999999817, 253427.0, 253728.0, 254027.0, 31774.0, 51410.742946285776, 51618.0, 51684.74157629263, 51746.22380664293, 32297.51553726696, 33752.0, 33791.66208337934, 33804.83097584496, 33817.83091084529, 12600.558980435824, 12676.556320528738, 12727.045471589669, 12740.681482962815, 12747.171433856769, 9885.25860560461, 9932.255080868963, 9935.403875767477, 9935.503224838729, 9941.80116397668, 7700.884486732703, 7754.806129846799, 7778.338841198448, 7817.843643127219, 7835.960820195863, 2974.479466093425, 3031.060371284909, 3032.272254658866, 3058.6788387219467, 3115.12776422602, 823.7775800533823, 859.1580251353708, 904.7738065483629, 924.3991405586422, 941.9011003844635, 27107.45785084287, 27790.86104569464, 27981.40994448829, 28078.578821317697, 28214.29464263369, 901.6753968571309, 956.5695437053354, 1008.0977525114981, 1014.6955913226003, 1052.321252791945, 14569.198694071716, 14613.853861461463, 14644.853551464348, 14729.116253024853, 14861.777073343908, 373590.0, 374950.0, 375411.0, 375926.0, 378277.0, 48382.5161748378, 48930.75534622304, 49012.754936225094, 49060.0, 49116.50883491119, 1043.796459690353, 1102.6416414665105, 1110.7667389848223, 1134.6539305511567, 1173.1494666366816, 27189.72810271951, 28712.569311459927, 29282.267943301587, 29671.851640741657, 29759.702402975694, 41369.0, 42059.369109463994, 42090.368644469745, 42192.578074218865, 42228.78885605552, 282056.0, 284235.0, 285127.0, 285456.0, 286616.0, 22271.0, 22888.31335059951, 23388.0, 25514.617280740433, 25896.727040038182, 36118.27763444769, 41537.0, 41715.882200878965, 41985.370219447344, 43295.350569742106, 36239.81880090583, 37058.8147059263, 37511.0, 40654.39018414785, 41564.58435415607, 36261.27477450489, 36369.454458183674, 36499.0, 36535.26929461343, 36643.81678091593, 35709.1072723184, 35962.28075438529, 39491.80254098826, 39742.80128599339, 40138.39792403058, 29941.0, 32195.195120122185, 33653.663463365054, 33760.831195843864, 33904.0, 24556.877215613807, 25468.108616198344, 25503.36241593975, 25865.612015820156, 26062.609060863724], "value": 16195.394069020744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.56195845964066, 366.5802655958927, 368.8745826419018, 379.98100094995243, 390.9452676625271, 16108.597285067879, 16651.916740416294, 17373.739393909087, 17473.864198827097, 17500.737488937644, 15393.69212615747, 15809.841901580981, 16139.515814525583, 16244.593885152877, 16275.0, 4986.800527978886, 5243.292155558989, 5243.475652434764, 5243.711595862226, 5250.0, 3746.6253374662588, 3908.687305015592, 3930.764154150746, 3933.3509970854775, 5186.377634683843, 6039.818805435822, 6117.44942955134, 6147.077938309245, 6147.7233524491285, 6151.72317245725, 5978.192943952554, 6059.303180134275, 6079.361667024965, 6096.055111457731, 6120.540959428016, 5178.689278643294, 5345.786168553253, 5350.785968561292, 5352.464753524655, 5364.7317634118135, 21041.0, 21231.893840530855, 21467.67798483024, 21472.463188420257, 21474.78525214759, 1896.0, 1916.5400303926958, 2003.889786061766, 2007.8114558118116, 2013.6375452418558, 13474.326283685874, 13502.729945401135, 13626.318684065856, 13734.45062197511, 14239.216843073627, 1699.3882202407124, 1707.8036025857061, 1728.2654871679485, 1766.381766381769, 1800.261892624031, 43527.56472435267, 64615.67692161556, 64979.0, 65294.673526633014, 65579.0, 9157.771055723528, 9280.72157835266, 9475.668351607661, 9728.075832795874, 9867.259955503223, 13154.144980576231, 13242.0, 13284.933575332061, 13414.12808167466, 13426.865731342561, 7068.893966590505, 7470.140933792574, 7505.0, 7611.695532178762, 7659.540427574363, 7147.6068816214565, 7160.10498687664, 7329.560226386434, 7356.0, 7380.926190738024, 5968.0, 6042.425969532887, 6110.633361998294, 6124.0, 6183.721732522047, 1610.5168449465114, 1702.7020271452693, 1728.6283449058262, 1730.0484733396581, 1761.8854774439621, 645.714824164208, 760.7147319755092, 781.316348195329, 816.6692489541745, 894.7584152278848, 18504.907475462536, 18804.529886752665, 19346.4196074118, 19394.903025485066, 19549.51126221856, 803.6263137641025, 815.2988429950238, 817.2889586060165, 819.4264015189391, 836.4981011393115, 10040.297179197387, 10937.234393592531, 10999.560017599366, 11022.409733712571, 11043.83434248487, 335554.0, 338999.0, 352439.0, 353412.0, 356512.0, 77734.0, 78685.0, 79302.0, 79394.20605793984, 81407.0, 915.4507295622707, 921.9354645174908, 927.2767241551601, 932.7807965128189, 936.5551363102472, 16331.59171020734, 16574.337026518806, 17053.147342632572, 17170.39903603368, 17666.734998975284, 38420.0, 38911.6108838908, 40183.0, 40256.798716007404, 40813.38779918244, 52544.0, 53129.46870531245, 53336.73331633317, 53891.46108538864, 55314.44685553254, 6415.332013676384, 6739.629320387426, 6789.830254243683, 7021.789346319619, 7083.362497375261, 8681.006736901096, 11227.395876155628, 11374.715632108933, 12282.07884408655, 12552.87447125517, 6478.935210647834, 7843.098043724816, 10368.326058806455, 10720.624778132727, 10845.457727113455, 10410.947945260225, 10532.736681583021, 10539.894601053891, 10815.0, 10908.61819836302, 10549.683509494727, 10676.46617669129, 10805.45972701346, 10825.56697732082, 11128.276662016942, 7423.814404639711, 7552.093748750185, 7734.961325193338, 7927.762167134995, 7948.0859701132795, 9927.801443970935, 10171.135453486537, 10173.898261017295, 10196.949015254877, 10379.169666426818], "value": 8342.427388654001, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.1109068015112, 1371.8422381426135, 1412.7527682655539, 1620.5624481390032, 1637.35324546804, 7469.701211951522, 8045.235702608257, 8052.557109358991, 8058.63736131874, 8062.596870156491, 6799.864002719943, 7448.851022979551, 7716.96141519293, 7719.266669666386, 7873.173316801739, 2186.1583290433177, 2215.091812356934, 2216.2575537195057, 2220.822334213267, 2221.1004543160047, 2150.204424362988, 2153.8923053847325, 2215.7784221577795, 2217.6008318502663, 2221.078252525208, 2164.891755412231, 2170.392290158758, 2175.216921908112, 2179.3570896585466, 2222.4666080140732, 2156.967645485319, 2160.2115227941845, 2163.935081947544, 2164.4264269968394, 2173.5326904715403, 2132.1897678882083, 2165.0473791531676, 2172.576347612216, 2173.6413491773997, 2176.1513009926143, 7776.65005074773, 7949.165337639581, 7951.085625153066, 7962.601869906482, 7987.321077708401, 4426.490953540352, 4597.839075632337, 4606.101810146989, 4618.307253911907, 4625.745583992879, 2762.4889395461705, 2839.488891999439, 2893.117599132264, 2894.942101157965, 2909.723576260252, 844.7719115838689, 868.1448772958631, 885.0927799006006, 891.5854127830526, 892.6964831957101, 10811.405372704497, 10817.945910270477, 10860.076893464066, 10925.235233533656, 10929.398883061429, 3983.7609743415487, 4143.81352839117, 4242.384854196124, 4328.5455027222315, 4329.134173165379, 9268.814623707623, 9271.258299336037, 9271.258299336172, 9271.443713377219, 9273.86089208649, 4538.478075021349, 4557.02024064821, 4565.223911934979, 4565.269556870885, 4565.292379681155, 3618.3848745713294, 3909.2963266612282, 4116.814743336557, 4141.79291035447, 4168.458100446983, 3534.929301413957, 3612.8554857805393, 3705.184859330943, 3747.2505498900327, 3770.3967365221433, 1168.3749194181073, 1196.4257156564724, 1200.5797970710182, 1209.7338585511172, 1216.853977522703, 795.3637090327715, 801.3308887079354, 809.5790189101634, 815.9061707903548, 842.0568962761746, 4907.975460122677, 5020.820107274788, 5048.5863958091795, 5054.444011158843, 5111.642185047085, 406.13898535105176, 408.244747217645, 411.4568769224655, 411.77352456149, 414.35567692238857, 3470.132466883279, 3504.5444092267844, 3556.448750443685, 3597.5143355647174, 3600.3879340512176, 9512.667056652985, 9653.758656033515, 9772.267079969031, 9776.364536305118, 9797.118259356692, 9698.418094914186, 9703.951480242695, 9731.659391921248, 9735.464549449707, 9751.951240243754, 7099.0, 7317.341439270491, 7381.372583330477, 7390.371818395389, 7403.037605111409, 5157.0, 5341.225522299323, 5420.4037555868035, 5487.314085739283, 5726.370099289158, 9009.594568244314, 9031.729048128567, 9038.819223615623, 9051.230645395215, 9069.818603628022, 8761.780955476164, 9308.115729005734, 9317.813643726951, 9327.207187389147, 9333.719988400358, 6068.150458935665, 6563.278039415756, 6857.5199736019995, 7004.264552222147, 7015.6842942066705, 7267.563946163247, 7488.400927925862, 7519.097708275042, 7539.132999704885, 7555.924440755742, 6360.236771587439, 6574.178227721535, 6575.5492868210285, 6695.531312808252, 6766.7969960901255, 6442.838929026624, 6458.741650333934, 6493.675316234264, 6581.440577550962, 6615.66921653925, 6159.322474527888, 6242.906356404566, 6247.656378899204, 6249.375062493714, 6250.687465626609, 4572.45130584332, 4588.839390621446, 4607.677462577587, 4643.512431194811, 4687.08601822655, 4674.11191873543, 4698.3657206278085, 4735.408073990751, 4813.326134341265, 4828.155072862165], "value": 4050.0279197750497, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.4767991455336, 295.55223835888626, 306.5539639824056, 306.5861087531832, 307.25797199762576, 4683.625309975202, 4723.385959825227, 4727.8108875644975, 4766.189747742879, 4786.56920877121, 4457.1977044132045, 4565.0, 4584.7478388688605, 4604.76976151192, 4688.367070445497, 3597.370460169473, 3642.5446819147605, 3642.6903713184347, 3669.1377526281303, 3694.2426802505556, 3686.520752302197, 3698.445233215026, 3701.703863690912, 3713.7214708896804, 3731.3097077040834, 3617.385044542434, 3675.411934090546, 3705.8332375043187, 3720.5535335759746, 3723.8324275407535, 3697.815109244527, 3706.7590606610484, 3713.405855063204, 3716.4053751399647, 3724.5344331958504, 3283.868645254211, 3285.195127193853, 3298.1424829544253, 3302.058913209724, 3314.635390107086, 4612.846788302924, 4619.620895238954, 4619.722816631013, 4622.537746225385, 4632.702843203874, 4058.6753059755147, 4224.408582798411, 4228.112096459748, 4239.448871646666, 4248.702590818644, 4918.729469879156, 4921.089598424303, 4925.079219104552, 4927.260910863363, 4933.827316043921, 3594.2272411431404, 3599.5140656011367, 3601.729870259741, 3608.657177568127, 3609.3864043112735, 4805.231163013936, 5130.384353877521, 5135.871603209912, 5143.974280128613, 5166.328377310925, 3550.8934731958084, 3604.9639503605154, 3606.85572577094, 3613.512175856278, 3616.1321282891918, 3663.5420572428447, 3665.5887483319116, 3672.192117734094, 3690.6678398944223, 3693.1874987502706, 4181.968073146944, 4193.874183774492, 4214.620684138381, 4214.768187749703, 4218.367244913287, 4747.216709243005, 4901.705897646081, 4921.901561968741, 4962.875928101754, 4975.353204083446, 1239.0892693869998, 1253.1666441816271, 1258.5343422933572, 1259.8425196850394, 1260.4328052376468, 806.9556174410346, 812.3338862133112, 845.9425717852685, 863.6502216602286, 879.1252703559999, 4369.497507786582, 4377.890552736207, 4391.516933137353, 4398.296272596369, 4452.265376212953, 4936.284238785356, 5021.748912554358, 5042.445331013586, 5055.3428054353435, 5066.341375621146, 4221.366794980716, 4374.900047976989, 4391.692581519327, 4402.6037656610415, 4422.977885110554, 2671.3054605802245, 2675.9732402676113, 2681.5441374966304, 2681.8793154308105, 2693.878775455109, 4789.257665061921, 4810.63920205986, 4813.807447702123, 4822.590079843182, 4843.418789745253, 4966.925496117561, 5128.923066153936, 5151.175811870083, 5153.598624907618, 5185.481451854785, 4870.09903167915, 4875.853724388274, 4887.266909963463, 4900.43186180426, 4910.189818680021, 5119.5648369887485, 5136.229565565195, 5140.532544378644, 5151.665141765773, 5165.070287348313, 4840.322354870392, 4989.550940415234, 5025.748712564284, 5053.671511351898, 5059.696418214919, 4879.853604391874, 4897.485763994871, 4903.8528844134735, 4904.166291730486, 4923.384576927884, 3637.418013117888, 3667.9266414671024, 3673.632636736305, 3698.130939229333, 3699.186179040607, 4905.828296009622, 5134.666246693953, 5188.714620695898, 5213.13983192769, 5215.243789650403, 4967.751612419437, 4982.950170498394, 4987.678265259781, 4989.800407983786, 4990.0, 4985.426675932169, 4998.375203099613, 5000.574836171673, 5014.84955451337, 5018.899622007612, 4792.7124372537755, 4889.975550122226, 4933.0, 4934.654574179773, 4958.652894297509, 4785.545373189541, 4855.053264613366, 4971.428285747185, 4973.776180071833, 5032.421271553671, 4815.927761083657, 4820.662553621353, 4844.757762111951, 4845.394325709286, 4855.562999330077], "value": 3743.3572855399398, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3257585216631, 612.9570930034894, 624.6782906802996, 705.1115594351116, 730.784418596514, 12584.119111662187, 13357.933210333958, 13385.39765710543, 13416.127951683146, 13417.932910335434, 11589.42052897356, 11665.825012624817, 11701.7659646807, 11704.824427633592, 11740.236884602495, 624.5721680648747, 739.6375775869825, 749.494091488246, 765.7894079128256, 770.0759089093083, 765.60188701875, 767.808047988003, 767.8349154931689, 768.6617888129233, 768.8116411479167, 802.8474589827944, 804.7424824056304, 807.0436532708759, 807.588130053671, 807.6284908941893, 651.0884761334123, 784.7920301120208, 800.5836964778312, 810.614957895001, 813.6175997281268, 591.4204080001623, 591.8845825064114, 595.0152497616451, 595.9332794298201, 596.2933923300902, 11721.29672219661, 11722.94138529302, 11737.354445505494, 11772.587959421464, 11798.351090690008, 11964.70088247792, 12180.330081845495, 12245.93877030618, 12683.873161268453, 12866.228026318357, 11785.0, 11926.582569610022, 12048.578299759554, 12065.939670301681, 12713.42789574462, 3977.801109944491, 3999.6400323970984, 4054.493188351456, 4190.476190476191, 4198.685098617585, 65032.0, 65275.3472465274, 65672.3432765671, 65857.67071164661, 65951.67024164849, 9862.753431164136, 9982.650607228712, 9983.400995940267, 10160.187185025181, 10180.694579162637, 20035.39893803188, 20046.49883752918, 20046.599068018557, 20051.29820456277, 20054.89972550128, 6433.485321174295, 6595.868082638321, 6706.5640733352175, 6875.312468753084, 6900.861982760317, 3753.474513568103, 3796.145867179918, 3826.9234615307537, 3870.07118291608, 3879.282332768447, 2846.957295640567, 3003.759699224057, 3005.3087789808465, 3006.428778532072, 3007.578938948549, 472.1548428313349, 479.7361451201825, 488.4260993332891, 489.2734289579971, 495.1112752609075, 427.76472939883564, 542.5551048140487, 550.5595523581119, 602.220124938206, 617.1668247865346, 7505.324520793046, 7904.802379940433, 7905.0, 8283.337333013344, 8754.781130471662, 494.90437314596966, 544.314164153162, 547.9917801232984, 559.82085732566, 620.9006558950546, 3797.2595343907674, 3819.3316169670197, 3887.2614203301846, 3960.1683646433994, 4023.4769479968004, 103925.48037259765, 106546.35438798179, 107439.46280268549, 108841.0, 111318.0, 91652.0, 91873.54063229775, 92950.0, 93171.53414233022, 93492.53253733824, 49065.509344906095, 80140.19859801327, 81312.40942568505, 83919.58040209759, 84014.57992709997, 7637.198094200029, 7781.416393770377, 7974.8006299840645, 7981.561014144278, 8036.100759727979, 44227.0, 45001.77499112483, 45332.093358133316, 45749.31376029429, 45854.0, 53909.46090539044, 55026.0, 55890.72054639863, 59937.70031149816, 60390.0, 10861.45692715377, 11034.710215177272, 11063.502142403771, 11274.943625282149, 11376.54493820238, 12197.78412404125, 12363.196392234477, 12658.87341126577, 12763.425645845773, 12764.936175319064, 8158.510489370657, 10897.291676041032, 10970.780584388109, 11234.719132021764, 11565.737589396973, 11399.715007124556, 11433.428328583372, 12750.362481875683, 12751.426185821474, 12758.48966041348, 11193.328400296008, 11218.775624487627, 11724.0, 12129.454174562343, 12740.108192426442, 9819.312648114563, 10440.216983726403, 10649.627263045757, 10829.350238985686, 11006.779864402828, 9005.954970225106, 10089.848652270075, 10121.493925303852, 10152.695419137437, 10237.129843963048], "value": 6549.994345842146, "unit": "score"}], "name": "dromaeo_css", "value": 6276.177586915733, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 116.0, 116.0, 110.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 126.0, 191.0, 129.0, 124.0, 154.0, 121.0, 186.0, 122.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 160.0, 162.0, 162.0, 163.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 112.0, 75.0, 77.0, 76.0, 76.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 124.0, 86.0, 86.0, 86.0, 114.0, 86.0, 85.0, 143.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 64.0, 66.0, 67.0, 64.0, 64.0, 67.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 83.0, 84.0, 83.0, 82.0, 82.0, 82.0, 83.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 141.0, 141.0, 131.0, 129.0, 131.0, 133.0, 156.0, 136.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 169.0, 170.0, 170.0, 169.0, 170.0, 171.0, 170.0, 170.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 69.0, 67.0, 68.0, 68.0, 69.0, 68.0, 67.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1546.3999999999999, "alertThreshold": 2.0}]} 13:13:04 INFO - Return code: 0 13:13:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:13:04 INFO - # TBPL SUCCESS # 13:13:04 INFO - Running post-action listener: _resource_record_post_action 13:13:04 INFO - [mozharness: 2016-08-18 20:13:04.411995Z] Finished run-tests step (success) 13:13:04 INFO - Running post-run listener: _resource_record_post_run 13:13:04 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 400424960; Read time: 0; Write time: 320104 13:13:04 INFO - TinderboxPrint: CPU usage
13.0% 13:13:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:13:04 INFO - TinderboxPrint: I/O write bytes / time
400,424,960 / 320,104 13:13:04 INFO - TinderboxPrint: CPU idle
8,336.7 (87.0%) 13:13:04 INFO - TinderboxPrint: CPU user
1,199.0 (12.5%) 13:13:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:13:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115101696; Read time: 0; Write time: 113228 13:13:04 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284319744; Read time: 0; Write time: 206856 13:13:05 INFO - Running post-run listener: _upload_blobber_files 13:13:05 INFO - Blob upload gear active. 13:13:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:13:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:13:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:13:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:13:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:06 INFO - (blobuploader) - INFO - Done attempting. 13:13:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:13:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:13:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:07 INFO - (blobuploader) - INFO - Done attempting. 13:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:11 INFO - (blobuploader) - INFO - Done attempting. 13:13:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:13:11 INFO - Return code: 0 13:13:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:13:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:13:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2532fb16515f07b21324d387cd61248cd8d66e82daf56e63ce238ba40a7833772226f699e83f5a3b6d3d711de5c51f5cae64b183d7d195be48145100cceaefae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/28cafd65a458c1f03e99fef9419b6813bdea4559e7deac0e78ee4b8d418033e62b2bcc59e9ce7008d44c453e2160e6e283bf3ca53c270386837fdf9d8b97b152", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb35119a8a28f6af3123df6a026235843f88f6b71f75104e2a9f5754d6de533db703f42ae56b9a9ea5d2378b88f0ed8c11689ce522e441f7f90b14b0ac8187ad"} 13:13:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:13:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:13:11 INFO - Contents: 13:13:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2532fb16515f07b21324d387cd61248cd8d66e82daf56e63ce238ba40a7833772226f699e83f5a3b6d3d711de5c51f5cae64b183d7d195be48145100cceaefae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/28cafd65a458c1f03e99fef9419b6813bdea4559e7deac0e78ee4b8d418033e62b2bcc59e9ce7008d44c453e2160e6e283bf3ca53c270386837fdf9d8b97b152", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb35119a8a28f6af3123df6a026235843f88f6b71f75104e2a9f5754d6de533db703f42ae56b9a9ea5d2378b88f0ed8c11689ce522e441f7f90b14b0ac8187ad"} 13:13:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:13:11 INFO - Copying logs to upload dir... 13:13:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:13:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.937608 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-18 13:13:11.073244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:13:11.076469) ========= 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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 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/2532fb16515f07b21324d387cd61248cd8d66e82daf56e63ce238ba40a7833772226f699e83f5a3b6d3d711de5c51f5cae64b183d7d195be48145100cceaefae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/28cafd65a458c1f03e99fef9419b6813bdea4559e7deac0e78ee4b8d418033e62b2bcc59e9ce7008d44c453e2160e6e283bf3ca53c270386837fdf9d8b97b152", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb35119a8a28f6af3123df6a026235843f88f6b71f75104e2a9f5754d6de533db703f42ae56b9a9ea5d2378b88f0ed8c11689ce522e441f7f90b14b0ac8187ad"} build_url:https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/HL2mSLjgSkuKFdFq05iVsg/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/2532fb16515f07b21324d387cd61248cd8d66e82daf56e63ce238ba40a7833772226f699e83f5a3b6d3d711de5c51f5cae64b183d7d195be48145100cceaefae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/28cafd65a458c1f03e99fef9419b6813bdea4559e7deac0e78ee4b8d418033e62b2bcc59e9ce7008d44c453e2160e6e283bf3ca53c270386837fdf9d8b97b152", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fb35119a8a28f6af3123df6a026235843f88f6b71f75104e2a9f5754d6de533db703f42ae56b9a9ea5d2378b88f0ed8c11689ce522e441f7f90b14b0ac8187ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 13:13:11.106529) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:13:11.106895) ========= 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=41bf3e9aed84707956354da8000001c5-1471549944.538553-24666194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 13:13:11.193072) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:13:11.193894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 13:13:11.194605) ========= ========= Total master_lag: 0.19 =========