builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1475878928.39 results: success (0) buildid: 20161007144421 builduid: ab1d5222f5534cf0a60917bc89ac7530 revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.390384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.391355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.391902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.410700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.410974) ========= 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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 15:22:09-- 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% 223M=0s 2016-10-07 15:22:09 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.506053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.506373) ========= 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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.555636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:08.556012) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 15:22:09,308 truncating revision to first 12 chars 2016-10-07 15:22:09,308 Setting DEBUG logging. 2016-10-07 15:22:09,308 attempt 1/10 2016-10-07 15:22:09,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efa3b654aa77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 15:22:09,626 unpacking tar archive at: fx-team-efa3b654aa77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:09.200422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:09.200925) ========= script_repo_revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:09.201536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:09.202100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 15:22:09.213793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 15:22:09.308597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:22:10 INFO - MultiFileLogger online at 20161007 15:22:10 in /builds/slave/test 15:22:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:22:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:10 INFO - {'append_to_log': False, 15:22:10 INFO - 'base_work_dir': '/builds/slave/test', 15:22:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:22:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:10 INFO - 'branch': 'Fx-Team-Non-PGO', 15:22:10 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:10 INFO - 'config_files': ('talos/linux_config.py',), 15:22:10 INFO - 'default_actions': ('clobber', 15:22:10 INFO - 'read-buildbot-config', 15:22:10 INFO - 'download-and-extract', 15:22:10 INFO - 'populate-webroot', 15:22:10 INFO - 'create-virtualenv', 15:22:10 INFO - 'install', 15:22:10 INFO - 'run-tests'), 15:22:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:10 INFO - 'download_minidump_stackwalk': True, 15:22:10 INFO - 'download_symbols': 'ondemand', 15:22:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:10 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:10 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:10 INFO - 'installer_path': 'installer.exe', 15:22:10 INFO - 'log_level': 'info', 15:22:10 INFO - 'log_name': 'talos', 15:22:10 INFO - 'log_to_console': True, 15:22:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:22:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:22:10 INFO - 'opt_config_files': (), 15:22:10 INFO - 'pip_index': False, 15:22:10 INFO - 'sps_profile': False, 15:22:10 INFO - 'sps_profile_interval': 0, 15:22:10 INFO - 'suite': 'dromaeojs', 15:22:10 INFO - 'system_bits': '32', 15:22:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:10 INFO - 'title': 'talos-linux64-ix-043', 15:22:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:10 INFO - 'use_talos_json': True, 15:22:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:10 INFO - 'work_dir': 'build'} 15:22:10 INFO - [mozharness: 2016-10-07 22:22:10.164226Z] Running clobber step. 15:22:10 INFO - Running pre-action listener: _resource_record_pre_action 15:22:10 INFO - Running main action method: clobber 15:22:10 INFO - rmtree: /builds/slave/test/build 15:22:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:10 INFO - Running post-action listener: _resource_record_post_action 15:22:10 INFO - [mozharness: 2016-10-07 22:22:10.643057Z] Finished clobber step (success) 15:22:10 INFO - [mozharness: 2016-10-07 22:22:10.643157Z] Running read-buildbot-config step. 15:22:10 INFO - Running pre-action listener: _resource_record_pre_action 15:22:10 INFO - Running main action method: read_buildbot_config 15:22:10 INFO - Using buildbot properties: 15:22:10 INFO - { 15:22:10 INFO - "project": "", 15:22:10 INFO - "product": "firefox", 15:22:10 INFO - "script_repo_revision": "production", 15:22:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:22:10 INFO - "repository": "", 15:22:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:22:10 INFO - "buildid": "20161007144421", 15:22:10 INFO - "pgo_build": "False", 15:22:10 INFO - "basedir": "/builds/slave/test", 15:22:10 INFO - "buildnumber": 1971, 15:22:10 INFO - "slavename": "talos-linux64-ix-043", 15:22:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:22:10 INFO - "platform": "ubuntu64_hw", 15:22:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:22:10 INFO - "branch": "fx-team", 15:22:10 INFO - "repo_path": "integration/fx-team", 15:22:10 INFO - "revision": "efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6", 15:22:10 INFO - "stage_platform": "linux64", 15:22:10 INFO - "builduid": "ab1d5222f5534cf0a60917bc89ac7530", 15:22:10 INFO - "slavebuilddir": "test" 15:22:10 INFO - } 15:22:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:22:10 INFO - Running post-action listener: _resource_record_post_action 15:22:10 INFO - [mozharness: 2016-10-07 22:22:10.646243Z] Finished read-buildbot-config step (success) 15:22:10 INFO - [mozharness: 2016-10-07 22:22:10.646331Z] Running download-and-extract step. 15:22:10 INFO - Running pre-action listener: _resource_record_pre_action 15:22:10 INFO - Running main action method: download_and_extract 15:22:10 INFO - mkdir: /builds/slave/test/build/tests 15:22:10 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')]} 15:22:10 INFO - trying https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:22:10 INFO - Downloading https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:22:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:22:11 INFO - Downloaded 1361 bytes. 15:22:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:22:11 INFO - Using the following test package requirements: 15:22:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:22:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:22:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'jsshell-linux-x86_64.zip'], 15:22:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:22:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:22:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:22:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:22:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:22:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:22:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:22:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:11 INFO - Http code: 200 15:22:11 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:22:11 INFO - x-amz-cf-id: rfRXJdFAe6fiLF0wX2G8GNG_giYJFA0G7Ck9uVpGrjD5jXjcgWTUNQ== 15:22:11 INFO - x-amz-version-id: D3rqt7W8oOOSAKNr6ITgigj5YeVCvCjQ 15:22:12 INFO - Expected file size: 20461758 15:22:12 INFO - Obtained file size: 20461758 15:22:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:22:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:22:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:16 INFO - Fetch https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:16 INFO - Http code: 200 15:22:16 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 15:22:16 INFO - x-amz-cf-id: C8CMr5ki_AolFl4LQ57T-JLDghLpGZJiWL-VlmAYm8JpzqnHnqM2AQ== 15:22:16 INFO - x-amz-version-id: D3rqt7W8oOOSAKNr6ITgigj5YeVCvCjQ 15:22:16 INFO - Expected file size: 20461758 15:22:16 INFO - Obtained file size: 20461758 15:22:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:22:21 INFO - Http code: 200 15:22:21 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 15:22:21 INFO - x-amz-cf-id: RQbO9gzDDevB33h-I2RJb1cm0AzdqrilooxU_JCOEm6aHS7q3i4CLQ== 15:22:21 INFO - x-amz-version-id: 6P.voQLwjWhBBzYyRYswX3.CI_IDhfs5 15:22:22 INFO - Expected file size: 14409006 15:22:22 INFO - Obtained file size: 14409006 15:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:22 INFO - trying https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:22:23 INFO - Downloaded 55867478 bytes. 15:22:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:23 INFO - mkdir: /builds/slave/test/properties 15:22:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:23 INFO - Contents: 15:22:23 INFO - build_url:https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:24 INFO - Running post-action listener: _resource_record_post_action 15:22:24 INFO - Running post-action listener: set_extra_try_arguments 15:22:24 INFO - [mozharness: 2016-10-07 22:22:24.014556Z] Finished download-and-extract step (success) 15:22:24 INFO - [mozharness: 2016-10-07 22:22:24.014783Z] Running populate-webroot step. 15:22:24 INFO - Running pre-action listener: _resource_record_pre_action 15:22:24 INFO - Running main action method: populate_webroot 15:22:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:24 INFO - '--tppagecycles', 15:22:24 INFO - '7'], 15:22:24 INFO - 'tests': ['tsvgm']}}, 15:22:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['damp', 'tps']}, 15:22:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'tests': ['damp', 'tps']}, 15:22:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['dromaeo_dom']}, 15:22:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['basic_compositor_video']}, 15:22:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:22:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['a11yr', 15:22:24 INFO - 'ts_paint', 15:22:24 INFO - 'tpaint', 15:22:24 INFO - 'sessionrestore', 15:22:24 INFO - 'sessionrestore_no_auto_restore', 15:22:24 INFO - 'tabpaint']}, 15:22:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['tsvgx', 15:22:24 INFO - 'tsvgr_opacity', 15:22:24 INFO - 'tart', 15:22:24 INFO - 'tscrollx', 15:22:24 INFO - 'cart']}, 15:22:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:24 INFO - 'tsvgr_opacity', 15:22:24 INFO - 'tart', 15:22:24 INFO - 'tscrollx', 15:22:24 INFO - 'cart']}, 15:22:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'talos_options': ['--disable-e10s'], 15:22:24 INFO - 'tests': ['tp5o']}, 15:22:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'tests': ['tp5o']}, 15:22:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'talos_options': ['--disable-e10s', 15:22:24 INFO - '--xperf_path', 15:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:24 INFO - 'tests': ['tp5n']}, 15:22:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:24 INFO - 'talos_options': ['--xperf_path', 15:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:24 INFO - 'tests': ['tp5n']}}, 15:22:24 INFO - 'talos.zip': {'path': '', 15:22:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:24 INFO - Running post-action listener: _resource_record_post_action 15:22:24 INFO - [mozharness: 2016-10-07 22:22:24.039500Z] Finished populate-webroot step (success) 15:22:24 INFO - [mozharness: 2016-10-07 22:22:24.039588Z] Running create-virtualenv step. 15:22:24 INFO - Running pre-action listener: _resource_record_pre_action 15:22:24 INFO - Running main action method: create_virtualenv 15:22:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:24 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 15:22:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:24 INFO - Using real prefix '/usr' 15:22:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:26 INFO - Installing pip.................done. 15:22:26 INFO - Return code: 0 15:22:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:22:26 INFO - Reading from file tmpfile_stdout 15:22:26 INFO - Output received: 15:22:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:22:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:26 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:26 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 15:22:26 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 15:22:26 INFO - Using env: {'DISPLAY': ':0', 15:22:26 INFO - 'HOME': '/home/cltbld', 15:22:26 INFO - 'LANG': 'en_US.UTF-8', 15:22:26 INFO - 'LANGUAGE': 'en_US:en', 15:22:26 INFO - 'LOGNAME': 'cltbld', 15:22:26 INFO - 'MAIL': '/var/mail/cltbld', 15:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:26 INFO - 'MOZ_NO_REMOTE': '1', 15:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:26 INFO - 'NO_EM_RESTART': '1', 15:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:26 INFO - 'PWD': '/builds/slave/test', 15:22:26 INFO - 'SHELL': '/bin/bash', 15:22:26 INFO - 'SHLVL': '1', 15:22:26 INFO - 'TERM': 'linux', 15:22:26 INFO - 'TMOUT': '86400', 15:22:26 INFO - 'USER': 'cltbld', 15:22:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:26 INFO - '_': '/tools/buildbot/bin/python'} 15:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:27 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 15:22:27 INFO - Cleaning up... 15:22:27 INFO - Return code: 0 15:22:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:27 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:27 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 15:22:27 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 15:22:27 INFO - Using env: {'DISPLAY': ':0', 15:22:27 INFO - 'HOME': '/home/cltbld', 15:22:27 INFO - 'LANG': 'en_US.UTF-8', 15:22:27 INFO - 'LANGUAGE': 'en_US:en', 15:22:27 INFO - 'LOGNAME': 'cltbld', 15:22:27 INFO - 'MAIL': '/var/mail/cltbld', 15:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:27 INFO - 'MOZ_NO_REMOTE': '1', 15:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:27 INFO - 'NO_EM_RESTART': '1', 15:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:27 INFO - 'PWD': '/builds/slave/test', 15:22:27 INFO - 'SHELL': '/bin/bash', 15:22:27 INFO - 'SHLVL': '1', 15:22:27 INFO - 'TERM': 'linux', 15:22:27 INFO - 'TMOUT': '86400', 15:22:27 INFO - 'USER': 'cltbld', 15:22:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:27 INFO - '_': '/tools/buildbot/bin/python'} 15:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:27 INFO - Downloading/unpacking psutil>=3.1.1 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:29 INFO - Installing collected packages: psutil 15:22:29 INFO - Running setup.py install for psutil 15:22:29 INFO - building 'psutil._psutil_linux' extension 15:22:29 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 15:22:29 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 15:22:29 INFO - building 'psutil._psutil_posix' extension 15:22:29 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 15:22:29 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 15:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:29 INFO - Successfully installed psutil 15:22:29 INFO - Cleaning up... 15:22:29 INFO - Return code: 0 15:22:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:29 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:29 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 15:22:29 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 15:22:29 INFO - Using env: {'DISPLAY': ':0', 15:22:29 INFO - 'HOME': '/home/cltbld', 15:22:29 INFO - 'LANG': 'en_US.UTF-8', 15:22:29 INFO - 'LANGUAGE': 'en_US:en', 15:22:29 INFO - 'LOGNAME': 'cltbld', 15:22:29 INFO - 'MAIL': '/var/mail/cltbld', 15:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:29 INFO - 'MOZ_NO_REMOTE': '1', 15:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:29 INFO - 'NO_EM_RESTART': '1', 15:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:29 INFO - 'PWD': '/builds/slave/test', 15:22:29 INFO - 'SHELL': '/bin/bash', 15:22:29 INFO - 'SHLVL': '1', 15:22:29 INFO - 'TERM': 'linux', 15:22:29 INFO - 'TMOUT': '86400', 15:22:29 INFO - 'USER': 'cltbld', 15:22:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:29 INFO - '_': '/tools/buildbot/bin/python'} 15:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:30 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 15:22:30 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 15:22:30 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 15:22:30 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 15:22:30 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 15:22:30 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 15:22:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:32 INFO - Installing collected packages: mozsystemmonitor 15:22:32 INFO - Running setup.py install for mozsystemmonitor 15:22:32 INFO - Successfully installed mozsystemmonitor 15:22:32 INFO - Cleaning up... 15:22:32 INFO - Return code: 0 15:22:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:32 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')]} 15:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:32 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')]} 15:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:32 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:32 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 15:22:32 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 15:22:32 INFO - Using env: {'DISPLAY': ':0', 15:22:32 INFO - 'HOME': '/home/cltbld', 15:22:32 INFO - 'LANG': 'en_US.UTF-8', 15:22:32 INFO - 'LANGUAGE': 'en_US:en', 15:22:32 INFO - 'LOGNAME': 'cltbld', 15:22:32 INFO - 'MAIL': '/var/mail/cltbld', 15:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:32 INFO - 'MOZ_NO_REMOTE': '1', 15:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:32 INFO - 'NO_EM_RESTART': '1', 15:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:32 INFO - 'PWD': '/builds/slave/test', 15:22:32 INFO - 'SHELL': '/bin/bash', 15:22:32 INFO - 'SHLVL': '1', 15:22:32 INFO - 'TERM': 'linux', 15:22:32 INFO - 'TMOUT': '86400', 15:22:32 INFO - 'USER': 'cltbld', 15:22:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:32 INFO - '_': '/tools/buildbot/bin/python'} 15:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:32 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 15:22:32 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 15:22:32 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 15:22:32 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 15:22:32 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 15:22:32 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 15:22:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:34 INFO - warning: no files found matching '*.txt' 15:22:34 INFO - no previously-included directories found matching 'build' 15:22:34 INFO - no previously-included directories found matching 'dist' 15:22:34 INFO - no previously-included directories found matching '.git*' 15:22:34 INFO - Installing collected packages: jsonschema, functools32 15:22:34 INFO - Running setup.py install for functools32 15:22:34 INFO - warning: no files found matching '*.txt' 15:22:34 INFO - no previously-included directories found matching 'build' 15:22:34 INFO - no previously-included directories found matching 'dist' 15:22:34 INFO - no previously-included directories found matching '.git*' 15:22:34 INFO - Successfully installed jsonschema functools32 15:22:34 INFO - Cleaning up... 15:22:34 INFO - Return code: 0 15:22:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:34 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')]} 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:34 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')]} 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:34 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:34 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 15:22:34 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 15:22:34 INFO - Using env: {'DISPLAY': ':0', 15:22:34 INFO - 'HOME': '/home/cltbld', 15:22:34 INFO - 'LANG': 'en_US.UTF-8', 15:22:34 INFO - 'LANGUAGE': 'en_US:en', 15:22:34 INFO - 'LOGNAME': 'cltbld', 15:22:34 INFO - 'MAIL': '/var/mail/cltbld', 15:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:34 INFO - 'MOZ_NO_REMOTE': '1', 15:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:34 INFO - 'NO_EM_RESTART': '1', 15:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:34 INFO - 'PWD': '/builds/slave/test', 15:22:34 INFO - 'SHELL': '/bin/bash', 15:22:34 INFO - 'SHLVL': '1', 15:22:34 INFO - 'TERM': 'linux', 15:22:34 INFO - 'TMOUT': '86400', 15:22:34 INFO - 'USER': 'cltbld', 15:22:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:34 INFO - '_': '/tools/buildbot/bin/python'} 15:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:34 INFO - Cleaning up... 15:22:34 INFO - Return code: 0 15:22:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:34 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')]} 15:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:34 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')]} 15:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:34 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:34 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 15:22:34 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 15:22:34 INFO - Using env: {'DISPLAY': ':0', 15:22:34 INFO - 'HOME': '/home/cltbld', 15:22:34 INFO - 'LANG': 'en_US.UTF-8', 15:22:34 INFO - 'LANGUAGE': 'en_US:en', 15:22:34 INFO - 'LOGNAME': 'cltbld', 15:22:34 INFO - 'MAIL': '/var/mail/cltbld', 15:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:34 INFO - 'MOZ_NO_REMOTE': '1', 15:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:34 INFO - 'NO_EM_RESTART': '1', 15:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:34 INFO - 'PWD': '/builds/slave/test', 15:22:34 INFO - 'SHELL': '/bin/bash', 15:22:34 INFO - 'SHLVL': '1', 15:22:34 INFO - 'TERM': 'linux', 15:22:34 INFO - 'TMOUT': '86400', 15:22:34 INFO - 'USER': 'cltbld', 15:22:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:34 INFO - '_': '/tools/buildbot/bin/python'} 15:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:35 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 15:22:35 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 15:22:35 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 15:22:35 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 15:22:35 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 15:22:35 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 15:22:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 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 15:22:37 INFO - Downloading docopt-0.6.1.tar.gz 15:22:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:37 INFO - Running setup.py install for blobuploader 15:22:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:37 INFO - Running setup.py install for requests 15:22:38 INFO - Running setup.py install for docopt 15:22:38 INFO - Successfully installed blobuploader requests docopt 15:22:38 INFO - Cleaning up... 15:22:38 INFO - Return code: 0 15:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:38 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:38 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 15:22:38 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 15:22:38 INFO - Using env: {'DISPLAY': ':0', 15:22:38 INFO - 'HOME': '/home/cltbld', 15:22:38 INFO - 'LANG': 'en_US.UTF-8', 15:22:38 INFO - 'LANGUAGE': 'en_US:en', 15:22:38 INFO - 'LOGNAME': 'cltbld', 15:22:38 INFO - 'MAIL': '/var/mail/cltbld', 15:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:38 INFO - 'MOZ_NO_REMOTE': '1', 15:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:38 INFO - 'NO_EM_RESTART': '1', 15:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:38 INFO - 'PWD': '/builds/slave/test', 15:22:38 INFO - 'SHELL': '/bin/bash', 15:22:38 INFO - 'SHLVL': '1', 15:22:38 INFO - 'TERM': 'linux', 15:22:38 INFO - 'TMOUT': '86400', 15:22:38 INFO - 'USER': 'cltbld', 15:22:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:38 INFO - '_': '/tools/buildbot/bin/python'} 15:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:38 INFO - Running setup.py (path:/tmp/pip-Kc5vOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:38 INFO - Running setup.py (path:/tmp/pip-0YcFrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:38 INFO - Running setup.py (path:/tmp/pip-JIOHiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:38 INFO - Running setup.py (path:/tmp/pip-sJGlHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:38 INFO - Running setup.py (path:/tmp/pip-yAILvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:39 INFO - Running setup.py (path:/tmp/pip-J7T5lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:39 INFO - Running setup.py (path:/tmp/pip-oDzpHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:39 INFO - Running setup.py (path:/tmp/pip-3Dek5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:39 INFO - Running setup.py (path:/tmp/pip-0M6yQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:39 INFO - Running setup.py (path:/tmp/pip-JobjvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:39 INFO - Running setup.py (path:/tmp/pip-X4kBxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:39 INFO - Running setup.py (path:/tmp/pip-1BFp8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:39 INFO - Running setup.py (path:/tmp/pip-bhqyiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:39 INFO - Running setup.py (path:/tmp/pip-VWYFm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:39 INFO - Running setup.py (path:/tmp/pip-oDlDEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:39 INFO - Running setup.py (path:/tmp/pip-PU2Gr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:39 INFO - Running setup.py (path:/tmp/pip-dMJ6mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:39 INFO - Running setup.py install for manifestparser 15:22:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozcrash 15:22:40 INFO - Running setup.py install for mozdebug 15:22:40 INFO - Running setup.py install for mozdevice 15:22:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozfile 15:22:40 INFO - Running setup.py install for mozhttpd 15:22:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozinfo 15:22:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozInstall 15:22:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for mozleak 15:22:40 INFO - Running setup.py install for mozlog 15:22:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:40 INFO - Running setup.py install for moznetwork 15:22:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Running setup.py install for mozprocess 15:22:41 INFO - Running setup.py install for mozprofile 15:22:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Running setup.py install for mozrunner 15:22:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Running setup.py install for mozscreenshot 15:22:41 INFO - Running setup.py install for moztest 15:22:41 INFO - Running setup.py install for mozversion 15:22:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:41 INFO - Cleaning up... 15:22:41 INFO - Return code: 0 15:22:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:41 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:41 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 15:22:41 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 15:22:41 INFO - Using env: {'DISPLAY': ':0', 15:22:41 INFO - 'HOME': '/home/cltbld', 15:22:41 INFO - 'LANG': 'en_US.UTF-8', 15:22:41 INFO - 'LANGUAGE': 'en_US:en', 15:22:41 INFO - 'LOGNAME': 'cltbld', 15:22:41 INFO - 'MAIL': '/var/mail/cltbld', 15:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:41 INFO - 'MOZ_NO_REMOTE': '1', 15:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:41 INFO - 'NO_EM_RESTART': '1', 15:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:41 INFO - 'PWD': '/builds/slave/test', 15:22:41 INFO - 'SHELL': '/bin/bash', 15:22:41 INFO - 'SHLVL': '1', 15:22:41 INFO - 'TERM': 'linux', 15:22:41 INFO - 'TMOUT': '86400', 15:22:41 INFO - 'USER': 'cltbld', 15:22:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:41 INFO - '_': '/tools/buildbot/bin/python'} 15:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:41 INFO - Running setup.py (path:/tmp/pip-vq0rY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:42 INFO - Running setup.py (path:/tmp/pip-KEcolw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:42 INFO - Running setup.py (path:/tmp/pip-zQp9Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:42 INFO - Running setup.py (path:/tmp/pip-m_gqag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:42 INFO - Running setup.py (path:/tmp/pip-U5C6MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:42 INFO - Running setup.py (path:/tmp/pip-Eun_a3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:42 INFO - Running setup.py (path:/tmp/pip-SvsBv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:42 INFO - Running setup.py (path:/tmp/pip-Z6TLQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:42 INFO - Running setup.py (path:/tmp/pip-TnE6JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Running setup.py (path:/tmp/pip-VdZtMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 INFO - Running setup.py (path:/tmp/pip-YsUVPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:42 INFO - Running setup.py (path:/tmp/pip-WCqY5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:42 INFO - Running setup.py (path:/tmp/pip-Qvob70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:42 INFO - Running setup.py (path:/tmp/pip-UOAsxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:42 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)) 15:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:42 INFO - Running setup.py (path:/tmp/pip-buz0nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:43 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)) 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:43 INFO - Running setup.py (path:/tmp/pip-7LccT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:43 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)) 15:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:43 INFO - Running setup.py (path:/tmp/pip-DSK0p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:43 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)) 15:22:43 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)) 15:22:43 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)) 15:22:43 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)) 15:22:43 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)) 15:22:43 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)) 15:22:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:45 INFO - Downloading blessings-1.6.tar.gz 15:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:45 INFO - Installing collected packages: blessings 15:22:45 INFO - Running setup.py install for blessings 15:22:45 INFO - Successfully installed blessings 15:22:45 INFO - Cleaning up... 15:22:45 INFO - Return code: 0 15:22:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:45 INFO - Reading from file tmpfile_stdout 15:22:45 INFO - Current package versions: 15:22:45 INFO - argparse == 1.2.1 15:22:45 INFO - blessings == 1.6 15:22:45 INFO - blobuploader == 1.2.4 15:22:45 INFO - docopt == 0.6.1 15:22:45 INFO - functools32 == 3.2.3-2 15:22:45 INFO - jsonschema == 2.5.1 15:22:45 INFO - manifestparser == 1.1 15:22:45 INFO - mozInstall == 1.12 15:22:45 INFO - mozcrash == 0.17 15:22:45 INFO - mozdebug == 0.1 15:22:45 INFO - mozdevice == 0.48 15:22:45 INFO - mozfile == 1.2 15:22:45 INFO - mozhttpd == 0.7 15:22:45 INFO - mozinfo == 0.9 15:22:45 INFO - mozleak == 0.1 15:22:45 INFO - mozlog == 3.4 15:22:45 INFO - moznetwork == 0.27 15:22:45 INFO - mozprocess == 0.23 15:22:45 INFO - mozprofile == 0.28 15:22:45 INFO - mozrunner == 6.12 15:22:45 INFO - mozscreenshot == 0.1 15:22:45 INFO - mozsystemmonitor == 0.3 15:22:45 INFO - moztest == 0.7 15:22:45 INFO - mozversion == 1.4 15:22:45 INFO - psutil == 3.1.1 15:22:45 INFO - requests == 1.2.3 15:22:45 INFO - wsgiref == 0.1.2 15:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 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 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:45 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 15:22:45 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 15:22:45 INFO - Using env: {'DISPLAY': ':0', 15:22:45 INFO - 'HOME': '/home/cltbld', 15:22:45 INFO - 'LANG': 'en_US.UTF-8', 15:22:45 INFO - 'LANGUAGE': 'en_US:en', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MAIL': '/var/mail/cltbld', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SHLVL': '1', 15:22:45 INFO - 'TERM': 'linux', 15:22:45 INFO - 'TMOUT': '86400', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - '_': '/tools/buildbot/bin/python'} 15:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 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)) 15:22:45 INFO - Cleaning up... 15:22:45 INFO - Return code: 0 15:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9036d69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', '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 15:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:45 INFO - Using env: {'DISPLAY': ':0', 15:22:45 INFO - 'HOME': '/home/cltbld', 15:22:45 INFO - 'LANG': 'en_US.UTF-8', 15:22:45 INFO - 'LANGUAGE': 'en_US:en', 15:22:45 INFO - 'LOGNAME': 'cltbld', 15:22:45 INFO - 'MAIL': '/var/mail/cltbld', 15:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:45 INFO - 'MOZ_NO_REMOTE': '1', 15:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:45 INFO - 'NO_EM_RESTART': '1', 15:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:45 INFO - 'PWD': '/builds/slave/test', 15:22:45 INFO - 'SHELL': '/bin/bash', 15:22:45 INFO - 'SHLVL': '1', 15:22:45 INFO - 'TERM': 'linux', 15:22:45 INFO - 'TMOUT': '86400', 15:22:45 INFO - 'USER': 'cltbld', 15:22:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:45 INFO - '_': '/tools/buildbot/bin/python'} 15:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:46 INFO - Cleaning up... 15:22:46 INFO - Return code: 0 15:22:46 INFO - Running post-action listener: _resource_record_post_action 15:22:46 INFO - Running post-action listener: _start_resource_monitoring 15:22:46 INFO - Starting resource monitoring. 15:22:46 INFO - [mozharness: 2016-10-07 22:22:46.046277Z] Finished create-virtualenv step (success) 15:22:46 INFO - [mozharness: 2016-10-07 22:22:46.046791Z] Running install step. 15:22:46 INFO - Running pre-action listener: _resource_record_pre_action 15:22:46 INFO - Running main action method: install 15:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:46 INFO - Reading from file tmpfile_stdout 15:22:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:46 INFO - Reading from file tmpfile_stdout 15:22:46 INFO - Output received: 15:22:46 INFO - Usage: mozinstall [options] installer 15:22:46 INFO - Options: 15:22:46 INFO - -h, --help show this help message and exit 15:22:46 INFO - -d DEST, --destination=DEST 15:22:46 INFO - Directory to install application into. [default: 15:22:46 INFO - "/builds/slave/test"] 15:22:46 INFO - --app=APP Application being installed. [default: firefox] 15:22:46 INFO - mkdir: /builds/slave/test/build/application 15:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:23:02 INFO - Reading from file tmpfile_stdout 15:23:02 INFO - Output received: 15:23:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:23:02 INFO - Running post-action listener: _resource_record_post_action 15:23:02 INFO - [mozharness: 2016-10-07 22:23:02.503786Z] Finished install step (success) 15:23:02 INFO - [mozharness: 2016-10-07 22:23:02.504033Z] Running run-tests step. 15:23:02 INFO - Running pre-action listener: _resource_record_pre_action 15:23:02 INFO - Running main action method: run_tests 15:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:02 INFO - Python 2.7.3 15:23:02 INFO - Return code: 0 15:23:02 INFO - grabbing minidump binary from tooltool 15:23:02 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')]} 15:23:02 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 0x129bf60>, '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 0x129cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:02 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 15:23:02 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 15:23:02 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 15:23:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:02 INFO - Return code: 0 15:23:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:23:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:23:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 15:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 15:23:02 INFO - Using env: {'DISPLAY': ':0', 15:23:02 INFO - 'HOME': '/home/cltbld', 15:23:02 INFO - 'LANG': 'en_US.UTF-8', 15:23:02 INFO - 'LANGUAGE': 'en_US:en', 15:23:02 INFO - 'LOGNAME': 'cltbld', 15:23:02 INFO - 'MAIL': '/var/mail/cltbld', 15:23:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:02 INFO - 'MOZ_NO_REMOTE': '1', 15:23:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:02 INFO - 'NO_EM_RESTART': '1', 15:23:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:02 INFO - 'PWD': '/builds/slave/test', 15:23:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:02 INFO - 'SHELL': '/bin/bash', 15:23:02 INFO - 'SHLVL': '1', 15:23:02 INFO - 'TERM': 'linux', 15:23:02 INFO - 'TMOUT': '86400', 15:23:02 INFO - 'USER': 'cltbld', 15:23:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434', 15:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:02 INFO - '_': '/tools/buildbot/bin/python'} 15:23:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 15:23:02 INFO - mozversion application_buildid: 20161007144421 15:23:02 INFO - mozversion application_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 15:23:02 INFO - mozversion application_display_name: Nightly 15:23:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:02 INFO - mozversion application_name: Firefox 15:23:02 INFO - mozversion application_remotingname: firefox 15:23:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:23:02 INFO - mozversion application_vendor: Mozilla 15:23:02 INFO - mozversion application_version: 52.0a1 15:23:02 INFO - mozversion platform_buildid: 20161007144421 15:23:02 INFO - mozversion platform_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 15:23:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:23:02 INFO - mozversion platform_version: 52.0a1 15:23:02 INFO - using testdate: 1475878982 15:23:02 INFO - actual date: 1475878982 15:23:02 INFO - starting webserver on 'localhost:39305' 15:23:02 INFO - SUITE-START | Running 2 tests 15:23:02 INFO - TEST-START | dromaeo_css 15:23:02 INFO - operating with platform_type : linux_ 15:23:02 INFO - Initialising browser for dromaeo_css test... 15:23:02 INFO - TEST-INFO | started process 32489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61aaYS/profile http://localhost:39305/getInfo.html) 15:23:07 INFO - PROCESS | 32489 | __metrics Screen width/height:1600/1200 15:23:07 INFO - PROCESS | 32489 | colorDepth:24 15:23:07 INFO - PROCESS | 32489 | Browser inner width/height: 1024/697 15:23:07 INFO - PROCESS | 32489 | __metrics 15:23:08 INFO - PROCESS | 32489 | 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" 15:23:08 INFO - PROCESS | 32489 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:23:08 INFO - PROCESS | 32489 | console.error: PushService: 15:23:08 INFO - PROCESS | 32489 | stateChangeProcessEnqueue: Error transitioning state 15:23:08 INFO - PROCESS | 32489 | UnknownError 15:23:09 INFO - TEST-INFO | 32489: exit 0 15:23:09 INFO - Browser initialized. 15:23:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:09 INFO - TEST-INFO | started process 32569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61aaYS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:21 INFO - PROCESS | 32569 | RSS: Main: 174481408 15:23:21 INFO - PROCESS | 32569 | 15:24:13 INFO - PROCESS | 32569 | 1475879053068 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] 15:26:26 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39305/tests/dromaeo/cssquery-ext.html) 15:26:28 INFO - PROCESS | 32569 | RSS: Main: 319107072 15:26:28 INFO - PROCESS | 32569 | 15:29:30 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-ext.html (next: http://localhost:39305/tests/dromaeo/cssquery-jquery.html) 15:29:31 INFO - PROCESS | 32569 | RSS: Main: 276574208 15:29:31 INFO - PROCESS | 32569 | 15:32:33 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39305/tests/dromaeo/cssquery-mootools.html) 15:32:34 INFO - PROCESS | 32569 | RSS: Main: 251170816 15:32:34 INFO - PROCESS | 32569 | 15:35:36 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39305/tests/dromaeo/cssquery-prototype.html) 15:35:36 INFO - PROCESS | 32569 | RSS: Main: 217870336 15:35:36 INFO - PROCESS | 32569 | 15:38:40 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39305/tests/dromaeo/cssquery-yui.html) 15:38:40 INFO - PROCESS | 32569 | RSS: Main: 218386432 15:38:40 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | Cycle 1(1): loaded http://localhost:39305/tests/dromaeo/cssquery-yui.html (next: http://localhost:39305/tests/dromaeo/cssquery-dojo.html) 15:41:43 INFO - PROCESS | 32569 | RSS: Main: 295104512 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | __start_tp_report 15:41:43 INFO - PROCESS | 32569 | _x_x_mozilla_page_load 15:41:43 INFO - PROCESS | 32569 | _x_x_mozilla_page_load_details 15:41:43 INFO - PROCESS | 32569 | |i|pagename|runs| 15:41:43 INFO - PROCESS | 32569 | |0;dojo.html;2504.849709017459;2528.949421011581;2535.974640253597;2557.8976840926366;2567.0630219969703;4422.911541769163;4488.192125417424;4586.908261834766;4592.586667199951;4600.769961501924;4486.506484286734;4504.842330518424;4507.864764057083;4512.9548704512945;4521.819127234915;4155.979220103903;4173.582641735818;4174.895627609304;4216.367544868263;4260.467441569804;4242.681798865097;4249.51130619978;4262.957370426287;4286.378475121106;4304.182205380983;4250.48994120706;4265.616094551489;4272.743635381871;4328.891777705551;4329.437173167484;4172.874813755592;4285.46431696038;4287.399764033038;4296.591823776736;4306.18182545317;4061.289274376972;4124.484439445069;4153.1486045360625;4175.561566035583;4201.747895126302;4441;4493.887652808706;4494.393256910308;4506.729596224237;4506.954930450686;4747.572718455355;4787.80848766049;4788.329633851264;4793.880152996168;4799.064182484417;4814.855554333376;4849.587785038276;4896.608271338285;4906.386701662293;4915.5821755150855;4578.656600754924;4644.373009643722;4648.209804333272;4653.95346046542;4703.553162449562;5064.290999260106;5073.365829271341;5073.898522029539;5080.59355251579;5146.408163061221;4674.7896344663895;4725.881852953635;4733.928991065137;4771.045790841846;4787;4835.153848076572;4869.70781753096;4882.780274887638;4884.926726099111;4928.6303527235605;4770.904581908412;4803.303520989437;4804.2073057945745;4807.567318941312;4866.9513304867205;4653.488116307203;4714.764261786897;4717.103750287434;4766.928496072562;4767.666263361601;4113.136241389282;4135.483064616923;4142.502899652;4143.3784932260405;4148.377743338523;3595.137167079882;3620.7465477416326;3645.325614761278;3653.671169594696;3698.8705395311035;4243.215005224043;4243.2998555238655;4245.384419259251;4290.2706539888295;4301.118270754488;4881.560659540658;4891.1685013547785;4897.534734200245;4899.926501102486;4966.801327946841;4112.095339025469;4188.748675079505;4188.790560471964;4193.727407718488;4228.302330115558;4408.713433626804;4410.69125161242;4453.376527286183;4463.843765468193;4465.218586747306;4577.8168873244695;4588.885277867947;4590.954090459186;4593.035462552902;4604.746738929391;4777.474477807369;4778.402699662543;4870.439899411613;4878.9512104878495;4881.51184881509;4509.616682581886;4525.321201819754;4530.139273538017;4560.6351491879905;4578.336141259432;4722.811087556596;4730.929036064531;4733.148033354029;4737.076270127292;4793.376861008047;4730.834420795256;4776.259679749644;4797.520247975174;4798.2802579613335;4852;4635;4658.464276608233;4674.672772905864;4708.764561771966;4742.359781429601;4672.252439609646;4676.579107880171;4680.836170734008;4686.133065382915;4731.810727570859;4581.289900065495;4611.239145540948;4621.1219868224925;4626.6298696104905;4675.532446755434;4658.790354434126;4741.075490279501;4752.42970843501;4810.831620893392;4819.012102519046;4706.882327941828;4713.128071306819;4716.339712440193;4763.190257656276;4772.427308722837 15:41:43 INFO - PROCESS | 32569 | |1;ext.html;556.1990733343985;563.8505795964068;568.1676344155811;569.51875665063;577.0161874004822;28020.15939521815;28719.425611487783;38419.42370864436;40189.799051004775;40262.79868600653;39880;40392.39411408831;40410.7979460103;40429.79785101078;40523.39214911779;7423.888641670379;7571;7575.1288601810675;7575.318221360077;7575.431842611799;7040.6127662978515;7251.129864416277;7251.238619944883;7395.334419902208;7516.473846830724;9538.809223815519;9839.950800246024;9844.261680373966;10125.797484050314;10137.543810528545;10059.24555658325;10113.595456181743;10127.08856202938;10134.138598219197;10143.442110683909;9740;9955;9969.501524923797;9970.651027214086;9971.202303815677;38441.61558384408;38798.41802372967;38809.805950970345;38816.22367552633;38850;2832.56095305228;2884.2933481297005;2900.419916016805;2992.7605791536625;3223.8226897520626;27303.45393092147;27812.30469238265;28096.719032809615;28121.29696757577;28689.426211475864;3203.983980080108;3333.1333853198103;3359.3281343731105;3381.594208694972;3394.439917413624;184824;187017;187332;187829.99999999863;187853;52436.47563524316;52805.47194528082;52939;52967;53013.204801928005;32707;33245.83377083147;33416.33167336688;56716.43283567194;56910.7154464225;13356.532521361705;13769.03616746818;13780.310984450738;13784.586462406143;13791.862081379259;10582.259241853151;10670.30643008202;10675.73310667224;10677.252592318619;10681.412522311191;15399;15776.842231577766;17332.480025599252;17853.7321940171;17969.19138638738;6508.381703738232;6713.227978782503;6794.9660251699415;6803.965980170067;6898.586084834826;761.265378909344;787.5274835099009;882.4440602420563;887.9911200888038;950.4677380666849;25713.742862571507;27731.306717332227;27887.581686274723;28214.576781348296;28394.85802570974;882.7748924024332;904.0101089307198;928.4243768863348;953.909378609031;990.2770977186694;14439.566812995627;14857.405703771728;14881.70236595262;14965.775513367309;15170.089794612139;373196;376347;376681.1165944153;376987;377421;42148.57851421508;43219.567804322185;47998.28002579964;49553.75223123861;49703.502964969884;1140.4525827602797;1156.4160099149708;1169.5789515774316;1176.4999875053068;1186.353437376649;27484.58773118445;28687.569686454302;29345;29529.85235073811;29710;42672.78663606662;43147.352789708806;43198.35202472028;43214.351784722625;43251.13497729965;325015;327263;327396;328484;328746;24521.50956980886;25324.620130697687;25424;25778.742212578385;25834.35414114662;40407.1918561633;40547.59452405438;40915.38626920539;42156;44049.339259910485;35410.46884296686;36103.27793444169;36471.45292820557;36700.26599468049;36832.631673683994;35828.283434331686;35910;36038.33290841203;36559;36838.63161368352;35427.82286088553;35524.28951420906;35773.1056723584;36058.45912311265;36390.818045909604;30541;33023.834880825445;33123.83438082794;36066.639333607374;36322.8183859079;24508.877455612608;24934.127305544218;25044.123455678964;25339.366515836515;25490.362740931625 15:41:43 INFO - PROCESS | 32569 | |2;jquery.html;343.6700767263427;364.4424031232215;366.76343758275914;370.24839575661406;379.660204117315;12025.458854351553;15338.769918451218;15469.690606187869;17032.914835425807;17194.82805171948;15849.366025359;16234.10712410817;16637.251323690434;16758.83241167588;16766.41317553886;4094.078832262747;4247.766372849492;4622.39908811854;4781.6413768967295;4840.806367745286;4992.375953005874;5106.540411362977;5114.43741188469;5114.923276150861;5115.283860259567;5080.491950804909;5085.618578606601;5085.974570127163;5289.86775330616;5591.161325801122;5540.445955404468;5585.162225666142;5589.524890384322;5601.635893666919;5604.495595396434;5258.973705131488;5387.272718183034;5430.67415955044;5431;5434.646747961409;11798.292102473879;12429.31638759868;12437.564685235973;12639.1784534005;12740.108192426535;1826.6803309420798;1857.535616095976;1858.5353661584604;1887.6602211601905;2092.299079808266;8439.957800211021;8817.426867253607;9198.954005229998;9498.335116541844;9754.512274386323;1718.6304944437006;1724.3706047292649;1774.1306759687789;1800.1539276540004;1820.2718912435;65792;68895.31104688939;70910;72347.27652723459;72788.90816637808;9665.951670241744;10064.295499314978;10103.33634441478;10192.541335639915;10315.587376505006;13569.592912212649;13711.588652340446;13885.652858678412;13887.305634718223;13904.791428128587;5518.117101263779;5591.10542313228;5751.309842818805;6350.682465876687;6630.171228596426;5910.556708246899;5952.672603006789;6093.75624974996;6118.694065296718;6133.6319820810895;4121.4848143982;4171.561985991488;4182.519010313853;4258.1057977824385;4333.285007973649;1774.600714839151;1820.7724034495689;1835.5135888989428;1870.6819840626854;1878.1360574135776;778.875379939207;803.61426515273;839.1123439667177;855.6748435594559;885.6634478897978;16268.837311626732;16641.251143698562;16782.328706851833;16919.407820726214;17640.91179544094;843.8481073406846;854.786303424144;866.2420382165606;873.7728190670472;883.1874675298741;9160.908390916138;9436.480993545421;9705.272104592184;9720.902790971999;9779.119879210904;350295;355696;355713;356302;356510;43094.353584696255;43321.78339108284;55539.72230138904;69505.95741063888;77950.99999999886;877.1929824561419;883.1036497954581;885.751989442957;886.1935638569;889.4263200235812;14750.188739618994;15118;15439.150846703089;15469.5359139226;15695.764563531327;37240.813795930844;37243.44134837925;37639;37710;38275.617243827204;48833.75583122062;49856.501434985184;50087;50227;52192.478075218765;7583;7639.427042971688;7724.343430808444;7729.961350193213;7771.222877712184;10581.682549523526;11076.778464430505;11627.88372116268;11673.649790506299;12177.208481448677;10304;10499.212559058255;10512.632057877938;10632.511448397076;10789.514471848943;10017.148542373689;10196.705741208169;10482.161427085968;10529;10603.151747860307;9770.951145244228;10262;10439.791204175723;10603.46982650849;10892.455377231265;7595.240475952361;7652.73215437457;7835.608219589112;7917.168697286932;7927.167647397171;10214.540345684314;10510.1066409353;10518.105960993402;10528.789424211625;11017.173711971795 15:41:43 INFO - PROCESS | 32569 | |3;mootools.html;1208.806590945449;1301.1932601786891;1358.0425799811135;1359.1165742267524;1597.3850067723922;6225.315215326316;6847.965760171199;7109.85780284394;7117.822054448648;7251.601161936104;7053.294670532944;7107.8933815992805;7123.465740069502;7126.287371262871;7129.07322048133;2028.1583142995676;2056.670932650776;2056.979430205701;2061.907214175366;2063.9793602064015;2055.629986602411;2089.0390420406557;2089.268755935426;2091.4771307173205;2096.5387614724737;2012.0845015517978;2012.8087831655969;2013.2148462099792;2016.67733162694;2018.7080268628017;2010.2461576908659;2018.6366454038268;2019.0813180003063;2020.1313435222849;2020.6867935469952;1922.5193701574606;1934.1199754111844;1939.3115444017453;1939.5732938753451;1956.6575849226472;6728.394444500019;7134.750283740096;7227.638618069075;7246.311600397954;7248.275172482762;4300.8709738707885;4496.572825581565;4501.212287849613;4503.909921801578;4519.683622146451;2664.6802383713884;2742.3829638331417;2792.944141117166;2801.7478426941675;2812.8874845006176;864.4726716702806;871.3273551978441;886.3618194899661;896.914793094655;909.7543663210962;8729.956350218272;8773.956130219372;8774.517401542913;8845.4250473719;8881.289496840238;3507.649235076472;3601.85592576294;3634.236810269873;3727.422249551324;3740.9625903741157;7269;7271.309225623663;7275.490715649854;7284.963575182091;7289.854202915912;4132.090939993197;4151.024509240327;4151.8962025949595;4152.1072969311745;4153.563875793058;3169.6354919184128;3254.446744053517;3889.669378102893;3898.4152377143087;3909.863154789569;3191.6170059592996;3196.440622891031;3302.0589132097716;3321.319129578479;3335.182880194368;1101.388729255255;1114.8104822180248;1124.471498395769;1126.222906194723;1149.0979581028853;778.5601135358504;796.7968168117093;801.4950581133849;809.5426084262373;816.4488969945263;4910.420037150165;4915.4347250065985;4961.231009193581;5093.9745301274;5164.78331056749;371.6320842366092;373.2572181359076;378.7216395948975;379.7626483447845;386.3952913690066;3329.8501567429525;3421.760476766652;3455.6198818129988;3460.5501284832812;3654.8903532894055;8100.878486822702;8459.06950235486;8466.703665371682;8482.406231563855;8484.787880303042;8405.033421156522;8426.747197584082;8429.789255268668;8439.578021099043;8443.113473085361;6559;6607.537472376887;6618.536702430783;6626.966865165643;6634.502412319095;4746.4541577719;4802.327674125555;4824.927626085541;4929.482404347636;4972.428170760409;7350.70597176107;7416.4066874648815;7646.617669116633;7652.426068045031;7677.117131529945;7616.3906887449975;7638.694452221849;7665.961670191613;7687.615619219128;7736.92263077362;5482.150266708666;6088.269407671108;6211.9689401552705;6227.06594010902;6234.812955611339;6268.905966410599;6484.416402523795;6795.93204067953;6801.455883529206;6966.582005079711;6309.085182648582;6320.683965801783;6343.904841427475;6376.330485298977;6460.289368169591;6206.379362063757;6236.064590311489;6238.656873871799;6245;6255.46828519581;5631.1271752878365;5636.351819540805;5646.576506761927;5661.094224923992;5661.179129026185;4299.591538803808;4351.8476853309985;4455.398521199597;4472.3515090311075;4536.092781443658;4151.481064866892;4332.3068309070395;4413;4418.646508279394;4540.367072433973 15:41:43 INFO - PROCESS | 32569 | |4;prototype.html;288.3569639703461;291.081637433896;296.055582691215;296.28151732049776;298.8386271413437;4734.810607575697;4767.6662633615615;4788.52114788521;4800;4802.855914322571;4714.5285471452835;4725.480197178316;4726.976365118169;4740.217864052427;4747.454042785081;3528.523649307336;3618.8371523281385;3652.9086772830624;3704.9814750926207;3752.6545908806997;3732.141607430293;3740.8690695825653;3747.906302342436;3751.6623503884643;3756.0797604586915;3708.2768860072297;3728.7576307540057;3730.384486559728;3740.121071548184;3750.5874353821196;3559.555055618048;3633.454981752732;3668.853245870162;3682.281955018759;3704.49989251453;3267.77125601208;3276.311974485337;3278.3115545735423;3278.426275401819;3286.65490123536;4650.9767451162525;4670.9766451167525;4675.719456832567;4694.577488026094;4697.459792123916;4148.771817550033;4188.764314527221;4218.894527636803;4259.531451540328;4262.147570485915;4912.71558725191;4923.409190897115;4933.161362568336;4940;4950.3069570260195;3589.784612923233;3605.557776889239;3605.963940360589;3611.9638803611892;3627.981860090683;4992.625553083533;5149.562287205592;5226.608004399647;5245.501677340685;5264.710440925747;3646.5441819772527;3652.5616925969052;3659.9451008234364;3661.6155303693263;3674.2651469706166;3722.3485889969147;3728.8135593220773;3731.9440208396895;3758.473813666089;3759.342115129841;4235.343521754133;4246.639035682002;4248.129133527619;4261.275583150872;4269.630355152858;4776.92519183188;4898.093852637274;4936.259561065797;4959;4963.8262660806695;1263.92416455013;1268.2644066441442;1277.920157466939;1281.769281529315;1293.5666551705096;802.8238630406366;816.6243527977197;828.3994104274353;836.1972506393809;841.2050612171439;4297.957020429756;4309.784510774512;4475.731456112644;4498.05540836428;4499.482559505634;5079.6952182869145;5102.311187989574;5144.717040562805;5149.330587023738;5167.612429067835;4449.243628583149;4466.620337271368;4470.5976462117915;4514.68397212192;4516.796744146522;2577.819552631298;2719.945601087967;2721.632579601768;2733.2346942856034;2740.5615101583653;4821.035063436032;4822.855314340575;4863.3434486343895;4870;4893.681910675795;5004.424491183488;5244.737763111829;5257.973710131425;5282.102042652681;5296.364436267672;4814.253790662453;4823.758812059383;4851.32081508582;4854.732989685601;4857.854264372075;5117.462666420121;5118.43697193301;5119.974400127976;5120.871978200575;5147.691138531551;4840.34655321527;4994.625403094855;5018.372703412074;5023.673461225008;5039.722815245197;4823.686460380064;4848.75756212195;4874.829380971649;4878.609711223023;4880.341153944172;3626.383514802543;3629.4374371972385;3662.1760103976394;3663.945040824443;3670.3209906167444;5012.774425150804;5172.793088276427;5174.197999310113;5223.582113430993;5230;4986.908116967504;5000.749962501933;5001.374828146481;5003.3495645565845;5026.371703537058;4980.477049909708;4989.401271847401;4990.850274491771;4997.9500204997485;5006.549410552922;4673.532646735299;4917.754112294442;4923.606111511142;4936.679115857458;4943.283223932582;4808.495108013748;4828;4905.313256144214;5022.547970682656;5031.52200540948;4874.2444921037295;4875.878103047452;4919.729414882073;4941.382327209099;4943.332650092335 15:41:43 INFO - PROCESS | 32569 | |5;yui.html;595.9582829201955;675.1290834823078;707.3351050012988;724.5725022236879;737.2369597466621;12373.752524949507;13102.08285420021;13109.934450327759;13127.6718082048;13141.342932853368;13289.335533223348;13327.800082998763;13433;13463.057585968985;13471.191728496296;585.5959388022272;600.7026521871679;715.4955756191898;718.2817182817183;736.7458226911733;742.907136607924;744.4528271720309;746.5669911451345;747.0512449189526;752.7064444866506;792.8889955406248;792.9920700792976;793.845200185964;794.027316537243;794.5113755040637;615.0896672924075;629.3329071184536;761.3414396547003;780.2275747010419;782.2529484342496;577.4831525784399;577.7573419163962;578.2569398323135;578.5863107877846;578.8147792706336;12069.456874440672;12189.085818563643;12198;12202.450889709984;12202.877971220263;11942.40287985606;12031.57889473873;12385.690357741038;12420.75158496825;12441.191322564004;11315.924987126293;11460.140489463323;11560;11652.242604230698;11987.400629968466;4068.471098757172;4106.240345536055;4160.251154792136;4166.541680415152;4203.579642035803;60055;61743.07385389223;61743.6912815433;61912.071318930255;64118;9732.814889597541;10425;10488.737781555523;10553.366797992145;10609.681709548726;18792.71810922837;18972.24111035543;19038.33365832189;19099.427017189508;19117;6392.840178995562;6450.903236451457;6536.281009088996;6593.86812263752;6719.260881303053;3481.268933523938;3580.874669386611;3601.5318008658705;3628.546431696038;3648.726345524043;2632.2761240658974;2712.091449364485;2718.945621087607;2724.019353032946;2731.2489065506747;453.3064411450486;461.61455184920965;461.8522072936628;467.4414075180195;478.91764611976487;502.1739238951977;510.58897587441726;529.9258103865462;542.0892899928159;545.1550097349093;7705.952601046323;7829.491083079582;7910.327622152066;7912.881306780403;8085.595720213966;531.8909623527245;532.9653572517774;542.9077056900336;547.3103889099683;567.4212303450457;3473.14907847579;3598.676119149289;3657.231981283907;3667.889963301105;3800.4299355096955;54884;55175.17237241445;63032;93591;100589.99410005953;85408;90029.54985225163;90868;92471;92480;77278.61360693385;77628.22371776323;77877;78188;78790;6834.589448631337;7190.334435319502;7306.634668266672;7452.441066920112;7512.849743005218;44361;45379.773101134284;45799;47073.76463117662;47179;60190.39809601848;60615.39384606274;64885;66069;67013.3298667007;8644.56777161152;8885.644574216958;9129.49787761653;9256.72229833106;9321.394109382869;9255.861162082709;9325.943214701627;9508.429494230368;9719.9028009719;9835.950820245853;9218.26253899673;9391.201747851235;9397.859032114387;9844.409335439897;9926.851097233402;8438.240558349778;8613.181747733955;8733.301335892986;8807.251383632463;8833.160849719266;9016.819663606822;9350.906490935004;9562.521873906138;9603.03969603034;9666.226701863694;7763.922360776546;7801.4929029612895;7909.564973926489;8084.191580841869;8352.415330926777;7324.304191101837;7843.647035883513;8160.632771525415;8243.752687419386;8256.545889975869 15:41:43 INFO - PROCESS | 32569 | __end_tp_report 15:41:43 INFO - PROCESS | 32569 | __start_cc_report 15:41:43 INFO - PROCESS | 32569 | _x_x_mozilla_cycle_collect,1349 15:41:43 INFO - PROCESS | 32569 | __end_cc_report 15:41:43 INFO - PROCESS | 32569 | __startTimestamp1475880103937__endTimestamp 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | ------- Summary: start ------- 15:41:43 INFO - PROCESS | 32569 | Number of tests: 6 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#0] dojo.html Cycles:165 Average:4495.52 Median:4611.24 stddev:457.34 (9.9%) stddev-sans-first:431.26 15:41:43 INFO - PROCESS | 32569 | Values: 2504.8 2528.9 2536.0 2557.9 2567.1 4422.9 4488.2 4586.9 4592.6 4600.8 4486.5 4504.8 4507.9 4513.0 4521.8 4156.0 4173.6 4174.9 4216.4 4260.5 4242.7 4249.5 4263.0 4286.4 4304.2 4250.5 4265.6 4272.7 4328.9 4329.4 4172.9 4285.5 4287.4 4296.6 4306.2 4061.3 4124.5 4153.1 4175.6 4201.7 4441.0 4493.9 4494.4 4506.7 4507.0 4747.6 4787.8 4788.3 4793.9 4799.1 4814.9 4849.6 4896.6 4906.4 4915.6 4578.7 4644.4 4648.2 4654.0 4703.6 5064.3 5073.4 5073.9 5080.6 5146.4 4674.8 4725.9 4733.9 4771.0 4787.0 4835.2 4869.7 4882.8 4884.9 4928.6 4770.9 4803.3 4804.2 4807.6 4867.0 4653.5 4714.8 4717.1 4766.9 4767.7 4113.1 4135.5 4142.5 4143.4 4148.4 3595.1 3620.7 3645.3 3653.7 3698.9 4243.2 4243.3 4245.4 4290.3 4301.1 4881.6 4891.2 4897.5 4899.9 4966.8 4112.1 4188.7 4188.8 4193.7 4228.3 4408.7 4410.7 4453.4 4463.8 4465.2 4577.8 4588.9 4591.0 4593.0 4604.7 4777.5 4778.4 4870.4 4879.0 4881.5 4509.6 4525.3 4530.1 4560.6 4578.3 4722.8 4730.9 4733.1 4737.1 4793.4 4730.8 4776.3 4797.5 4798.3 4852.0 4635.0 4658.5 4674.7 4708.8 4742.4 4672.3 4676.6 4680.8 4686.1 4731.8 4581.3 4611.2 4621.1 4626.6 4675.5 4658.8 4741.1 4752.4 4810.8 4819.0 4706.9 4713.1 4716.3 4763.2 4772.4 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#1] ext.html Cycles:180 Average:45164.69 Median:35974.17 stddev:81034.46 (225.3%) stddev-sans-first:81192.56 15:41:43 INFO - PROCESS | 32569 | Values: 556.2 563.9 568.2 569.5 577.0 28020.2 28719.4 38419.4 40189.8 40262.8 39880.0 40392.4 40410.8 40429.8 40523.4 7423.9 7571.0 7575.1 7575.3 7575.4 7040.6 7251.1 7251.2 7395.3 7516.5 9538.8 9840.0 9844.3 10125.8 10137.5 10059.2 10113.6 10127.1 10134.1 10143.4 9740.0 9955.0 9969.5 9970.7 9971.2 38441.6 38798.4 38809.8 38816.2 38850.0 2832.6 2884.3 2900.4 2992.8 3223.8 27303.5 27812.3 28096.7 28121.3 28689.4 3204.0 3333.1 3359.3 3381.6 3394.4 184824.0 187017.0 187332.0 187830.0 187853.0 52436.5 52805.5 52939.0 52967.0 53013.2 32707.0 33245.8 33416.3 56716.4 56910.7 13356.5 13769.0 13780.3 13784.6 13791.9 10582.3 10670.3 10675.7 10677.3 10681.4 15399.0 15776.8 17332.5 17853.7 17969.2 6508.4 6713.2 6795.0 6804.0 6898.6 761.3 787.5 882.4 888.0 950.5 25713.7 27731.3 27887.6 28214.6 28394.9 882.8 904.0 928.4 953.9 990.3 14439.6 14857.4 14881.7 14965.8 15170.1 373196.0 376347.0 376681.1 376987.0 377421.0 42148.6 43219.6 47998.3 49553.8 49703.5 1140.5 1156.4 1169.6 1176.5 1186.4 27484.6 28687.6 29345.0 29529.9 29710.0 42672.8 43147.4 43198.4 43214.4 43251.1 325015.0 327263.0 327396.0 328484.0 328746.0 24521.5 25324.6 25424.0 25778.7 25834.4 40407.2 40547.6 40915.4 42156.0 44049.3 35410.5 36103.3 36471.5 36700.3 36832.6 35828.3 35910.0 36038.3 36559.0 36838.6 35427.8 35524.3 35773.1 36058.5 36390.8 30541.0 33023.8 33123.8 36066.6 36322.8 24508.9 24934.1 25044.1 25339.4 25490.4 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#2] jquery.html Cycles:180 Average:22472.84 Median:4177.04 stddev:58560.55 (1402.0%) stddev-sans-first:58701.25 15:41:43 INFO - PROCESS | 32569 | Values: 343.7 364.4 366.8 370.2 379.7 12025.5 15338.8 15469.7 17032.9 17194.8 15849.4 16234.1 16637.3 16758.8 16766.4 4094.1 4247.8 4622.4 4781.6 4840.8 4992.4 5106.5 5114.4 5114.9 5115.3 5080.5 5085.6 5086.0 5289.9 5591.2 5540.4 5585.2 5589.5 5601.6 5604.5 5259.0 5387.3 5430.7 5431.0 5434.6 11798.3 12429.3 12437.6 12639.2 12740.1 1826.7 1857.5 1858.5 1887.7 2092.3 8440.0 8817.4 9199.0 9498.3 9754.5 1718.6 1724.4 1774.1 1800.2 1820.3 65792.0 68895.3 70910.0 72347.3 72788.9 9666.0 10064.3 10103.3 10192.5 10315.6 13569.6 13711.6 13885.7 13887.3 13904.8 5518.1 5591.1 5751.3 6350.7 6630.2 5910.6 5952.7 6093.8 6118.7 6133.6 4121.5 4171.6 4182.5 4258.1 4333.3 1774.6 1820.8 1835.5 1870.7 1878.1 778.9 803.6 839.1 855.7 885.7 16268.8 16641.3 16782.3 16919.4 17640.9 843.8 854.8 866.2 873.8 883.2 9160.9 9436.5 9705.3 9720.9 9779.1 350295.0 355696.0 355713.0 356302.0 356510.0 43094.4 43321.8 55539.7 69506.0 77951.0 877.2 883.1 885.8 886.2 889.4 14750.2 15118.0 15439.2 15469.5 15695.8 37240.8 37243.4 37639.0 37710.0 38275.6 48833.8 49856.5 50087.0 50227.0 52192.5 7583.0 7639.4 7724.3 7730.0 7771.2 10581.7 11076.8 11627.9 11673.6 12177.2 10304.0 10499.2 10512.6 10632.5 10789.5 10017.1 10196.7 10482.2 10529.0 10603.2 9771.0 10262.0 10439.8 10603.5 10892.5 7595.2 7652.7 7835.6 7917.2 7927.2 10214.5 10510.1 10518.1 10528.8 11017.2 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#3] mootools.html Cycles:180 Average:4597.87 Median:4945.36 stddev:2470.73 (50.0%) stddev-sans-first:2464.53 15:41:43 INFO - PROCESS | 32569 | Values: 1208.8 1301.2 1358.0 1359.1 1597.4 6225.3 6848.0 7109.9 7117.8 7251.6 7053.3 7107.9 7123.5 7126.3 7129.1 2028.2 2056.7 2057.0 2061.9 2064.0 2055.6 2089.0 2089.3 2091.5 2096.5 2012.1 2012.8 2013.2 2016.7 2018.7 2010.2 2018.6 2019.1 2020.1 2020.7 1922.5 1934.1 1939.3 1939.6 1956.7 6728.4 7134.8 7227.6 7246.3 7248.3 4300.9 4496.6 4501.2 4503.9 4519.7 2664.7 2742.4 2792.9 2801.7 2812.9 864.5 871.3 886.4 896.9 909.8 8730.0 8774.0 8774.5 8845.4 8881.3 3507.6 3601.9 3634.2 3727.4 3741.0 7269.0 7271.3 7275.5 7285.0 7289.9 4132.1 4151.0 4151.9 4152.1 4153.6 3169.6 3254.4 3889.7 3898.4 3909.9 3191.6 3196.4 3302.1 3321.3 3335.2 1101.4 1114.8 1124.5 1126.2 1149.1 778.6 796.8 801.5 809.5 816.4 4910.4 4915.4 4961.2 5094.0 5164.8 371.6 373.3 378.7 379.8 386.4 3329.9 3421.8 3455.6 3460.6 3654.9 8100.9 8459.1 8466.7 8482.4 8484.8 8405.0 8426.7 8429.8 8439.6 8443.1 6559.0 6607.5 6618.5 6627.0 6634.5 4746.5 4802.3 4824.9 4929.5 4972.4 7350.7 7416.4 7646.6 7652.4 7677.1 7616.4 7638.7 7666.0 7687.6 7736.9 5482.2 6088.3 6212.0 6227.1 6234.8 6268.9 6484.4 6795.9 6801.5 6966.6 6309.1 6320.7 6343.9 6376.3 6460.3 6206.4 6236.1 6238.7 6245.0 6255.5 5631.1 5636.4 5646.6 5661.1 5661.2 4299.6 4351.8 4455.4 4472.4 4536.1 4151.5 4332.3 4413.0 4418.6 4540.4 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#4] prototype.html Cycles:180 Average:4146.03 Median:4743.84 stddev:1202.33 (25.3%) stddev-sans-first:1170.32 15:41:43 INFO - PROCESS | 32569 | Values: 288.4 291.1 296.1 296.3 298.8 4734.8 4767.7 4788.5 4800.0 4802.9 4714.5 4725.5 4727.0 4740.2 4747.5 3528.5 3618.8 3652.9 3705.0 3752.7 3732.1 3740.9 3747.9 3751.7 3756.1 3708.3 3728.8 3730.4 3740.1 3750.6 3559.6 3633.5 3668.9 3682.3 3704.5 3267.8 3276.3 3278.3 3278.4 3286.7 4651.0 4671.0 4675.7 4694.6 4697.5 4148.8 4188.8 4218.9 4259.5 4262.1 4912.7 4923.4 4933.2 4940.0 4950.3 3589.8 3605.6 3606.0 3612.0 3628.0 4992.6 5149.6 5226.6 5245.5 5264.7 3646.5 3652.6 3659.9 3661.6 3674.3 3722.3 3728.8 3731.9 3758.5 3759.3 4235.3 4246.6 4248.1 4261.3 4269.6 4776.9 4898.1 4936.3 4959.0 4963.8 1263.9 1268.3 1277.9 1281.8 1293.6 802.8 816.6 828.4 836.2 841.2 4298.0 4309.8 4475.7 4498.1 4499.5 5079.7 5102.3 5144.7 5149.3 5167.6 4449.2 4466.6 4470.6 4514.7 4516.8 2577.8 2719.9 2721.6 2733.2 2740.6 4821.0 4822.9 4863.3 4870.0 4893.7 5004.4 5244.7 5258.0 5282.1 5296.4 4814.3 4823.8 4851.3 4854.7 4857.9 5117.5 5118.4 5120.0 5120.9 5147.7 4840.3 4994.6 5018.4 5023.7 5039.7 4823.7 4848.8 4874.8 4878.6 4880.3 3626.4 3629.4 3662.2 3663.9 3670.3 5012.8 5172.8 5174.2 5223.6 5230.0 4986.9 5000.7 5001.4 5003.3 5026.4 4980.5 4989.4 4990.9 4998.0 5006.5 4673.5 4917.8 4923.6 4936.7 4943.3 4808.5 4828.0 4905.3 5022.5 5031.5 4874.2 4875.9 4919.7 4941.4 4943.3 15:41:43 INFO - PROCESS | 32569 | 15:41:43 INFO - PROCESS | 32569 | [#5] yui.html Cycles:180 Average:16908.96 Median:61827.88 stddev:24651.65 (39.9%) stddev-sans-first:24690.37 15:41:43 INFO - PROCESS | 32569 | Values: 596.0 675.1 707.3 724.6 737.2 12373.8 13102.1 13109.9 13127.7 13141.3 13289.3 13327.8 13433.0 13463.1 13471.2 585.6 600.7 715.5 718.3 736.7 742.9 744.5 746.6 747.1 752.7 792.9 793.0 793.8 794.0 794.5 615.1 629.3 761.3 780.2 782.3 577.5 577.8 578.3 578.6 578.8 12069.5 12189.1 12198.0 12202.5 12202.9 11942.4 12031.6 12385.7 12420.8 12441.2 11315.9 11460.1 11560.0 11652.2 11987.4 4068.5 4106.2 4160.3 4166.5 4203.6 60055.0 61743.1 61743.7 61912.1 64118.0 9732.8 10425.0 10488.7 10553.4 10609.7 18792.7 18972.2 19038.3 19099.4 19117.0 6392.8 6450.9 6536.3 6593.9 6719.3 3481.3 3580.9 3601.5 3628.5 3648.7 2632.3 2712.1 2718.9 2724.0 2731.2 453.3 461.6 461.9 467.4 478.9 502.2 510.6 529.9 542.1 545.2 7706.0 7829.5 7910.3 7912.9 8085.6 531.9 533.0 542.9 547.3 567.4 3473.1 3598.7 3657.2 3667.9 3800.4 54884.0 55175.2 63032.0 93591.0 100590.0 85408.0 90029.5 90868.0 92471.0 92480.0 77278.6 77628.2 77877.0 78188.0 78790.0 6834.6 7190.3 7306.6 7452.4 7512.8 44361.0 45379.8 45799.0 47073.8 47179.0 60190.4 60615.4 64885.0 66069.0 67013.3 8644.6 8885.6 9129.5 9256.7 9321.4 9255.9 9325.9 9508.4 9719.9 9836.0 9218.3 9391.2 9397.9 9844.4 9926.9 8438.2 8613.2 8733.3 8807.3 8833.2 9016.8 9350.9 9562.5 9603.0 9666.2 7763.9 7801.5 7909.6 8084.2 8352.4 7324.3 7843.6 8160.6 8243.8 8256.5 15:41:43 INFO - PROCESS | 32569 | -------- Summary: end -------- 15:41:43 INFO - PROCESS | 32569 | 15:41:44 INFO - TEST-INFO | 32569: exit 0 15:41:44 INFO - TEST-OK | dromaeo_css | took 1122177ms 15:41:44 INFO - TEST-START | kraken 15:41:44 INFO - operating with platform_type : linux_ 15:41:44 INFO - Initialising browser for kraken test... 15:41:44 INFO - TEST-INFO | started process 411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp6vNl/profile http://localhost:39305/getInfo.html) 15:41:49 INFO - PROCESS | 411 | __metrics Screen width/height:1600/1200 15:41:49 INFO - PROCESS | 411 | colorDepth:24 15:41:49 INFO - PROCESS | 411 | Browser inner width/height: 1024/697 15:41:49 INFO - PROCESS | 411 | __metrics 15:41:50 INFO - PROCESS | 411 | 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" 15:41:50 INFO - PROCESS | 411 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:50 INFO - PROCESS | 411 | console.error: PushService: 15:41:50 INFO - PROCESS | 411 | stateChangeProcessEnqueue: Error transitioning state 15:41:50 INFO - PROCESS | 411 | UnknownError 15:41:51 INFO - TEST-INFO | 411: exit 0 15:41:51 INFO - Browser initialized. 15:41:51 INFO - Running cycle 1/1 for kraken test... 15:41:51 INFO - TEST-INFO | started process 493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp6vNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:03 INFO - PROCESS | 493 | RSS: Main: 174514176 15:42:03 INFO - PROCESS | 493 | 15:42:06 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39305/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:07 INFO - PROCESS | 493 | RSS: Main: 241545216 15:42:07 INFO - PROCESS | 493 | 15:42:10 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39305/tests/kraken/driver.html?testName=audio-dft) 15:42:10 INFO - PROCESS | 493 | RSS: Main: 217718784 15:42:10 INFO - PROCESS | 493 | 15:42:14 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39305/tests/kraken/driver.html?testName=audio-fft) 15:42:14 INFO - PROCESS | 493 | RSS: Main: 299937792 15:42:14 INFO - PROCESS | 493 | 15:42:16 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39305/tests/kraken/driver.html?testName=audio-oscillator) 15:42:17 INFO - PROCESS | 493 | RSS: Main: 210358272 15:42:17 INFO - PROCESS | 493 | 15:42:19 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39305/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:20 INFO - PROCESS | 493 | RSS: Main: 213610496 15:42:20 INFO - PROCESS | 493 | 15:42:23 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39305/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:24 INFO - PROCESS | 493 | RSS: Main: 249659392 15:42:24 INFO - PROCESS | 493 | 15:42:27 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39305/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:28 INFO - PROCESS | 493 | RSS: Main: 244310016 15:42:28 INFO - PROCESS | 493 | 15:42:31 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39305/tests/kraken/driver.html?testName=json-parse-financial) 15:42:31 INFO - PROCESS | 493 | RSS: Main: 246767616 15:42:31 INFO - PROCESS | 493 | 15:42:33 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39305/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:34 INFO - PROCESS | 493 | RSS: Main: 210071552 15:42:34 INFO - PROCESS | 493 | 15:42:36 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:36 INFO - PROCESS | 493 | RSS: Main: 216715264 15:42:36 INFO - PROCESS | 493 | 15:42:38 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:39 INFO - PROCESS | 493 | RSS: Main: 226443264 15:42:39 INFO - PROCESS | 493 | 15:42:42 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:43 INFO - PROCESS | 493 | RSS: Main: 235388928 15:42:43 INFO - PROCESS | 493 | 15:42:46 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:46 INFO - PROCESS | 493 | RSS: Main: 232353792 15:42:46 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:39305/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39305/tests/kraken/driver.html?testName=ai-astar) 15:42:48 INFO - PROCESS | 493 | RSS: Main: 283877376 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | __start_tp_report 15:42:48 INFO - PROCESS | 493 | _x_x_mozilla_page_load 15:42:48 INFO - PROCESS | 493 | _x_x_mozilla_page_load_details 15:42:48 INFO - PROCESS | 493 | |i|pagename|runs| 15:42:48 INFO - PROCESS | 493 | |0;ai-astar;112;116;117;115;114;114;114;114;115;115 15:42:48 INFO - PROCESS | 493 | |1;audio-beat-detection;154;133;132;169;131;133;126;126;169;129 15:42:48 INFO - PROCESS | 493 | |2;audio-dft;160;162;162;162;162;161;161;161;160;161 15:42:48 INFO - PROCESS | 493 | |3;audio-fft;77;76;77;107;78;76;76;75;114;76 15:42:48 INFO - PROCESS | 493 | |4;audio-oscillator;83;84;121;84;85;84;107;84;83;117 15:42:48 INFO - PROCESS | 493 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;117;116 15:42:48 INFO - PROCESS | 493 | |6;imaging-darkroom;146;147;146;145;147;147;148;147;147;147 15:42:48 INFO - PROCESS | 493 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 15:42:48 INFO - PROCESS | 493 | |8;json-parse-financial;65;64;64;63;66;67;65;65;65;65 15:42:48 INFO - PROCESS | 493 | |9;json-stringify-tinderbox;66;66;67;66;67;65;68;68;67;67 15:42:48 INFO - PROCESS | 493 | |10;stanford-crypto-aes;84;83;84;85;84;83;83;89;87;83 15:42:48 INFO - PROCESS | 493 | |11;stanford-crypto-ccm;142;154;146;140;139;148;139;139;184;147 15:42:48 INFO - PROCESS | 493 | |12;stanford-crypto-pbkdf2;181;184;176;178;176;181;183;185;179;177 15:42:48 INFO - PROCESS | 493 | |13;stanford-crypto-sha256-iterative;70;70;69;69;70;75;70;70;70;70 15:42:48 INFO - PROCESS | 493 | __end_tp_report 15:42:48 INFO - PROCESS | 493 | __start_cc_report 15:42:48 INFO - PROCESS | 493 | _x_x_mozilla_cycle_collect,1918 15:42:48 INFO - PROCESS | 493 | __end_cc_report 15:42:48 INFO - PROCESS | 493 | __startTimestamp1475880168768__endTimestamp 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | ------- Summary: start ------- 15:42:48 INFO - PROCESS | 493 | Number of tests: 14 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 15:42:48 INFO - PROCESS | 493 | Values: 112.0 116.0 117.0 115.0 114.0 114.0 114.0 114.0 115.0 115.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:133.00 stddev:17.11 (12.9%) stddev-sans-first:17.40 15:42:48 INFO - PROCESS | 493 | Values: 154.0 133.0 132.0 169.0 131.0 133.0 126.0 126.0 169.0 129.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.71 15:42:48 INFO - PROCESS | 493 | Values: 160.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 160.0 161.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:14.51 (19.1%) stddev-sans-first:15.21 15:42:48 INFO - PROCESS | 493 | Values: 77.0 76.0 77.0 107.0 78.0 76.0 76.0 75.0 114.0 76.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:15.43 (18.4%) stddev-sans-first:15.92 15:42:48 INFO - PROCESS | 493 | Values: 83.0 84.0 121.0 84.0 85.0 84.0 107.0 84.0 83.0 117.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 15:42:48 INFO - PROCESS | 493 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 15:42:48 INFO - PROCESS | 493 | Values: 146.0 147.0 146.0 145.0 147.0 147.0 148.0 147.0 147.0 147.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:42:48 INFO - PROCESS | 493 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 15:42:48 INFO - PROCESS | 493 | Values: 65.0 64.0 64.0 63.0 66.0 67.0 65.0 65.0 65.0 65.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 15:42:48 INFO - PROCESS | 493 | Values: 66.0 66.0 67.0 66.0 67.0 65.0 68.0 68.0 67.0 67.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.01 (2.4%) stddev-sans-first:2.13 15:42:48 INFO - PROCESS | 493 | Values: 84.0 83.0 84.0 85.0 84.0 83.0 83.0 89.0 87.0 83.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:146.50 stddev:13.66 (9.3%) stddev-sans-first:14.33 15:42:48 INFO - PROCESS | 493 | Values: 142.0 154.0 146.0 140.0 139.0 148.0 139.0 139.0 184.0 147.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:181.00 stddev:3.30 (1.8%) stddev-sans-first:3.48 15:42:48 INFO - PROCESS | 493 | Values: 181.0 184.0 176.0 178.0 176.0 181.0 183.0 185.0 179.0 177.0 15:42:48 INFO - PROCESS | 493 | 15:42:48 INFO - PROCESS | 493 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.80 15:42:48 INFO - PROCESS | 493 | Values: 70.0 70.0 69.0 69.0 70.0 75.0 70.0 70.0 70.0 70.0 15:42:48 INFO - PROCESS | 493 | -------- Summary: end -------- 15:42:48 INFO - PROCESS | 493 | 15:42:50 INFO - TEST-INFO | 493: exit 0 15:42:50 INFO - TEST-OK | kraken | took 65243ms 15:42:50 INFO - SUITE-END | took 1187s 15:42:50 INFO - Completed test suite (00:19:47) 15:42:50 INFO - javascript benchmark 15:42:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2504.849709017459, 2528.949421011581, 2535.974640253597, 2557.8976840926366, 2567.0630219969703, 4422.911541769163, 4488.192125417424, 4586.908261834766, 4592.586667199951, 4600.769961501924, 4486.506484286734, 4504.842330518424, 4507.864764057083, 4512.9548704512945, 4521.819127234915, 4155.979220103903, 4173.582641735818, 4174.895627609304, 4216.367544868263, 4260.467441569804, 4242.681798865097, 4249.51130619978, 4262.957370426287, 4286.378475121106, 4304.182205380983, 4250.48994120706, 4265.616094551489, 4272.743635381871, 4328.891777705551, 4329.437173167484, 4172.874813755592, 4285.46431696038, 4287.399764033038, 4296.591823776736, 4306.18182545317, 4061.289274376972, 4124.484439445069, 4153.1486045360625, 4175.561566035583, 4201.747895126302, 4441.0, 4493.887652808706, 4494.393256910308, 4506.729596224237, 4506.954930450686, 4747.572718455355, 4787.80848766049, 4788.329633851264, 4793.880152996168, 4799.064182484417, 4814.855554333376, 4849.587785038276, 4896.608271338285, 4906.386701662293, 4915.5821755150855, 4578.656600754924, 4644.373009643722, 4648.209804333272, 4653.95346046542, 4703.553162449562, 5064.290999260106, 5073.365829271341, 5073.898522029539, 5080.59355251579, 5146.408163061221, 4674.7896344663895, 4725.881852953635, 4733.928991065137, 4771.045790841846, 4787.0, 4835.153848076572, 4869.70781753096, 4882.780274887638, 4884.926726099111, 4928.6303527235605, 4770.904581908412, 4803.303520989437, 4804.2073057945745, 4807.567318941312, 4866.9513304867205, 4653.488116307203, 4714.764261786897, 4717.103750287434, 4766.928496072562, 4767.666263361601, 4113.136241389282, 4135.483064616923, 4142.502899652, 4143.3784932260405, 4148.377743338523, 3595.137167079882, 3620.7465477416326, 3645.325614761278, 3653.671169594696, 3698.8705395311035, 4243.215005224043, 4243.2998555238655, 4245.384419259251, 4290.2706539888295, 4301.118270754488, 4881.560659540658, 4891.1685013547785, 4897.534734200245, 4899.926501102486, 4966.801327946841, 4112.095339025469, 4188.748675079505, 4188.790560471964, 4193.727407718488, 4228.302330115558, 4408.713433626804, 4410.69125161242, 4453.376527286183, 4463.843765468193, 4465.218586747306, 4577.8168873244695, 4588.885277867947, 4590.954090459186, 4593.035462552902, 4604.746738929391, 4777.474477807369, 4778.402699662543, 4870.439899411613, 4878.9512104878495, 4881.51184881509, 4509.616682581886, 4525.321201819754, 4530.139273538017, 4560.6351491879905, 4578.336141259432, 4722.811087556596, 4730.929036064531, 4733.148033354029, 4737.076270127292, 4793.376861008047, 4730.834420795256, 4776.259679749644, 4797.520247975174, 4798.2802579613335, 4852.0, 4635.0, 4658.464276608233, 4674.672772905864, 4708.764561771966, 4742.359781429601, 4672.252439609646, 4676.579107880171, 4680.836170734008, 4686.133065382915, 4731.810727570859, 4581.289900065495, 4611.239145540948, 4621.1219868224925, 4626.6298696104905, 4675.532446755434, 4658.790354434126, 4741.075490279501, 4752.42970843501, 4810.831620893392, 4819.012102519046, 4706.882327941828, 4713.128071306819, 4716.339712440193, 4763.190257656276, 4772.427308722837], "value": 4466.818930341086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1990733343985, 563.8505795964068, 568.1676344155811, 569.51875665063, 577.0161874004822, 28020.15939521815, 28719.425611487783, 38419.42370864436, 40189.799051004775, 40262.79868600653, 39880.0, 40392.39411408831, 40410.7979460103, 40429.79785101078, 40523.39214911779, 7423.888641670379, 7571.0, 7575.1288601810675, 7575.318221360077, 7575.431842611799, 7040.6127662978515, 7251.129864416277, 7251.238619944883, 7395.334419902208, 7516.473846830724, 9538.809223815519, 9839.950800246024, 9844.261680373966, 10125.797484050314, 10137.543810528545, 10059.24555658325, 10113.595456181743, 10127.08856202938, 10134.138598219197, 10143.442110683909, 9740.0, 9955.0, 9969.501524923797, 9970.651027214086, 9971.202303815677, 38441.61558384408, 38798.41802372967, 38809.805950970345, 38816.22367552633, 38850.0, 2832.56095305228, 2884.2933481297005, 2900.419916016805, 2992.7605791536625, 3223.8226897520626, 27303.45393092147, 27812.30469238265, 28096.719032809615, 28121.29696757577, 28689.426211475864, 3203.983980080108, 3333.1333853198103, 3359.3281343731105, 3381.594208694972, 3394.439917413624, 184824.0, 187017.0, 187332.0, 187829.99999999863, 187853.0, 52436.47563524316, 52805.47194528082, 52939.0, 52967.0, 53013.204801928005, 32707.0, 33245.83377083147, 33416.33167336688, 56716.43283567194, 56910.7154464225, 13356.532521361705, 13769.03616746818, 13780.310984450738, 13784.586462406143, 13791.862081379259, 10582.259241853151, 10670.30643008202, 10675.73310667224, 10677.252592318619, 10681.412522311191, 15399.0, 15776.842231577766, 17332.480025599252, 17853.7321940171, 17969.19138638738, 6508.381703738232, 6713.227978782503, 6794.9660251699415, 6803.965980170067, 6898.586084834826, 761.265378909344, 787.5274835099009, 882.4440602420563, 887.9911200888038, 950.4677380666849, 25713.742862571507, 27731.306717332227, 27887.581686274723, 28214.576781348296, 28394.85802570974, 882.7748924024332, 904.0101089307198, 928.4243768863348, 953.909378609031, 990.2770977186694, 14439.566812995627, 14857.405703771728, 14881.70236595262, 14965.775513367309, 15170.089794612139, 373196.0, 376347.0, 376681.1165944153, 376987.0, 377421.0, 42148.57851421508, 43219.567804322185, 47998.28002579964, 49553.75223123861, 49703.502964969884, 1140.4525827602797, 1156.4160099149708, 1169.5789515774316, 1176.4999875053068, 1186.353437376649, 27484.58773118445, 28687.569686454302, 29345.0, 29529.85235073811, 29710.0, 42672.78663606662, 43147.352789708806, 43198.35202472028, 43214.351784722625, 43251.13497729965, 325015.0, 327263.0, 327396.0, 328484.0, 328746.0, 24521.50956980886, 25324.620130697687, 25424.0, 25778.742212578385, 25834.35414114662, 40407.1918561633, 40547.59452405438, 40915.38626920539, 42156.0, 44049.339259910485, 35410.46884296686, 36103.27793444169, 36471.45292820557, 36700.26599468049, 36832.631673683994, 35828.283434331686, 35910.0, 36038.33290841203, 36559.0, 36838.63161368352, 35427.82286088553, 35524.28951420906, 35773.1056723584, 36058.45912311265, 36390.818045909604, 30541.0, 33023.834880825445, 33123.83438082794, 36066.639333607374, 36322.8183859079, 24508.877455612608, 24934.127305544218, 25044.123455678964, 25339.366515836515, 25490.362740931625], "value": 17310.34720058865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6700767263427, 364.4424031232215, 366.76343758275914, 370.24839575661406, 379.660204117315, 12025.458854351553, 15338.769918451218, 15469.690606187869, 17032.914835425807, 17194.82805171948, 15849.366025359, 16234.10712410817, 16637.251323690434, 16758.83241167588, 16766.41317553886, 4094.078832262747, 4247.766372849492, 4622.39908811854, 4781.6413768967295, 4840.806367745286, 4992.375953005874, 5106.540411362977, 5114.43741188469, 5114.923276150861, 5115.283860259567, 5080.491950804909, 5085.618578606601, 5085.974570127163, 5289.86775330616, 5591.161325801122, 5540.445955404468, 5585.162225666142, 5589.524890384322, 5601.635893666919, 5604.495595396434, 5258.973705131488, 5387.272718183034, 5430.67415955044, 5431.0, 5434.646747961409, 11798.292102473879, 12429.31638759868, 12437.564685235973, 12639.1784534005, 12740.108192426535, 1826.6803309420798, 1857.535616095976, 1858.5353661584604, 1887.6602211601905, 2092.299079808266, 8439.957800211021, 8817.426867253607, 9198.954005229998, 9498.335116541844, 9754.512274386323, 1718.6304944437006, 1724.3706047292649, 1774.1306759687789, 1800.1539276540004, 1820.2718912435, 65792.0, 68895.31104688939, 70910.0, 72347.27652723459, 72788.90816637808, 9665.951670241744, 10064.295499314978, 10103.33634441478, 10192.541335639915, 10315.587376505006, 13569.592912212649, 13711.588652340446, 13885.652858678412, 13887.305634718223, 13904.791428128587, 5518.117101263779, 5591.10542313228, 5751.309842818805, 6350.682465876687, 6630.171228596426, 5910.556708246899, 5952.672603006789, 6093.75624974996, 6118.694065296718, 6133.6319820810895, 4121.4848143982, 4171.561985991488, 4182.519010313853, 4258.1057977824385, 4333.285007973649, 1774.600714839151, 1820.7724034495689, 1835.5135888989428, 1870.6819840626854, 1878.1360574135776, 778.875379939207, 803.61426515273, 839.1123439667177, 855.6748435594559, 885.6634478897978, 16268.837311626732, 16641.251143698562, 16782.328706851833, 16919.407820726214, 17640.91179544094, 843.8481073406846, 854.786303424144, 866.2420382165606, 873.7728190670472, 883.1874675298741, 9160.908390916138, 9436.480993545421, 9705.272104592184, 9720.902790971999, 9779.119879210904, 350295.0, 355696.0, 355713.0, 356302.0, 356510.0, 43094.353584696255, 43321.78339108284, 55539.72230138904, 69505.95741063888, 77950.99999999886, 877.1929824561419, 883.1036497954581, 885.751989442957, 886.1935638569, 889.4263200235812, 14750.188739618994, 15118.0, 15439.150846703089, 15469.5359139226, 15695.764563531327, 37240.813795930844, 37243.44134837925, 37639.0, 37710.0, 38275.617243827204, 48833.75583122062, 49856.501434985184, 50087.0, 50227.0, 52192.478075218765, 7583.0, 7639.427042971688, 7724.343430808444, 7729.961350193213, 7771.222877712184, 10581.682549523526, 11076.778464430505, 11627.88372116268, 11673.649790506299, 12177.208481448677, 10304.0, 10499.212559058255, 10512.632057877938, 10632.511448397076, 10789.514471848943, 10017.148542373689, 10196.705741208169, 10482.161427085968, 10529.0, 10603.151747860307, 9770.951145244228, 10262.0, 10439.791204175723, 10603.46982650849, 10892.455377231265, 7595.240475952361, 7652.73215437457, 7835.608219589112, 7917.168697286932, 7927.167647397171, 10214.540345684314, 10510.1066409353, 10518.105960993402, 10528.789424211625, 11017.173711971795], "value": 7863.376227854033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.806590945449, 1301.1932601786891, 1358.0425799811135, 1359.1165742267524, 1597.3850067723922, 6225.315215326316, 6847.965760171199, 7109.85780284394, 7117.822054448648, 7251.601161936104, 7053.294670532944, 7107.8933815992805, 7123.465740069502, 7126.287371262871, 7129.07322048133, 2028.1583142995676, 2056.670932650776, 2056.979430205701, 2061.907214175366, 2063.9793602064015, 2055.629986602411, 2089.0390420406557, 2089.268755935426, 2091.4771307173205, 2096.5387614724737, 2012.0845015517978, 2012.8087831655969, 2013.2148462099792, 2016.67733162694, 2018.7080268628017, 2010.2461576908659, 2018.6366454038268, 2019.0813180003063, 2020.1313435222849, 2020.6867935469952, 1922.5193701574606, 1934.1199754111844, 1939.3115444017453, 1939.5732938753451, 1956.6575849226472, 6728.394444500019, 7134.750283740096, 7227.638618069075, 7246.311600397954, 7248.275172482762, 4300.8709738707885, 4496.572825581565, 4501.212287849613, 4503.909921801578, 4519.683622146451, 2664.6802383713884, 2742.3829638331417, 2792.944141117166, 2801.7478426941675, 2812.8874845006176, 864.4726716702806, 871.3273551978441, 886.3618194899661, 896.914793094655, 909.7543663210962, 8729.956350218272, 8773.956130219372, 8774.517401542913, 8845.4250473719, 8881.289496840238, 3507.649235076472, 3601.85592576294, 3634.236810269873, 3727.422249551324, 3740.9625903741157, 7269.0, 7271.309225623663, 7275.490715649854, 7284.963575182091, 7289.854202915912, 4132.090939993197, 4151.024509240327, 4151.8962025949595, 4152.1072969311745, 4153.563875793058, 3169.6354919184128, 3254.446744053517, 3889.669378102893, 3898.4152377143087, 3909.863154789569, 3191.6170059592996, 3196.440622891031, 3302.0589132097716, 3321.319129578479, 3335.182880194368, 1101.388729255255, 1114.8104822180248, 1124.471498395769, 1126.222906194723, 1149.0979581028853, 778.5601135358504, 796.7968168117093, 801.4950581133849, 809.5426084262373, 816.4488969945263, 4910.420037150165, 4915.4347250065985, 4961.231009193581, 5093.9745301274, 5164.78331056749, 371.6320842366092, 373.2572181359076, 378.7216395948975, 379.7626483447845, 386.3952913690066, 3329.8501567429525, 3421.760476766652, 3455.6198818129988, 3460.5501284832812, 3654.8903532894055, 8100.878486822702, 8459.06950235486, 8466.703665371682, 8482.406231563855, 8484.787880303042, 8405.033421156522, 8426.747197584082, 8429.789255268668, 8439.578021099043, 8443.113473085361, 6559.0, 6607.537472376887, 6618.536702430783, 6626.966865165643, 6634.502412319095, 4746.4541577719, 4802.327674125555, 4824.927626085541, 4929.482404347636, 4972.428170760409, 7350.70597176107, 7416.4066874648815, 7646.617669116633, 7652.426068045031, 7677.117131529945, 7616.3906887449975, 7638.694452221849, 7665.961670191613, 7687.615619219128, 7736.92263077362, 5482.150266708666, 6088.269407671108, 6211.9689401552705, 6227.06594010902, 6234.812955611339, 6268.905966410599, 6484.416402523795, 6795.93204067953, 6801.455883529206, 6966.582005079711, 6309.085182648582, 6320.683965801783, 6343.904841427475, 6376.330485298977, 6460.289368169591, 6206.379362063757, 6236.064590311489, 6238.656873871799, 6245.0, 6255.46828519581, 5631.1271752878365, 5636.351819540805, 5646.576506761927, 5661.094224923992, 5661.179129026185, 4299.591538803808, 4351.8476853309985, 4455.398521199597, 4472.3515090311075, 4536.092781443658, 4151.481064866892, 4332.3068309070395, 4413.0, 4418.646508279394, 4540.367072433973], "value": 3695.9707245761265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3569639703461, 291.081637433896, 296.055582691215, 296.28151732049776, 298.8386271413437, 4734.810607575697, 4767.6662633615615, 4788.52114788521, 4800.0, 4802.855914322571, 4714.5285471452835, 4725.480197178316, 4726.976365118169, 4740.217864052427, 4747.454042785081, 3528.523649307336, 3618.8371523281385, 3652.9086772830624, 3704.9814750926207, 3752.6545908806997, 3732.141607430293, 3740.8690695825653, 3747.906302342436, 3751.6623503884643, 3756.0797604586915, 3708.2768860072297, 3728.7576307540057, 3730.384486559728, 3740.121071548184, 3750.5874353821196, 3559.555055618048, 3633.454981752732, 3668.853245870162, 3682.281955018759, 3704.49989251453, 3267.77125601208, 3276.311974485337, 3278.3115545735423, 3278.426275401819, 3286.65490123536, 4650.9767451162525, 4670.9766451167525, 4675.719456832567, 4694.577488026094, 4697.459792123916, 4148.771817550033, 4188.764314527221, 4218.894527636803, 4259.531451540328, 4262.147570485915, 4912.71558725191, 4923.409190897115, 4933.161362568336, 4940.0, 4950.3069570260195, 3589.784612923233, 3605.557776889239, 3605.963940360589, 3611.9638803611892, 3627.981860090683, 4992.625553083533, 5149.562287205592, 5226.608004399647, 5245.501677340685, 5264.710440925747, 3646.5441819772527, 3652.5616925969052, 3659.9451008234364, 3661.6155303693263, 3674.2651469706166, 3722.3485889969147, 3728.8135593220773, 3731.9440208396895, 3758.473813666089, 3759.342115129841, 4235.343521754133, 4246.639035682002, 4248.129133527619, 4261.275583150872, 4269.630355152858, 4776.92519183188, 4898.093852637274, 4936.259561065797, 4959.0, 4963.8262660806695, 1263.92416455013, 1268.2644066441442, 1277.920157466939, 1281.769281529315, 1293.5666551705096, 802.8238630406366, 816.6243527977197, 828.3994104274353, 836.1972506393809, 841.2050612171439, 4297.957020429756, 4309.784510774512, 4475.731456112644, 4498.05540836428, 4499.482559505634, 5079.6952182869145, 5102.311187989574, 5144.717040562805, 5149.330587023738, 5167.612429067835, 4449.243628583149, 4466.620337271368, 4470.5976462117915, 4514.68397212192, 4516.796744146522, 2577.819552631298, 2719.945601087967, 2721.632579601768, 2733.2346942856034, 2740.5615101583653, 4821.035063436032, 4822.855314340575, 4863.3434486343895, 4870.0, 4893.681910675795, 5004.424491183488, 5244.737763111829, 5257.973710131425, 5282.102042652681, 5296.364436267672, 4814.253790662453, 4823.758812059383, 4851.32081508582, 4854.732989685601, 4857.854264372075, 5117.462666420121, 5118.43697193301, 5119.974400127976, 5120.871978200575, 5147.691138531551, 4840.34655321527, 4994.625403094855, 5018.372703412074, 5023.673461225008, 5039.722815245197, 4823.686460380064, 4848.75756212195, 4874.829380971649, 4878.609711223023, 4880.341153944172, 3626.383514802543, 3629.4374371972385, 3662.1760103976394, 3663.945040824443, 3670.3209906167444, 5012.774425150804, 5172.793088276427, 5174.197999310113, 5223.582113430993, 5230.0, 4986.908116967504, 5000.749962501933, 5001.374828146481, 5003.3495645565845, 5026.371703537058, 4980.477049909708, 4989.401271847401, 4990.850274491771, 4997.9500204997485, 5006.549410552922, 4673.532646735299, 4917.754112294442, 4923.606111511142, 4936.679115857458, 4943.283223932582, 4808.495108013748, 4828.0, 4905.313256144214, 5022.547970682656, 5031.52200540948, 4874.2444921037295, 4875.878103047452, 4919.729414882073, 4941.382327209099, 4943.332650092335], "value": 3761.2719295866236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9582829201955, 675.1290834823078, 707.3351050012988, 724.5725022236879, 737.2369597466621, 12373.752524949507, 13102.08285420021, 13109.934450327759, 13127.6718082048, 13141.342932853368, 13289.335533223348, 13327.800082998763, 13433.0, 13463.057585968985, 13471.191728496296, 585.5959388022272, 600.7026521871679, 715.4955756191898, 718.2817182817183, 736.7458226911733, 742.907136607924, 744.4528271720309, 746.5669911451345, 747.0512449189526, 752.7064444866506, 792.8889955406248, 792.9920700792976, 793.845200185964, 794.027316537243, 794.5113755040637, 615.0896672924075, 629.3329071184536, 761.3414396547003, 780.2275747010419, 782.2529484342496, 577.4831525784399, 577.7573419163962, 578.2569398323135, 578.5863107877846, 578.8147792706336, 12069.456874440672, 12189.085818563643, 12198.0, 12202.450889709984, 12202.877971220263, 11942.40287985606, 12031.57889473873, 12385.690357741038, 12420.75158496825, 12441.191322564004, 11315.924987126293, 11460.140489463323, 11560.0, 11652.242604230698, 11987.400629968466, 4068.471098757172, 4106.240345536055, 4160.251154792136, 4166.541680415152, 4203.579642035803, 60055.0, 61743.07385389223, 61743.6912815433, 61912.071318930255, 64118.0, 9732.814889597541, 10425.0, 10488.737781555523, 10553.366797992145, 10609.681709548726, 18792.71810922837, 18972.24111035543, 19038.33365832189, 19099.427017189508, 19117.0, 6392.840178995562, 6450.903236451457, 6536.281009088996, 6593.86812263752, 6719.260881303053, 3481.268933523938, 3580.874669386611, 3601.5318008658705, 3628.546431696038, 3648.726345524043, 2632.2761240658974, 2712.091449364485, 2718.945621087607, 2724.019353032946, 2731.2489065506747, 453.3064411450486, 461.61455184920965, 461.8522072936628, 467.4414075180195, 478.91764611976487, 502.1739238951977, 510.58897587441726, 529.9258103865462, 542.0892899928159, 545.1550097349093, 7705.952601046323, 7829.491083079582, 7910.327622152066, 7912.881306780403, 8085.595720213966, 531.8909623527245, 532.9653572517774, 542.9077056900336, 547.3103889099683, 567.4212303450457, 3473.14907847579, 3598.676119149289, 3657.231981283907, 3667.889963301105, 3800.4299355096955, 54884.0, 55175.17237241445, 63032.0, 93591.0, 100589.99410005953, 85408.0, 90029.54985225163, 90868.0, 92471.0, 92480.0, 77278.61360693385, 77628.22371776323, 77877.0, 78188.0, 78790.0, 6834.589448631337, 7190.334435319502, 7306.634668266672, 7452.441066920112, 7512.849743005218, 44361.0, 45379.773101134284, 45799.0, 47073.76463117662, 47179.0, 60190.39809601848, 60615.39384606274, 64885.0, 66069.0, 67013.3298667007, 8644.56777161152, 8885.644574216958, 9129.49787761653, 9256.72229833106, 9321.394109382869, 9255.861162082709, 9325.943214701627, 9508.429494230368, 9719.9028009719, 9835.950820245853, 9218.26253899673, 9391.201747851235, 9397.859032114387, 9844.409335439897, 9926.851097233402, 8438.240558349778, 8613.181747733955, 8733.301335892986, 8807.251383632463, 8833.160849719266, 9016.819663606822, 9350.906490935004, 9562.521873906138, 9603.03969603034, 9666.226701863694, 7763.922360776546, 7801.4929029612895, 7909.564973926489, 8084.191580841869, 8352.415330926777, 7324.304191101837, 7843.647035883513, 8160.632771525415, 8243.752687419386, 8256.545889975869], "value": 6109.894396803766, "unit": "score"}], "name": "dromaeo_css", "value": 6102.542141693723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 117.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 132.0, 169.0, 131.0, 133.0, 126.0, 126.0, 169.0, 129.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 107.0, 78.0, 76.0, 76.0, 75.0, 114.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 121.0, 84.0, 85.0, 84.0, 107.0, 84.0, 83.0, 117.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 65.0, 68.0, 68.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 85.0, 84.0, 83.0, 83.0, 89.0, 87.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 154.0, 146.0, 140.0, 139.0, 148.0, 139.0, 139.0, 184.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 176.0, 178.0, 176.0, 181.0, 183.0, 185.0, 179.0, 177.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 70.0, 75.0, 70.0, 70.0, 70.0, 70.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1565.3999999999999, "alertThreshold": 2.0}]} 15:42:50 INFO - Return code: 0 15:42:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:50 INFO - # TBPL SUCCESS # 15:42:50 INFO - Running post-action listener: _resource_record_post_action 15:42:50 INFO - [mozharness: 2016-10-07 22:42:50.554494Z] Finished run-tests step (success) 15:42:50 INFO - Running post-run listener: _resource_record_post_run 15:42:50 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 402092032; Read time: 0; Write time: 245716 15:42:50 INFO - TinderboxPrint: CPU usage
13.0% 15:42:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:42:50 INFO - TinderboxPrint: I/O write bytes / time
402,092,032 / 245,716 15:42:50 INFO - TinderboxPrint: CPU idle
8,355.9 (87.0%) 15:42:50 INFO - TinderboxPrint: CPU user
1,201.3 (12.5%) 15:42:50 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110632960; Read time: 0; Write time: 75468 15:42:50 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291459072; Read time: 0; Write time: 170248 15:42:51 INFO - Running post-run listener: _upload_blobber_files 15:42:51 INFO - Blob upload gear active. 15:42:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:51 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 15:42:51 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:51 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:54 INFO - (blobuploader) - INFO - Done attempting. 15:42:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:55 INFO - (blobuploader) - INFO - Done attempting. 15:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:56 INFO - (blobuploader) - INFO - Done attempting. 15:42:56 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:56 INFO - Return code: 0 15:42:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec2b5639708c858399d953c1bdc6cd904ab02fad9b73e557c5860bc8e3f55873a5f3cf243c7575cc28df92b1cd091023ccf7b0cb286902d9a3d7fca20c7f70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fdad881ad3a84ffb7f1b328c82606a6758540e314eb7695afdcaf4926c3f1ebdc612f21e3b380e791cc1f0f57b45a2e248fcf5f1d887584b49a012dd92dc030", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb210285670569def6d84fb1ecadae01ab34d640087a5a7595ba0043e65492f63835a69d3954008e6e1aa2b40ebf0ab5da047e64e2ba018b2be519a69856a366"} 15:42:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:56 INFO - Contents: 15:42:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec2b5639708c858399d953c1bdc6cd904ab02fad9b73e557c5860bc8e3f55873a5f3cf243c7575cc28df92b1cd091023ccf7b0cb286902d9a3d7fca20c7f70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fdad881ad3a84ffb7f1b328c82606a6758540e314eb7695afdcaf4926c3f1ebdc612f21e3b380e791cc1f0f57b45a2e248fcf5f1d887584b49a012dd92dc030", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb210285670569def6d84fb1ecadae01ab34d640087a5a7595ba0043e65492f63835a69d3954008e6e1aa2b40ebf0ab5da047e64e2ba018b2be519a69856a366"} 15:42:56 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:56 INFO - Copying logs to upload dir... 15:42:56 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.552731 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-07 15:42:55.883712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 15:42:55.887159) ========= 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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec2b5639708c858399d953c1bdc6cd904ab02fad9b73e557c5860bc8e3f55873a5f3cf243c7575cc28df92b1cd091023ccf7b0cb286902d9a3d7fca20c7f70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fdad881ad3a84ffb7f1b328c82606a6758540e314eb7695afdcaf4926c3f1ebdc612f21e3b380e791cc1f0f57b45a2e248fcf5f1d887584b49a012dd92dc030", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb210285670569def6d84fb1ecadae01ab34d640087a5a7595ba0043e65492f63835a69d3954008e6e1aa2b40ebf0ab5da047e64e2ba018b2be519a69856a366"} build_url:https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/FDCSnUW4QxW2v65EalwvLA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ec2b5639708c858399d953c1bdc6cd904ab02fad9b73e557c5860bc8e3f55873a5f3cf243c7575cc28df92b1cd091023ccf7b0cb286902d9a3d7fca20c7f70b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1fdad881ad3a84ffb7f1b328c82606a6758540e314eb7695afdcaf4926c3f1ebdc612f21e3b380e791cc1f0f57b45a2e248fcf5f1d887584b49a012dd92dc030", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bb210285670569def6d84fb1ecadae01ab34d640087a5a7595ba0043e65492f63835a69d3954008e6e1aa2b40ebf0ab5da047e64e2ba018b2be519a69856a366"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 15:42:55.912982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:42:55.913315) ========= 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=d2a8c569965ab8367867b893000001a1-1475877209.467727-1893423434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 15:42:55.999355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 15:42:55.999916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 15:42:56.000240) ========= ========= Total master_lag: 0.19 =========