builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1487888101.8 results: success (0) buildid: 20170223120822 builduid: 86366fe5fc1c40fb827c97dbe3e79bed revision: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.798954) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.799368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.799657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.816409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.816773) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-23 14:15:01-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.5M=0.001s 2017-02-23 14:15:02 (16.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.945165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.945511) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017437 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:01.995075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 14:15:01.995426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a654cb6a61e3c051d50542cc67b61943e4fbf80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8a654cb6a61e3c051d50542cc67b61943e4fbf80 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-23 14:15:02,158 truncating revision to first 12 chars 2017-02-23 14:15:02,158 Setting DEBUG logging. 2017-02-23 14:15:02,158 attempt 1/10 2017-02-23 14:15:02,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8a654cb6a61e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 14:15:03,201 unpacking tar archive at: mozilla-beta-8a654cb6a61e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.294113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 14:15:03.302446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:03.302759) ========= script_repo_revision: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:03.303137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:03.303407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 14:15:03.314047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 14:15:03.314408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:03 INFO - MultiFileLogger online at 20170223 14:15:03 in /builds/slave/test 14:15:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:15:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:03 INFO - {'append_to_log': False, 14:15:03 INFO - 'base_work_dir': '/builds/slave/test', 14:15:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:15:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:03 INFO - 'branch': 'Mozilla-Beta', 14:15:03 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:03 INFO - 'config_files': ('talos/linux_config.py',), 14:15:03 INFO - 'default_actions': ('clobber', 14:15:03 INFO - 'read-buildbot-config', 14:15:03 INFO - 'download-and-extract', 14:15:03 INFO - 'populate-webroot', 14:15:03 INFO - 'create-virtualenv', 14:15:03 INFO - 'install', 14:15:03 INFO - 'run-tests'), 14:15:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:03 INFO - 'download_minidump_stackwalk': True, 14:15:03 INFO - 'download_symbols': 'ondemand', 14:15:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:03 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:03 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:03 INFO - 'installer_path': 'installer.exe', 14:15:03 INFO - 'log_level': 'info', 14:15:03 INFO - 'log_name': 'talos', 14:15:03 INFO - 'log_to_console': True, 14:15:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:03 INFO - 'opt_config_files': (), 14:15:03 INFO - 'pip_index': False, 14:15:03 INFO - 'sps_profile': False, 14:15:03 INFO - 'sps_profile_interval': 0, 14:15:03 INFO - 'suite': 'dromaeojs', 14:15:03 INFO - 'system_bits': '32', 14:15:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:03 INFO - 'title': 'talos-linux64-ix-041', 14:15:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:03 INFO - 'use_talos_json': True, 14:15:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:03 INFO - 'work_dir': 'build'} 14:15:03 INFO - [mozharness: 2017-02-23 22:15:03.579959Z] Running clobber step. 14:15:03 INFO - Running pre-action listener: _resource_record_pre_action 14:15:03 INFO - Running main action method: clobber 14:15:03 INFO - rmtree: /builds/slave/test/build 14:15:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:04 INFO - Running post-action listener: _resource_record_post_action 14:15:04 INFO - [mozharness: 2017-02-23 22:15:04.514613Z] Finished clobber step (success) 14:15:04 INFO - [mozharness: 2017-02-23 22:15:04.514715Z] Running read-buildbot-config step. 14:15:04 INFO - Running pre-action listener: _resource_record_pre_action 14:15:04 INFO - Running main action method: read_buildbot_config 14:15:04 INFO - Using buildbot properties: 14:15:04 INFO - { 14:15:04 INFO - "project": "", 14:15:04 INFO - "product": "firefox", 14:15:04 INFO - "script_repo_revision": "production", 14:15:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:15:04 INFO - "repository": "", 14:15:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:15:04 INFO - "buildid": "20170223120822", 14:15:04 INFO - "pgo_build": "True", 14:15:04 INFO - "basedir": "/builds/slave/test", 14:15:04 INFO - "buildnumber": 28, 14:15:04 INFO - "slavename": "talos-linux64-ix-041", 14:15:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:15:04 INFO - "platform": "ubuntu64_hw", 14:15:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:15:04 INFO - "branch": "mozilla-beta", 14:15:04 INFO - "repo_path": "releases/mozilla-beta", 14:15:04 INFO - "revision": "8a654cb6a61e3c051d50542cc67b61943e4fbf80", 14:15:04 INFO - "stage_platform": "linux64-pgo", 14:15:04 INFO - "builduid": "86366fe5fc1c40fb827c97dbe3e79bed", 14:15:04 INFO - "slavebuilddir": "test" 14:15:04 INFO - } 14:15:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:15:04 INFO - Running post-action listener: _resource_record_post_action 14:15:04 INFO - [mozharness: 2017-02-23 22:15:04.517195Z] Finished read-buildbot-config step (success) 14:15:04 INFO - [mozharness: 2017-02-23 22:15:04.517283Z] Running download-and-extract step. 14:15:04 INFO - Running pre-action listener: _resource_record_pre_action 14:15:04 INFO - Running main action method: download_and_extract 14:15:04 INFO - mkdir: /builds/slave/test/build/tests 14:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:04 INFO - trying https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:15:05 INFO - Downloaded 1327 bytes. 14:15:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:15:05 INFO - Using the following test package requirements: 14:15:05 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:15:05 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:05 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:15:05 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'jsshell-linux-x86_64.zip'], 14:15:05 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:05 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:15:05 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:15:05 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:15:05 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:05 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:15:05 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:15:05 INFO - Http code: 200 14:15:05 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 14:15:05 INFO - x-amz-cf-id: X9n3GKXgeGYIfsH3II--d-A0z14whYpGE_4b-oiP9JnaDZFb7PSHmQ== 14:15:05 INFO - x-amz-version-id: kMeiXwKjEdDQ7pL4VG1MjXGFrxc9tpjy 14:15:06 INFO - Expected file size: 21963586 14:15:06 INFO - Obtained file size: 21963586 14:15:10 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:15:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:15:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:15:10 INFO - Fetch https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:15:11 INFO - Http code: 200 14:15:11 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:15:11 INFO - x-amz-cf-id: _FZEd4r6OooMnsl-jovpvXRX9hBmb2KavCfcIOyIaF6t8uPCYVf4Tg== 14:15:11 INFO - x-amz-version-id: kMeiXwKjEdDQ7pL4VG1MjXGFrxc9tpjy 14:15:11 INFO - Expected file size: 21963586 14:15:11 INFO - Obtained file size: 21963586 14:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:15:16 INFO - Http code: 200 14:15:16 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 14:15:16 INFO - x-amz-cf-id: 5NNuX-zxmvgItYqEyJEbdHXzBEteDdof-BiFJ8nJ2PvQdQIm2V9IqQ== 14:15:16 INFO - x-amz-version-id: BeZgSkAz7RyjLQKc_Tb0P.cfwRXqgaQj 14:15:16 INFO - Expected file size: 14402992 14:15:16 INFO - Obtained file size: 14402992 14:15:16 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')]} 14:15:16 INFO - trying https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:15:18 INFO - Downloaded 57761252 bytes. 14:15:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:15:18 INFO - mkdir: /builds/slave/test/properties 14:15:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:18 INFO - Contents: 14:15:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:15:19 INFO - Running post-action listener: _resource_record_post_action 14:15:19 INFO - Running post-action listener: set_extra_try_arguments 14:15:19 INFO - [mozharness: 2017-02-23 22:15:19.144427Z] Finished download-and-extract step (success) 14:15:19 INFO - [mozharness: 2017-02-23 22:15:19.144653Z] Running populate-webroot step. 14:15:19 INFO - Running pre-action listener: _resource_record_pre_action 14:15:19 INFO - Running main action method: populate_webroot 14:15:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:19 INFO - '--tppagecycles', 14:15:19 INFO - '7'], 14:15:19 INFO - 'tests': ['tsvgm']}}, 14:15:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['damp', 'tps']}, 14:15:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'tests': ['damp', 'tps']}, 14:15:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['dromaeo_dom']}, 14:15:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['basic_compositor_video']}, 14:15:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:15:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['a11yr', 14:15:19 INFO - 'ts_paint', 14:15:19 INFO - 'tpaint', 14:15:19 INFO - 'sessionrestore', 14:15:19 INFO - 'sessionrestore_no_auto_restore', 14:15:19 INFO - 'tabpaint']}, 14:15:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['tsvgx', 14:15:19 INFO - 'tsvgr_opacity', 14:15:19 INFO - 'tart', 14:15:19 INFO - 'tscrollx', 14:15:19 INFO - 'cart']}, 14:15:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:19 INFO - 'tsvgr_opacity', 14:15:19 INFO - 'tart', 14:15:19 INFO - 'tscrollx', 14:15:19 INFO - 'cart']}, 14:15:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'talos_options': ['--disable-e10s'], 14:15:19 INFO - 'tests': ['tp5o']}, 14:15:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'tests': ['tp5o']}, 14:15:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'talos_options': ['--disable-e10s', 14:15:19 INFO - '--xperf_path', 14:15:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:19 INFO - 'tests': ['tp5n']}, 14:15:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:19 INFO - 'talos_options': ['--xperf_path', 14:15:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:19 INFO - 'tests': ['tp5n']}}, 14:15:19 INFO - 'talos.zip': {'path': '', 14:15:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:19 INFO - Running post-action listener: _resource_record_post_action 14:15:19 INFO - [mozharness: 2017-02-23 22:15:19.161665Z] Finished populate-webroot step (success) 14:15:19 INFO - [mozharness: 2017-02-23 22:15:19.161752Z] Running create-virtualenv step. 14:15:19 INFO - Running pre-action listener: _resource_record_pre_action 14:15:19 INFO - Running main action method: create_virtualenv 14:15:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:19 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 14:15:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:19 INFO - Using real prefix '/usr' 14:15:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:21 INFO - Installing pip.................done. 14:15:21 INFO - Return code: 0 14:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:15:21 INFO - Reading from file tmpfile_stdout 14:15:21 INFO - Output received: 14:15:21 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) 14:15:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:21 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:21 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 14:15:21 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 14:15:21 INFO - Using env: {'DISPLAY': ':0', 14:15:21 INFO - 'HOME': '/home/cltbld', 14:15:21 INFO - 'LANG': 'en_US.UTF-8', 14:15:21 INFO - 'LANGUAGE': 'en_US:en', 14:15:21 INFO - 'LOGNAME': 'cltbld', 14:15:21 INFO - 'MAIL': '/var/mail/cltbld', 14:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:21 INFO - 'MOZ_NO_REMOTE': '1', 14:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:21 INFO - 'NO_EM_RESTART': '1', 14:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:21 INFO - 'PWD': '/builds/slave/test', 14:15:21 INFO - 'SHELL': '/bin/bash', 14:15:21 INFO - 'SHLVL': '1', 14:15:21 INFO - 'TERM': 'linux', 14:15:21 INFO - 'TMOUT': '86400', 14:15:21 INFO - 'USER': 'cltbld', 14:15:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:21 INFO - '_': '/tools/buildbot/bin/python'} 14:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:22 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 14:15:22 INFO - Cleaning up... 14:15:22 INFO - Return code: 0 14:15:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:22 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:22 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 14:15:22 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 14:15:22 INFO - Using env: {'DISPLAY': ':0', 14:15:22 INFO - 'HOME': '/home/cltbld', 14:15:22 INFO - 'LANG': 'en_US.UTF-8', 14:15:22 INFO - 'LANGUAGE': 'en_US:en', 14:15:22 INFO - 'LOGNAME': 'cltbld', 14:15:22 INFO - 'MAIL': '/var/mail/cltbld', 14:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:22 INFO - 'MOZ_NO_REMOTE': '1', 14:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:22 INFO - 'NO_EM_RESTART': '1', 14:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:22 INFO - 'PWD': '/builds/slave/test', 14:15:22 INFO - 'SHELL': '/bin/bash', 14:15:22 INFO - 'SHLVL': '1', 14:15:22 INFO - 'TERM': 'linux', 14:15:22 INFO - 'TMOUT': '86400', 14:15:22 INFO - 'USER': 'cltbld', 14:15:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:22 INFO - '_': '/tools/buildbot/bin/python'} 14:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:22 INFO - Downloading/unpacking psutil>=3.1.1 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:24 INFO - Installing collected packages: psutil 14:15:24 INFO - Running setup.py install for psutil 14:15:24 INFO - building 'psutil._psutil_linux' extension 14:15:24 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 14:15:24 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 14:15:24 INFO - building 'psutil._psutil_posix' extension 14:15:24 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 14:15:24 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 14:15:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:25 INFO - Successfully installed psutil 14:15:25 INFO - Cleaning up... 14:15:25 INFO - Return code: 0 14:15:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:15:25 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')]} 14:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:25 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')]} 14:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:25 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:25 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 14:15:25 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 14:15:25 INFO - Using env: {'DISPLAY': ':0', 14:15:25 INFO - 'HOME': '/home/cltbld', 14:15:25 INFO - 'LANG': 'en_US.UTF-8', 14:15:25 INFO - 'LANGUAGE': 'en_US:en', 14:15:25 INFO - 'LOGNAME': 'cltbld', 14:15:25 INFO - 'MAIL': '/var/mail/cltbld', 14:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:25 INFO - 'MOZ_NO_REMOTE': '1', 14:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:25 INFO - 'NO_EM_RESTART': '1', 14:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:25 INFO - 'PWD': '/builds/slave/test', 14:15:25 INFO - 'SHELL': '/bin/bash', 14:15:25 INFO - 'SHLVL': '1', 14:15:25 INFO - 'TERM': 'linux', 14:15:25 INFO - 'TMOUT': '86400', 14:15:25 INFO - 'USER': 'cltbld', 14:15:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:25 INFO - '_': '/tools/buildbot/bin/python'} 14:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:15:25 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 14:15:25 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 14:15:25 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 14:15:25 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 14:15:25 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 14:15:25 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 14:15:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:15:27 INFO - Installing collected packages: mozsystemmonitor 14:15:27 INFO - Running setup.py install for mozsystemmonitor 14:15:27 INFO - Successfully installed mozsystemmonitor 14:15:27 INFO - Cleaning up... 14:15:27 INFO - Return code: 0 14:15:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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', '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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:15: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 jsonschema==2.5.1 14:15:27 INFO - Using env: {'DISPLAY': ':0', 14:15:27 INFO - 'HOME': '/home/cltbld', 14:15:27 INFO - 'LANG': 'en_US.UTF-8', 14:15:27 INFO - 'LANGUAGE': 'en_US:en', 14:15:27 INFO - 'LOGNAME': 'cltbld', 14:15:27 INFO - 'MAIL': '/var/mail/cltbld', 14:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:27 INFO - 'MOZ_NO_REMOTE': '1', 14:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:27 INFO - 'NO_EM_RESTART': '1', 14:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:27 INFO - 'PWD': '/builds/slave/test', 14:15:27 INFO - 'SHELL': '/bin/bash', 14:15:27 INFO - 'SHLVL': '1', 14:15:27 INFO - 'TERM': 'linux', 14:15:27 INFO - 'TMOUT': '86400', 14:15:27 INFO - 'USER': 'cltbld', 14:15:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:27 INFO - '_': '/tools/buildbot/bin/python'} 14:15:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:27 INFO - Downloading/unpacking jsonschema==2.5.1 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:15:29 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 14:15:29 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 14:15:29 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 14:15:29 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 14:15:29 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 14:15:29 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 14:15:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:29 INFO - warning: no files found matching '*.txt' 14:15:29 INFO - no previously-included directories found matching 'build' 14:15:29 INFO - no previously-included directories found matching 'dist' 14:15:29 INFO - no previously-included directories found matching '.git*' 14:15:29 INFO - Installing collected packages: jsonschema, functools32 14:15:30 INFO - Running setup.py install for functools32 14:15:30 INFO - warning: no files found matching '*.txt' 14:15:30 INFO - no previously-included directories found matching 'build' 14:15:30 INFO - no previously-included directories found matching 'dist' 14:15:30 INFO - no previously-included directories found matching '.git*' 14:15:30 INFO - Successfully installed jsonschema functools32 14:15:30 INFO - Cleaning up... 14:15:30 INFO - Return code: 0 14:15:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:15:30 INFO - Using env: {'DISPLAY': ':0', 14:15:30 INFO - 'HOME': '/home/cltbld', 14:15:30 INFO - 'LANG': 'en_US.UTF-8', 14:15:30 INFO - 'LANGUAGE': 'en_US:en', 14:15:30 INFO - 'LOGNAME': 'cltbld', 14:15:30 INFO - 'MAIL': '/var/mail/cltbld', 14:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:30 INFO - 'MOZ_NO_REMOTE': '1', 14:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:30 INFO - 'NO_EM_RESTART': '1', 14:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:30 INFO - 'PWD': '/builds/slave/test', 14:15:30 INFO - 'SHELL': '/bin/bash', 14:15:30 INFO - 'SHLVL': '1', 14:15:30 INFO - 'TERM': 'linux', 14:15:30 INFO - 'TMOUT': '86400', 14:15:30 INFO - 'USER': 'cltbld', 14:15:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:30 INFO - '_': '/tools/buildbot/bin/python'} 14:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:15:30 INFO - Cleaning up... 14:15:30 INFO - Return code: 0 14:15:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:15:30 INFO - Using env: {'DISPLAY': ':0', 14:15:30 INFO - 'HOME': '/home/cltbld', 14:15:30 INFO - 'LANG': 'en_US.UTF-8', 14:15:30 INFO - 'LANGUAGE': 'en_US:en', 14:15:30 INFO - 'LOGNAME': 'cltbld', 14:15:30 INFO - 'MAIL': '/var/mail/cltbld', 14:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:30 INFO - 'MOZ_NO_REMOTE': '1', 14:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:30 INFO - 'NO_EM_RESTART': '1', 14:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:30 INFO - 'PWD': '/builds/slave/test', 14:15:30 INFO - 'SHELL': '/bin/bash', 14:15:30 INFO - 'SHLVL': '1', 14:15:30 INFO - 'TERM': 'linux', 14:15:30 INFO - 'TMOUT': '86400', 14:15:30 INFO - 'USER': 'cltbld', 14:15:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:30 INFO - '_': '/tools/buildbot/bin/python'} 14:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15: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 14:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:33 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 14:15:33 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 14:15:33 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 14:15:33 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 14:15:33 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 14:15:33 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 14:15:33 INFO - Downloading docopt-0.6.1.tar.gz 14:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:33 INFO - Running setup.py install for blobuploader 14:15:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:33 INFO - Running setup.py install for requests 14:15:33 INFO - Running setup.py install for docopt 14:15:33 INFO - Successfully installed blobuploader requests docopt 14:15:33 INFO - Cleaning up... 14:15:34 INFO - Return code: 0 14:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:34 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:34 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 14:15:34 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 14:15:34 INFO - Using env: {'DISPLAY': ':0', 14:15:34 INFO - 'HOME': '/home/cltbld', 14:15:34 INFO - 'LANG': 'en_US.UTF-8', 14:15:34 INFO - 'LANGUAGE': 'en_US:en', 14:15:34 INFO - 'LOGNAME': 'cltbld', 14:15:34 INFO - 'MAIL': '/var/mail/cltbld', 14:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:34 INFO - 'MOZ_NO_REMOTE': '1', 14:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:34 INFO - 'NO_EM_RESTART': '1', 14:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:34 INFO - 'PWD': '/builds/slave/test', 14:15:34 INFO - 'SHELL': '/bin/bash', 14:15:34 INFO - 'SHLVL': '1', 14:15:34 INFO - 'TERM': 'linux', 14:15:34 INFO - 'TMOUT': '86400', 14:15:34 INFO - 'USER': 'cltbld', 14:15:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:34 INFO - '_': '/tools/buildbot/bin/python'} 14:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:34 INFO - Running setup.py (path:/tmp/pip-bNIymf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:34 INFO - Running setup.py (path:/tmp/pip-evKIpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:34 INFO - Running setup.py (path:/tmp/pip-Yphf3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:34 INFO - Running setup.py (path:/tmp/pip-hiSvff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:34 INFO - Running setup.py (path:/tmp/pip-kW0wxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:34 INFO - Running setup.py (path:/tmp/pip-bxQ0Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:34 INFO - Running setup.py (path:/tmp/pip-y_XGd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:34 INFO - Running setup.py (path:/tmp/pip-xU_c7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:34 INFO - Running setup.py (path:/tmp/pip-XTx79F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:34 INFO - Running setup.py (path:/tmp/pip-ShVvOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:34 INFO - Running setup.py (path:/tmp/pip-XWLrOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:35 INFO - Running setup.py (path:/tmp/pip-VQHsH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:35 INFO - Running setup.py (path:/tmp/pip-SLlqyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:35 INFO - Running setup.py (path:/tmp/pip-CLiKzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:35 INFO - Running setup.py (path:/tmp/pip-kFgKlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:35 INFO - Running setup.py (path:/tmp/pip-ONYF97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:35 INFO - Running setup.py (path:/tmp/pip-X0cNnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:35 INFO - Running setup.py install for manifestparser 14:15:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:35 INFO - Running setup.py install for mozcrash 14:15:35 INFO - Running setup.py install for mozdebug 14:15:35 INFO - Running setup.py install for mozdevice 14:15:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:35 INFO - Running setup.py install for mozfile 14:15:35 INFO - Running setup.py install for mozhttpd 14:15:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozinfo 14:15:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozInstall 14:15:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozleak 14:15:36 INFO - Running setup.py install for mozlog 14:15:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for moznetwork 14:15:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozprocess 14:15:36 INFO - Running setup.py install for mozprofile 14:15:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozrunner 14:15:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:36 INFO - Running setup.py install for mozscreenshot 14:15:37 INFO - Running setup.py install for moztest 14:15:37 INFO - Running setup.py install for mozversion 14:15:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:37 INFO - Cleaning up... 14:15:37 INFO - Return code: 0 14:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:37 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:37 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 14:15:37 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 14:15:37 INFO - Using env: {'DISPLAY': ':0', 14:15:37 INFO - 'HOME': '/home/cltbld', 14:15:37 INFO - 'LANG': 'en_US.UTF-8', 14:15:37 INFO - 'LANGUAGE': 'en_US:en', 14:15:37 INFO - 'LOGNAME': 'cltbld', 14:15:37 INFO - 'MAIL': '/var/mail/cltbld', 14:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:37 INFO - 'MOZ_NO_REMOTE': '1', 14:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:37 INFO - 'NO_EM_RESTART': '1', 14:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:37 INFO - 'PWD': '/builds/slave/test', 14:15:37 INFO - 'SHELL': '/bin/bash', 14:15:37 INFO - 'SHLVL': '1', 14:15:37 INFO - 'TERM': 'linux', 14:15:37 INFO - 'TMOUT': '86400', 14:15:37 INFO - 'USER': 'cltbld', 14:15:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:37 INFO - '_': '/tools/buildbot/bin/python'} 14:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:37 INFO - Running setup.py (path:/tmp/pip-tTjk_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:37 INFO - Running setup.py (path:/tmp/pip-IzLOCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:37 INFO - Running setup.py (path:/tmp/pip-72X6zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:37 INFO - Running setup.py (path:/tmp/pip-nxeUZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:37 INFO - Running setup.py (path:/tmp/pip-PZSKaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:37 INFO - Running setup.py (path:/tmp/pip-phpz6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:37 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)) 14:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:37 INFO - Running setup.py (path:/tmp/pip-_PisMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:38 INFO - Running setup.py (path:/tmp/pip-MXJkZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:38 INFO - Running setup.py (path:/tmp/pip-y0YEMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:38 INFO - Running setup.py (path:/tmp/pip-vmP86j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:38 INFO - Running setup.py (path:/tmp/pip-HoF3UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:38 INFO - Running setup.py (path:/tmp/pip-PAYhDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:38 INFO - Running setup.py (path:/tmp/pip-WllV6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:38 INFO - Running setup.py (path:/tmp/pip-6YB6YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:38 INFO - Running setup.py (path:/tmp/pip-16h9Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:38 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:38 INFO - Running setup.py (path:/tmp/pip-vgiWoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:38 INFO - Running setup.py (path:/tmp/pip-kvHOYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:38 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)) 14:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:15:38 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)) 14:15:38 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)) 14:15:38 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)) 14:15:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:38 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 14:15:38 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 14:15:38 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 14:15:38 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 14:15:38 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 14:15:38 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 14:15:40 INFO - Downloading blessings-1.6.tar.gz 14:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:40 INFO - Installing collected packages: blessings 14:15:40 INFO - Running setup.py install for blessings 14:15:40 INFO - Successfully installed blessings 14:15:40 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:41 INFO - Reading from file tmpfile_stdout 14:15:41 INFO - Current package versions: 14:15:41 INFO - argparse == 1.2.1 14:15:41 INFO - blessings == 1.6 14:15:41 INFO - blobuploader == 1.2.4 14:15:41 INFO - docopt == 0.6.1 14:15:41 INFO - functools32 == 3.2.3-2 14:15:41 INFO - jsonschema == 2.5.1 14:15:41 INFO - manifestparser == 1.1 14:15:41 INFO - mozInstall == 1.12 14:15:41 INFO - mozcrash == 1.0 14:15:41 INFO - mozdebug == 0.1 14:15:41 INFO - mozdevice == 0.48 14:15:41 INFO - mozfile == 1.2 14:15:41 INFO - mozhttpd == 0.7 14:15:41 INFO - mozinfo == 0.9 14:15:41 INFO - mozleak == 0.1 14:15:41 INFO - mozlog == 3.4 14:15:41 INFO - moznetwork == 0.27 14:15:41 INFO - mozprocess == 0.23 14:15:41 INFO - mozprofile == 0.28 14:15:41 INFO - mozrunner == 6.13 14:15:41 INFO - mozscreenshot == 0.1 14:15:41 INFO - mozsystemmonitor == 0.3 14:15:41 INFO - moztest == 0.8 14:15:41 INFO - mozversion == 1.4 14:15:41 INFO - psutil == 3.1.1 14:15:41 INFO - requests == 1.2.3 14:15:41 INFO - wsgiref == 0.1.2 14:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'DISPLAY': ':0', 14:15:41 INFO - 'HOME': '/home/cltbld', 14:15:41 INFO - 'LANG': 'en_US.UTF-8', 14:15:41 INFO - 'LANGUAGE': 'en_US:en', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MAIL': '/var/mail/cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SHLVL': '1', 14:15:41 INFO - 'TERM': 'linux', 14:15:41 INFO - 'TMOUT': '86400', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - '_': '/tools/buildbot/bin/python'} 14:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 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)) 14:15:41 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:41 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 0x7fe733bc4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', '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 14:15:41 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 14:15:41 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 14:15:41 INFO - Using env: {'DISPLAY': ':0', 14:15:41 INFO - 'HOME': '/home/cltbld', 14:15:41 INFO - 'LANG': 'en_US.UTF-8', 14:15:41 INFO - 'LANGUAGE': 'en_US:en', 14:15:41 INFO - 'LOGNAME': 'cltbld', 14:15:41 INFO - 'MAIL': '/var/mail/cltbld', 14:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:41 INFO - 'MOZ_NO_REMOTE': '1', 14:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:41 INFO - 'NO_EM_RESTART': '1', 14:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:41 INFO - 'PWD': '/builds/slave/test', 14:15:41 INFO - 'SHELL': '/bin/bash', 14:15:41 INFO - 'SHLVL': '1', 14:15:41 INFO - 'TERM': 'linux', 14:15:41 INFO - 'TMOUT': '86400', 14:15:41 INFO - 'USER': 'cltbld', 14:15:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:41 INFO - '_': '/tools/buildbot/bin/python'} 14:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:15:41 INFO - Cleaning up... 14:15:41 INFO - Return code: 0 14:15:41 INFO - Running post-action listener: _resource_record_post_action 14:15:41 INFO - Running post-action listener: _start_resource_monitoring 14:15:41 INFO - Starting resource monitoring. 14:15:41 INFO - [mozharness: 2017-02-23 22:15:41.747960Z] Finished create-virtualenv step (success) 14:15:41 INFO - [mozharness: 2017-02-23 22:15:41.748460Z] Running install step. 14:15:41 INFO - Running pre-action listener: _resource_record_pre_action 14:15:41 INFO - Running main action method: install 14:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:41 INFO - Reading from file tmpfile_stdout 14:15:41 INFO - Detecting whether we're running mozinstall >=1.0... 14:15:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:15:42 INFO - Reading from file tmpfile_stdout 14:15:42 INFO - Output received: 14:15:42 INFO - Usage: mozinstall [options] installer 14:15:42 INFO - Options: 14:15:42 INFO - -h, --help show this help message and exit 14:15:42 INFO - -d DEST, --destination=DEST 14:15:42 INFO - Directory to install application into. [default: 14:15:42 INFO - "/builds/slave/test"] 14:15:42 INFO - --app=APP Application being installed. [default: firefox] 14:15:42 INFO - mkdir: /builds/slave/test/build/application 14:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:15:55 INFO - Reading from file tmpfile_stdout 14:15:55 INFO - Output received: 14:15:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:15:55 INFO - Running post-action listener: _resource_record_post_action 14:15:55 INFO - [mozharness: 2017-02-23 22:15:55.701855Z] Finished install step (success) 14:15:55 INFO - [mozharness: 2017-02-23 22:15:55.702097Z] Running run-tests step. 14:15:55 INFO - Running pre-action listener: _resource_record_pre_action 14:15:55 INFO - Running main action method: run_tests 14:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:15:55 INFO - Python 2.7.3 14:15:55 INFO - Return code: 0 14:15:55 INFO - grabbing minidump binary from tooltool 14:15:55 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')]} 14:15:55 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 0x1767f60>, '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 0x1768d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17691d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:15:55 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 14:15:55 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 14:15:55 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 14:15:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:15:55 INFO - Return code: 0 14:15:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:15:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:15:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 14:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 14:15:55 INFO - Using env: {'DISPLAY': ':0', 14:15:55 INFO - 'HOME': '/home/cltbld', 14:15:55 INFO - 'LANG': 'en_US.UTF-8', 14:15:55 INFO - 'LANGUAGE': 'en_US:en', 14:15:55 INFO - 'LOGNAME': 'cltbld', 14:15:55 INFO - 'MAIL': '/var/mail/cltbld', 14:15:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:15:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:55 INFO - 'MOZ_NO_REMOTE': '1', 14:15:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:55 INFO - 'NO_EM_RESTART': '1', 14:15:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:55 INFO - 'PWD': '/builds/slave/test', 14:15:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:15:55 INFO - 'SHELL': '/bin/bash', 14:15:55 INFO - 'SHLVL': '1', 14:15:55 INFO - 'TERM': 'linux', 14:15:55 INFO - 'TMOUT': '86400', 14:15:55 INFO - 'USER': 'cltbld', 14:15:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141', 14:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:55 INFO - '_': '/tools/buildbot/bin/python'} 14:15:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 14:15:55 INFO - mozversion application_buildid: 20170223120822 14:15:55 INFO - mozversion application_changeset: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 14:15:55 INFO - mozversion application_display_name: Firefox 14:15:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:15:55 INFO - mozversion application_name: Firefox 14:15:55 INFO - mozversion application_remotingname: firefox 14:15:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:55 INFO - mozversion application_vendor: Mozilla 14:15:55 INFO - mozversion application_version: 52.0 14:15:55 INFO - mozversion platform_buildid: 20170223120822 14:15:55 INFO - mozversion platform_changeset: 8a654cb6a61e3c051d50542cc67b61943e4fbf80 14:15:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:15:55 INFO - mozversion platform_version: 52.0 14:15:55 INFO - using testdate: 1487888155 14:15:55 INFO - actual date: 1487888155 14:15:55 INFO - starting webserver on 'localhost:58210' 14:15:55 INFO - SUITE-START | Running 2 tests 14:15:55 INFO - TEST-START | dromaeo_css 14:15:55 INFO - operating with platform_type : linux_ 14:15:55 INFO - Initialising browser for dromaeo_css test... 14:15:55 INFO - TEST-INFO | started process 18708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJCOgK4/profile http://localhost:58210/getInfo.html) 14:16:00 INFO - PROCESS | 18708 | __metrics Screen width/height:1600/1200 14:16:00 INFO - PROCESS | 18708 | colorDepth:24 14:16:00 INFO - PROCESS | 18708 | Browser inner width/height: 1024/697 14:16:00 INFO - PROCESS | 18708 | __metrics 14:16:01 INFO - PROCESS | 18708 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:16:01 INFO - PROCESS | 18708 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:01 INFO - TEST-INFO | 18708: exit 0 14:16:01 INFO - Browser initialized. 14:16:01 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:01 INFO - TEST-INFO | started process 18799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJCOgK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:13 INFO - PROCESS | 18799 | RSS: Main: 140730368 14:16:13 INFO - PROCESS | 18799 | 14:19:15 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58210/tests/dromaeo/cssquery-ext.html) 14:19:16 INFO - PROCESS | 18799 | RSS: Main: 235716608 14:19:16 INFO - PROCESS | 18799 | 14:22:19 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-ext.html (next: http://localhost:58210/tests/dromaeo/cssquery-jquery.html) 14:22:19 INFO - PROCESS | 18799 | RSS: Main: 230387712 14:22:19 INFO - PROCESS | 18799 | 14:25:21 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58210/tests/dromaeo/cssquery-mootools.html) 14:25:22 INFO - PROCESS | 18799 | RSS: Main: 179929088 14:25:22 INFO - PROCESS | 18799 | 14:28:24 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58210/tests/dromaeo/cssquery-prototype.html) 14:28:24 INFO - PROCESS | 18799 | RSS: Main: 227475456 14:28:24 INFO - PROCESS | 18799 | 14:31:27 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58210/tests/dromaeo/cssquery-yui.html) 14:31:27 INFO - PROCESS | 18799 | RSS: Main: 171446272 14:31:27 INFO - PROCESS | 18799 | 14:34:30 INFO - PROCESS | 18799 | Cycle 1(1): loaded http://localhost:58210/tests/dromaeo/cssquery-yui.html (next: http://localhost:58210/tests/dromaeo/cssquery-dojo.html) 14:34:31 INFO - PROCESS | 18799 | RSS: Main: 267579392 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | __start_tp_report 14:34:31 INFO - PROCESS | 18799 | _x_x_mozilla_page_load 14:34:31 INFO - PROCESS | 18799 | _x_x_mozilla_page_load_details 14:34:31 INFO - PROCESS | 18799 | |i|pagename|runs| 14:34:31 INFO - PROCESS | 18799 | |0;dojo.html;3190.1705556555294;3215.067630387188;3224.32289219264;3255.2838375557367;3266.901992940211;5610.214569960203;5665;5677.744501497432;5686.914696279559;5689.630174038684;5618.2415373924505;5640.717964101788;5686.516646085078;5689.459501347375;5718.628289161202;5132.820351287705;5137.948620513803;5149.459306772791;5184.792608295664;5216.791328346881;4990.500949905017;5194.740262986855;5195.480451954793;5207.531322181003;5215.843524694246;4974.950250497503;5054.368203974504;5066.138756411419;5092.745362731867;5108.4636113208135;5147.8455646330485;5171.612129090315;5175.482451754832;5227.059129356714;5228.111221092423;5047.7476126193915;5132.076226279269;5172.069027575035;5187.3775146982225;5213.7914483421;5273.077211488013;5315.840524784263;5461.644993075437;5481.369642491125;5505.256790333294;5904.232449781501;5909.2022576951995;5919;5960.165576819249;5976.223090998143;5984.611000285011;5991.460768530809;6005.879882402372;6007.579469437097;6009.549283803733;5342.305500284938;5381.461853814626;5541.778328866881;5595.21666966625;5601.6358936668985;6112.786052488142;6146.0473626587955;6146.7233974471255;6151.138840562325;6173.32093469718;5918.852028699231;5931.58478906481;5932.762689492458;5934.406559344031;5935.495482884004;5724.341700704473;5795.1017592273265;5839.270091238595;5897.115432685046;5911.172435858984;5886.470217680429;5889.764409423661;5907.202527658797;5914.8817023659285;5920.526357891358;5828.0966450200285;5871.735771890275;5879.529637629065;5890.793822216202;5896.705164741746;4464.620507256855;4500.774961251925;4599.609033232213;4637.907241855211;4678.859634210911;4102.098898962746;4136.028033412145;4156.210320039243;4162.895927601774;4173.332266837291;5775.653460792366;5791.62354446968;5792.102224155263;5797.768089276466;5801.53587712982;5775.27809023872;5823.970880145572;6098.085287206865;6114.0828875669;6117.449429551273;5673.659580425187;5686.0333743263745;5702.087665973508;5731.111677689964;5748.770049198069;5179.948200518022;5182.455842136596;5190.11767999441;5195.376554813447;5196.038732834362;5902.291724993029;6241.719122639583;6246.281677607042;6278.246610406689;6291.6539590321145;5765.077587586134;5929.584929054925;5962.940370596412;5969.791057313147;5983.162357270073;6097.359777223328;6118.388161183846;6140.078988151813;6143.324234334309;6147.784827531015;5826.300843898759;5827.679477628772;5828;5829.854253643693;5833.533317334688;5657.745401456862;5660.830175094754;5872.119182122716;5886.440788125121;5943.702814859326;5828.417158284307;5856.853578660568;5861.7655293787775;5863.032599621015;5878.588498805043;5851.268591426072;5861.912071318849;5861.9413805863105;5871.4715675589405;5875.177475153568;5515.338159420895;5536.474034966672;5708.514776244066;5772.393898640582;5817.563682723728;5893.469587737124;5893.9685555026845;5895.793647222326;5902;5915.615484993462;5518.365387980433;5751.051076572318;5761.337446193741;5763.827085187451;5769.105788602773 14:34:31 INFO - PROCESS | 18799 | |1;ext.html;580.0892598620165;602.7619090459272;607.5413063137333;612.5497759147028;646.2761706888285;33636.327273454546;45266.321005184946;45295.77352113239;45443;45476.77261613696;46026.539734602644;46689.533104668946;46970.53029469704;47065.52934470654;47129.29306060403;8390;9074.546272686355;9223;9229.21551668109;9241.815163696756;8433.072362040171;10820.350778953289;11105.111591072695;11108.333499990027;11432.428378581038;11120.165987550925;11172.553097876074;11172.664820055412;11173.21787474877;11185.888141118607;11009.504572294267;11072.446377681124;11073.667789966314;11080.445977701123;11084.667459976134;10927.672169834917;10999.395033273167;11000.724981875517;11002.229843910929;11020.50407731654;44418;44613;44694.55305446936;44743.10513789706;44743.32885006727;3477.1828620274214;3667.504886840269;3670.926581468382;3685.0787303174206;3763.7929913854728;33262;33367.6663233367;33420.49869251963;33430.83284583561;33655.4951675725;4523.185826551219;4576.107659006495;4772.546608072227;4787.473377928425;4798.208295631217;337352;342530;344773;346445;347492;35340.64659353425;35944.28111437757;36414.27171456556;62915.6854215726;63642.045369319494;39412;39520.604793951694;39663.801680991986;39731;39797.80101099534;15695.764563531557;15881.205939702968;15887.28507217178;15889.761653575206;15893.364265429485;11989;12083.879161208451;12221.144519883523;12929.418176182095;12981.675458113434;9254.167124958785;9358.11097945694;9363.765905852271;9414.340996130342;9441.055894410503;3504.2115524006895;3547.627499112556;3558.3594952908206;3584.1577229351083;3645.65366290202;1022.7954409118206;1058.7564860082225;1093.8523299354645;1122.7529943412437;1188.4651906642046;32918.177045574055;33858.83070584631;33867.66132338645;33977;34007.4898876517;1094.9890501095047;1106.789709955106;1117.0951529261324;1142.7600203957095;1217.4704003758216;17394.652106958045;17821.287148513915;17992.190351434216;18013.009284489217;18016.819831801775;510784;514493;514630;516824;518230;59734.70132649396;60753;60828.69585652043;60964;61070.694646526485;1278.5397256987478;1313.835770528684;1334.5062326939094;1367.0567308557263;1389.423389293432;30919.84540077285;33576.664233357355;33688.831555842065;34563.654363456044;34662;52380.73809630927;52943.735281323345;52949.205761914374;52995.73502132465;53086.203706943656;289292;289437;290601;290705;290974;25869;30402.391952161277;30461.54307685342;31649.8417507911;31829.681703182672;48243.27635085547;48480.7575962132;48664.27003594878;48910.51089489202;49057;40836.1832763349;40837;41129.588704112575;41274.79362603168;43444.56555434405;40283;40447;40452.19095618012;40594.391084133174;42754.572454276306;40510.59489405068;41931.37102943519;41959.790201048796;42259.78870105753;42335.15329693327;34447;36801.963356660766;36909.26181476302;37308.25383492369;37828.81085594554;28227.476140348404;28278.43443131085;28450.715492844807;28509;28512.85743571352 14:34:31 INFO - PROCESS | 18799 | |2;jquery.html;400.22356628141387;407.472323341273;411.0709795861353;415.17173239387415;417.96238338549523;18252.45242642721;18734.34429794954;19640.116194771235;19731.60536789265;19756.802431975677;18586.721199182022;18834.15246313916;19138.61722765544;19574.314898978537;19702.11340489678;5657;5672.773089076432;5820.039693450575;5852.853678658025;5854.7072646367515;5784.623999440044;5888.793892213774;5894.056950887859;5894.086416605433;5898.233229680136;5672.290963629546;5912.822615321547;5945.940540594582;6023.819285421422;6033.366496517869;5769.394213607553;5952.672603006833;5971.731272092745;5983.311919129291;6022.909656355158;5828.358880523139;5835.212246346731;5837.066069428871;5838.678872662002;5838.854028649275;14164.150150990974;18510.629787404177;19386.224551017942;22904.65643015356;23101.653475197887;2303.6890019847274;2320.431494283894;2442.829001969863;2642.484715480482;2700.2034399851896;10517.263791534595;10700.78598428027;10711.196660250434;14102.435902563886;14846.257687115709;1947.269773834812;1966.7738210105879;1970.1725275384374;1974.6050789842088;2030.0661695620033;80037.59981200115;82569;82953;83326;84304.99999999939;10766.46167691628;10941.507632156572;11163.330200188015;11197.185210359623;11246.100311975186;15802.525924222291;15863.12752798584;15987.040777553384;15988.680226395407;16024.118673472838;8063.354931605458;8169.42814003026;8251.33989280856;8339.416240863202;8387.538685372363;7809.843803123906;7864.702324116457;8037.03555573335;8067.636956336979;8071.959640201879;4797.232442809203;4871.561559459666;4888.462269150391;4889.168841296988;4988.226824842155;1993.4617653233545;2007.8092581204762;2015.7581090268968;2028.2799606139904;2029.3404643490924;879.9824003519893;929.5120061967522;937.0957026469354;966.2270183852889;966.8114717630135;17788.288468461375;19440.125194366286;19440.611187776165;19554.608907821763;19901.502462438555;988.6243227573619;996.4270544436978;1000.7682867206171;1017.9592816287413;1024.882138554061;10385.740356491147;10812.621558245424;10888.087215851394;10967.287126336763;10999.670009899715;344162;345213;346251;451699;458094;93546;95993;97062;97898.51050744843;100347;998.8951160128082;1025.6922923123182;1047.989520104789;1061.368485750977;1064.7444613292755;17142.485725428258;17588.560285992953;18017.729734053737;18041.1881465337;18223.271069157614;41563.168736624495;41586.168276634904;41836.790816046945;41994.58005420029;42710;54076.729616351666;56103;58112.4188758107;61249;62105.689471554164;6837.2820853809635;7932.6033698313695;8677.392582519416;8788.692395766118;8994.775130621787;12851.742965140831;12946.158499697489;13040.934795325962;13279.601611951657;13936;11056.281341712764;11149.665510034712;11380.317180969168;11456.083513319081;11582.478788454708;11160.218784684994;11343.773124537298;11521;11714.121440892137;11788.646340609796;11639.301641901513;11933.641990740292;11993;12027;12032.578859739868;8510.148985101441;8678.967670099773;8775.07861674515;8827;8914.955425222832;10586;11850.288982661068;11996.64010079699;12002;12002.39988000579 14:34:31 INFO - PROCESS | 18799 | |3;mootools.html;1353.8307711536058;1488.0179081806007;1492.8731057860082;1608.1557182479196;1744.2935611077519;7241.963790181048;7668.424868134891;8429.367797415203;8698.956505217466;8712.477251364922;8652.30781537477;8686.13138686131;8714.25928796053;8718.389712720113;8719.651213951434;2139.9786002139936;2168.447046003267;2169.0998235732154;2174.63031284682;2179.182806447582;2318.049599664138;2376.3465047112095;2392.2105705117356;2396.7962723168553;2398.1726304424947;2306.7001289832297;2315.3285547191294;2333.8249631277636;2368.1948137633203;2369.786719195272;2265.3430505153488;2273.1362082408664;2287.6339785634386;2290.690756747851;2293.5986202414592;2327.8836058197194;2383.7258715247794;2386.1648423051965;2386.4153282445736;2387.152560840894;8681.869771953427;8748;8748.34387420946;8750.693725719633;8759.474431534129;5085.898282034339;5161.096808058613;5322.0952438085615;5323.733813309319;5334.493223143795;3103.5655008298854;3190;3223.7421006319437;3225.0969728476066;3226.8870589529256;1013.5439052426364;1053.039794761653;1072.2601405030505;1073.500822117719;1092.2736380307085;11702.414879256003;11892.227005244631;11935.820962685566;11962.82055769164;11965.880341196564;4481.484629267676;4595.356650068993;4614.353990441341;4632.467266264355;4639;9538.666146684971;9540.522973851279;9547.331686781998;9549.140577348073;9550.904490955141;5309.070912590281;5311.760970756325;5314.149736042292;5314.202869569595;5314.681119132864;4791.928121078186;4796.378734055766;4846.636502262274;4846.7818948147415;4859.95140048595;3624.7643903146213;3674.853005879735;3742.120601658608;3758.5489741231227;3783.4892289541112;1104.5140138339104;1111.7998760223238;1113.3097479562723;1119.7144728094283;1126.4311522680994;848.809017970964;932.6455946740195;959.9040095990484;993.344392700814;1013.2653825976256;5931.940680593225;5986.6707331097205;6016.488598469092;6092.573519853568;6229.595076320115;454.3003774187714;464.0625935610116;468.3185964421758;470.5811827473551;487.9024195160982;4164.66682665386;4289.1421715657;4299.914001719948;4315.741055536678;4332.935005974913;10662.466876656292;10855.67432977012;10946.562137514411;10954.287971281841;10998.395088270061;10240;10630.787384252271;10634.946825265824;10941.4529273536;10946.890531094587;8178.550179740171;8317.085120636724;8356.080831108573;8376.12050734664;8382.958085209535;5836.678982655994;5935.169076329404;5987.580869339278;6012.969935150471;6240.625562466085;9948;9950.651727189514;9959.352642078242;10028.097471227624;10090.09189172978;10073.496325183858;10161.542730576994;10170.338927969658;10178.389296642225;10225.43760093202;7507.699692012258;7711.614419278902;7796.025496812898;7836.80407989782;8011.679532818622;8487.151284871463;8540.231379175655;8559.914400855912;8560.315174786127;8566.400351975552;7535.54786712799;7643.656035478528;7680.9231907680205;7799.610019499116;7840.3335716464735;7386.778396648109;7416;7612.276833700789;7614.390848732199;7618.123915749759;6796.18445786489;6865.862682746417;6916.723331066701;6922.342377474132;6926.619035953071;5204.115300399017;5393.9730301348245;5396.622236443568;5439;5531.7234138293725;5287.4976877196605;5361.24942508057;5410.269613602113;5420.918686219631;5484.067708489487 14:34:31 INFO - PROCESS | 18799 | |4;prototype.html;321.40379595849697;323.4905024586277;329.5386458957459;335.2942056970078;337.85978818790204;5199.714015729143;5294.226434144566;5330.147176451768;5359.839204823857;5371.382291036527;5151.871203219921;5236.397814251362;5258.421573626898;5266.447023062581;5319.734013299339;4212.410262563244;4213.768242746663;4222.071144348239;4222.472190976128;4226.577342265779;4126.298529250034;4191.2874811282;4199.748015119103;4218.519721229982;4232.74603523788;4158.958410415888;4170.791460426982;4171.728837625545;4182.602652747984;4187.958120418787;4168.7290326128705;4175.394567787654;4175.91648167038;4176.436181115556;4190.5180904195795;3512.701420379271;3605.242898991215;3626.963730362689;3633.509476220729;3700.259948010382;5141.922871156936;5168.147255702805;5168.431472538018;5176.197689358118;5179.964007198575;4705.341252224691;4708.163816111719;4709.811607535695;4721.952780472186;4724.173269677793;5391.838244852661;5450.236966824647;5484.862878428032;5518.448155184489;5529.170624406331;3963;3976.16500534888;3978.6419222270133;3984.541777695544;3997.9205614483926;5688.544916406678;5748.48263656273;5766.135079738073;5766.394528574523;5782.508486778629;3934.350832112669;4006.799660017046;4031.8185681644395;4055.141125506511;4063.2889244382704;4095.9180816383505;4105;4108.8356465741035;4122.793860306972;4127.772972486542;4683.367745354401;4695.413073365829;4697.412823397075;4699.976500117477;4717.599004084691;5446.863828404322;5465.754041068161;5533.889322213614;5565.610407271533;5583.832485025456;1287.7746394381134;1316.3878796359738;1342.8254326937436;1376.057400680537;1380.2960490150097;910.5538286239695;939.3518472254123;940.8118376324762;949.7483166960761;956.7560272130702;5112.565431938327;5145.794168233228;5158.613104017214;5196.53231209193;5199.740012999335;5450.400455949843;5454.290942177571;5454.372747134051;5462.7268636568015;5502.926929248838;4928.29973659087;5126.077306084866;5142.714321419645;5143.7685304161405;5189.598808321732;2904.5788360687584;2904.6804851466322;2909.185428080141;2910.621619189534;2921.1966709155154;5639.436056394327;5644.774209031592;5651.491365777099;5661.575381846378;5669.092945128759;5560.915621453778;5578.944210557924;5859.710863609999;5915.290165180119;5922.2597175353085;5945;5971.731272092679;5984.311804142492;5987.790427335022;5989.281286245591;5573.888522229451;5757.884842303214;5770.163326317745;5779.624324418899;5811.476967072984;5618.2415373924;5627.52166065889;5629.7748090077575;5680.7443665036;5693.28833895763;5900.881982360414;5913.645181289136;5971.522278217819;5980.611260268069;5998.25021872266;3961.5840336764227;4042.8787136385954;4080.6531444827524;4094.733842300241;4107.322291821816;5486.835394938158;5685.361368723938;5686.857828554319;5723.112917497628;5746.827595172152;5481.451854814646;5520.779168833202;5609.148980836233;5614.354349249888;5617.943820561905;5583.2462617547735;5595.356533998643;5603.047481928001;5609;5615.410381909841;5320.467953204648;5519.917201242065;5544.7227638618715;5568.805091821929;5572.136318870582;5590.245316882331;5643.125315576092;5671.716414179192;5679.602427830012;5681.431856814285;5470.863228419322;5481.424450432647;5506.394296627448;5506.559475241891;5533.806316778893 14:34:31 INFO - PROCESS | 18799 | |5;yui.html;794.4875555266854;819.6762278899835;825.4139560911752;857.9742607721771;885.5306687455649;15005;15722.449714260003;15741.763873541906;15746.685066298667;15751.60620984476;14206.502772402968;14338;14362.497312594061;14369.066010709297;14370.712585748279;793.3018943329876;819.9549024803633;821.8479581277453;822.8148666550038;823.1644880446322;824.0358780227118;824.6165533027141;826.2976470000482;826.3017750001239;826.3513142183388;883.0771843423605;883.2580632268892;883.6200433813458;884.6549845560237;884.8893888263967;876.5923845411851;876.7457437343163;880.5289170293894;880.828238493494;882.6557642519423;645.9773907913248;646.356874909468;646.5991085526956;646.935306469354;648.0959062108333;13949.02356835022;14007;14020.43918243269;14072.929635351758;14087.647808804759;12578.245305281713;13734.313284335843;13792.517261895786;13823.101498402671;13951.860481395157;10510.474476276155;10583.62957296491;10720.517576709066;10727.946360268148;10776.137908967265;3795.7153213508823;3823.600846604904;3824.9808750956345;3846.9615303847163;3937.7637341759587;44021.55978440207;45735.77132114351;55349.446505535234;58728.11907821429;62101.37898621001;10724.946375268073;10750.408727519905;10768.676939691823;10940.617078402218;11109.388983605979;18426.631467370844;18432.539186520175;18432.907835461006;18621.162047707887;18704.438866834018;7786.5440272767055;7970.322522585645;8010.359171266285;8074;8221;4573.885652858705;4629.8148074077335;4651.976740116345;4731.763411829464;4772.618190544748;3351.8324083795715;3433.896983090511;3470.5488286523096;3473.3053389322235;3483.547138871981;622.4957784194817;626.677261210477;628.9182406287154;628.9465395441439;632.9335419780949;666.0641798273433;682.3585829320522;700.9193942696553;757.1217387830201;798.3932211519287;9406.43561386319;9483.620655173854;9596.856047159297;9926.156276716416;10315.080269497694;662.5726406467801;663.1776597019757;711.9644017799089;770.7032792374976;812.544974814106;4463.866084017484;4744.667873248839;4757.785899634525;4836.46798852126;4856.125897338442;76839.2316076832;79598.60200698959;79639.20360796434;87906.56046719853;88016.55991720129;72005;73333.26666733371;74399;74895.25104748992;74910.25089749142;65926;68430;68559.3144068563;70735;71468.28531714616;9000.909990900007;9003.189712925869;9243.352965292634;9267.814643707223;9307.301952353466;41846;42574.36138457864;43345.34981975336;43838.78080609577;44397.33403999007;56103.43896560982;61546.69226653838;61788.69105654443;62585.37414625796;63440.36559634344;10305.330153539995;10462.738431538968;10828.675139745821;10846.29499082557;10945.288556243819;13106.934465327993;13160.80258796138;13161.868381316064;13260.336983150997;13856.307184640526;11933.105017123577;12366.62900112998;12662.556810511587;12868.935655321664;12896;12399.380030998595;12581.245125292511;13064.934675326562;13189.076764626385;13410.195388276734;11859.644210673694;12180.939095304468;12505.062120341192;12696.619101426972;12719.872801272239;9893.604255829687;10060;10161.441120738431;10335.379877207391;10565.788684226427;9786.432783310865;10562.577496900038;10764.838527422251;10767.138628909512;10818.621348252773 14:34:31 INFO - PROCESS | 18799 | __end_tp_report 14:34:31 INFO - PROCESS | 18799 | __start_cc_report 14:34:31 INFO - PROCESS | 18799 | _x_x_mozilla_cycle_collect,1009 14:34:31 INFO - PROCESS | 18799 | __end_cc_report 14:34:31 INFO - PROCESS | 18799 | __startTimestamp1487889271141__endTimestamp 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | ------- Summary: start ------- 14:34:31 INFO - PROCESS | 18799 | Number of tests: 6 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#0] dojo.html Cycles:165 Average:5548.23 Median:5772.39 stddev:611.76 (10.6%) stddev-sans-first:585.00 14:34:31 INFO - PROCESS | 18799 | Values: 3190.2 3215.1 3224.3 3255.3 3266.9 5610.2 5665.0 5677.7 5686.9 5689.6 5618.2 5640.7 5686.5 5689.5 5718.6 5132.8 5137.9 5149.5 5184.8 5216.8 4990.5 5194.7 5195.5 5207.5 5215.8 4975.0 5054.4 5066.1 5092.7 5108.5 5147.8 5171.6 5175.5 5227.1 5228.1 5047.7 5132.1 5172.1 5187.4 5213.8 5273.1 5315.8 5461.6 5481.4 5505.3 5904.2 5909.2 5919.0 5960.2 5976.2 5984.6 5991.5 6005.9 6007.6 6009.5 5342.3 5381.5 5541.8 5595.2 5601.6 6112.8 6146.0 6146.7 6151.1 6173.3 5918.9 5931.6 5932.8 5934.4 5935.5 5724.3 5795.1 5839.3 5897.1 5911.2 5886.5 5889.8 5907.2 5914.9 5920.5 5828.1 5871.7 5879.5 5890.8 5896.7 4464.6 4500.8 4599.6 4637.9 4678.9 4102.1 4136.0 4156.2 4162.9 4173.3 5775.7 5791.6 5792.1 5797.8 5801.5 5775.3 5824.0 6098.1 6114.1 6117.4 5673.7 5686.0 5702.1 5731.1 5748.8 5179.9 5182.5 5190.1 5195.4 5196.0 5902.3 6241.7 6246.3 6278.2 6291.7 5765.1 5929.6 5962.9 5969.8 5983.2 6097.4 6118.4 6140.1 6143.3 6147.8 5826.3 5827.7 5828.0 5829.9 5833.5 5657.7 5660.8 5872.1 5886.4 5943.7 5828.4 5856.9 5861.8 5863.0 5878.6 5851.3 5861.9 5861.9 5871.5 5875.2 5515.3 5536.5 5708.5 5772.4 5817.6 5893.5 5894.0 5895.8 5902.0 5915.6 5518.4 5751.1 5761.3 5763.8 5769.1 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#1] ext.html Cycles:180 Average:54900.37 Median:3571.26 stddev:104500.06 (2926.1%) stddev-sans-first:104713.62 14:34:31 INFO - PROCESS | 18799 | Values: 580.1 602.8 607.5 612.5 646.3 33636.3 45266.3 45295.8 45443.0 45476.8 46026.5 46689.5 46970.5 47065.5 47129.3 8390.0 9074.5 9223.0 9229.2 9241.8 8433.1 10820.4 11105.1 11108.3 11432.4 11120.2 11172.6 11172.7 11173.2 11185.9 11009.5 11072.4 11073.7 11080.4 11084.7 10927.7 10999.4 11000.7 11002.2 11020.5 44418.0 44613.0 44694.6 44743.1 44743.3 3477.2 3667.5 3670.9 3685.1 3763.8 33262.0 33367.7 33420.5 33430.8 33655.5 4523.2 4576.1 4772.5 4787.5 4798.2 337352.0 342530.0 344773.0 346445.0 347492.0 35340.6 35944.3 36414.3 62915.7 63642.0 39412.0 39520.6 39663.8 39731.0 39797.8 15695.8 15881.2 15887.3 15889.8 15893.4 11989.0 12083.9 12221.1 12929.4 12981.7 9254.2 9358.1 9363.8 9414.3 9441.1 3504.2 3547.6 3558.4 3584.2 3645.7 1022.8 1058.8 1093.9 1122.8 1188.5 32918.2 33858.8 33867.7 33977.0 34007.5 1095.0 1106.8 1117.1 1142.8 1217.5 17394.7 17821.3 17992.2 18013.0 18016.8 510784.0 514493.0 514630.0 516824.0 518230.0 59734.7 60753.0 60828.7 60964.0 61070.7 1278.5 1313.8 1334.5 1367.1 1389.4 30919.8 33576.7 33688.8 34563.7 34662.0 52380.7 52943.7 52949.2 52995.7 53086.2 289292.0 289437.0 290601.0 290705.0 290974.0 25869.0 30402.4 30461.5 31649.8 31829.7 48243.3 48480.8 48664.3 48910.5 49057.0 40836.2 40837.0 41129.6 41274.8 43444.6 40283.0 40447.0 40452.2 40594.4 42754.6 40510.6 41931.4 41959.8 42259.8 42335.2 34447.0 36802.0 36909.3 37308.3 37828.8 28227.5 28278.4 28450.7 28509.0 28512.9 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#2] jquery.html Cycles:180 Average:26414.34 Median:2542.66 stddev:65638.18 (2581.5%) stddev-sans-first:65793.26 14:34:31 INFO - PROCESS | 18799 | Values: 400.2 407.5 411.1 415.2 418.0 18252.5 18734.3 19640.1 19731.6 19756.8 18586.7 18834.2 19138.6 19574.3 19702.1 5657.0 5672.8 5820.0 5852.9 5854.7 5784.6 5888.8 5894.1 5894.1 5898.2 5672.3 5912.8 5945.9 6023.8 6033.4 5769.4 5952.7 5971.7 5983.3 6022.9 5828.4 5835.2 5837.1 5838.7 5838.9 14164.2 18510.6 19386.2 22904.7 23101.7 2303.7 2320.4 2442.8 2642.5 2700.2 10517.3 10700.8 10711.2 14102.4 14846.3 1947.3 1966.8 1970.2 1974.6 2030.1 80037.6 82569.0 82953.0 83326.0 84305.0 10766.5 10941.5 11163.3 11197.2 11246.1 15802.5 15863.1 15987.0 15988.7 16024.1 8063.4 8169.4 8251.3 8339.4 8387.5 7809.8 7864.7 8037.0 8067.6 8072.0 4797.2 4871.6 4888.5 4889.2 4988.2 1993.5 2007.8 2015.8 2028.3 2029.3 880.0 929.5 937.1 966.2 966.8 17788.3 19440.1 19440.6 19554.6 19901.5 988.6 996.4 1000.8 1018.0 1024.9 10385.7 10812.6 10888.1 10967.3 10999.7 344162.0 345213.0 346251.0 451699.0 458094.0 93546.0 95993.0 97062.0 97898.5 100347.0 998.9 1025.7 1048.0 1061.4 1064.7 17142.5 17588.6 18017.7 18041.2 18223.3 41563.2 41586.2 41836.8 41994.6 42710.0 54076.7 56103.0 58112.4 61249.0 62105.7 6837.3 7932.6 8677.4 8788.7 8994.8 12851.7 12946.2 13040.9 13279.6 13936.0 11056.3 11149.7 11380.3 11456.1 11582.5 11160.2 11343.8 11521.0 11714.1 11788.6 11639.3 11933.6 11993.0 12027.0 12032.6 8510.1 8679.0 8775.1 8827.0 8915.0 10586.0 11850.3 11996.6 12002.0 12002.4 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#3] mootools.html Cycles:180 Average:5727.09 Median:4853.37 stddev:3250.65 (67.0%) stddev-sans-first:3243.15 14:34:31 INFO - PROCESS | 18799 | Values: 1353.8 1488.0 1492.9 1608.2 1744.3 7242.0 7668.4 8429.4 8699.0 8712.5 8652.3 8686.1 8714.3 8718.4 8719.7 2140.0 2168.4 2169.1 2174.6 2179.2 2318.0 2376.3 2392.2 2396.8 2398.2 2306.7 2315.3 2333.8 2368.2 2369.8 2265.3 2273.1 2287.6 2290.7 2293.6 2327.9 2383.7 2386.2 2386.4 2387.2 8681.9 8748.0 8748.3 8750.7 8759.5 5085.9 5161.1 5322.1 5323.7 5334.5 3103.6 3190.0 3223.7 3225.1 3226.9 1013.5 1053.0 1072.3 1073.5 1092.3 11702.4 11892.2 11935.8 11962.8 11965.9 4481.5 4595.4 4614.4 4632.5 4639.0 9538.7 9540.5 9547.3 9549.1 9550.9 5309.1 5311.8 5314.1 5314.2 5314.7 4791.9 4796.4 4846.6 4846.8 4860.0 3624.8 3674.9 3742.1 3758.5 3783.5 1104.5 1111.8 1113.3 1119.7 1126.4 848.8 932.6 959.9 993.3 1013.3 5931.9 5986.7 6016.5 6092.6 6229.6 454.3 464.1 468.3 470.6 487.9 4164.7 4289.1 4299.9 4315.7 4332.9 10662.5 10855.7 10946.6 10954.3 10998.4 10240.0 10630.8 10634.9 10941.5 10946.9 8178.6 8317.1 8356.1 8376.1 8383.0 5836.7 5935.2 5987.6 6013.0 6240.6 9948.0 9950.7 9959.4 10028.1 10090.1 10073.5 10161.5 10170.3 10178.4 10225.4 7507.7 7711.6 7796.0 7836.8 8011.7 8487.2 8540.2 8559.9 8560.3 8566.4 7535.5 7643.7 7680.9 7799.6 7840.3 7386.8 7416.0 7612.3 7614.4 7618.1 6796.2 6865.9 6916.7 6922.3 6926.6 5204.1 5394.0 5396.6 5439.0 5531.7 5287.5 5361.2 5410.3 5420.9 5484.1 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#4] prototype.html Cycles:180 Average:4664.32 Median:5306.98 stddev:1377.05 (25.9%) stddev-sans-first:1341.78 14:34:31 INFO - PROCESS | 18799 | Values: 321.4 323.5 329.5 335.3 337.9 5199.7 5294.2 5330.1 5359.8 5371.4 5151.9 5236.4 5258.4 5266.4 5319.7 4212.4 4213.8 4222.1 4222.5 4226.6 4126.3 4191.3 4199.7 4218.5 4232.7 4159.0 4170.8 4171.7 4182.6 4188.0 4168.7 4175.4 4175.9 4176.4 4190.5 3512.7 3605.2 3627.0 3633.5 3700.3 5141.9 5168.1 5168.4 5176.2 5180.0 4705.3 4708.2 4709.8 4722.0 4724.2 5391.8 5450.2 5484.9 5518.4 5529.2 3963.0 3976.2 3978.6 3984.5 3997.9 5688.5 5748.5 5766.1 5766.4 5782.5 3934.4 4006.8 4031.8 4055.1 4063.3 4095.9 4105.0 4108.8 4122.8 4127.8 4683.4 4695.4 4697.4 4700.0 4717.6 5446.9 5465.8 5533.9 5565.6 5583.8 1287.8 1316.4 1342.8 1376.1 1380.3 910.6 939.4 940.8 949.7 956.8 5112.6 5145.8 5158.6 5196.5 5199.7 5450.4 5454.3 5454.4 5462.7 5502.9 4928.3 5126.1 5142.7 5143.8 5189.6 2904.6 2904.7 2909.2 2910.6 2921.2 5639.4 5644.8 5651.5 5661.6 5669.1 5560.9 5578.9 5859.7 5915.3 5922.3 5945.0 5971.7 5984.3 5987.8 5989.3 5573.9 5757.9 5770.2 5779.6 5811.5 5618.2 5627.5 5629.8 5680.7 5693.3 5900.9 5913.6 5971.5 5980.6 5998.3 3961.6 4042.9 4080.7 4094.7 4107.3 5486.8 5685.4 5686.9 5723.1 5746.8 5481.5 5520.8 5609.1 5614.4 5617.9 5583.2 5595.4 5603.0 5609.0 5615.4 5320.5 5519.9 5544.7 5568.8 5572.1 5590.2 5643.1 5671.7 5679.6 5681.4 5470.9 5481.4 5506.4 5506.6 5533.8 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - PROCESS | 18799 | [#5] yui.html Cycles:180 Average:17043.29 Median:4738.22 stddev:22286.59 (470.4%) stddev-sans-first:22315.71 14:34:31 INFO - PROCESS | 18799 | Values: 794.5 819.7 825.4 858.0 885.5 15005.0 15722.4 15741.8 15746.7 15751.6 14206.5 14338.0 14362.5 14369.1 14370.7 793.3 820.0 821.8 822.8 823.2 824.0 824.6 826.3 826.3 826.4 883.1 883.3 883.6 884.7 884.9 876.6 876.7 880.5 880.8 882.7 646.0 646.4 646.6 646.9 648.1 13949.0 14007.0 14020.4 14072.9 14087.6 12578.2 13734.3 13792.5 13823.1 13951.9 10510.5 10583.6 10720.5 10727.9 10776.1 3795.7 3823.6 3825.0 3847.0 3937.8 44021.6 45735.8 55349.4 58728.1 62101.4 10724.9 10750.4 10768.7 10940.6 11109.4 18426.6 18432.5 18432.9 18621.2 18704.4 7786.5 7970.3 8010.4 8074.0 8221.0 4573.9 4629.8 4652.0 4731.8 4772.6 3351.8 3433.9 3470.5 3473.3 3483.5 622.5 626.7 628.9 628.9 632.9 666.1 682.4 700.9 757.1 798.4 9406.4 9483.6 9596.9 9926.2 10315.1 662.6 663.2 712.0 770.7 812.5 4463.9 4744.7 4757.8 4836.5 4856.1 76839.2 79598.6 79639.2 87906.6 88016.6 72005.0 73333.3 74399.0 74895.3 74910.3 65926.0 68430.0 68559.3 70735.0 71468.3 9000.9 9003.2 9243.4 9267.8 9307.3 41846.0 42574.4 43345.3 43838.8 44397.3 56103.4 61546.7 61788.7 62585.4 63440.4 10305.3 10462.7 10828.7 10846.3 10945.3 13106.9 13160.8 13161.9 13260.3 13856.3 11933.1 12366.6 12662.6 12868.9 12896.0 12399.4 12581.2 13064.9 13189.1 13410.2 11859.6 12180.9 12505.1 12696.6 12719.9 9893.6 10060.0 10161.4 10335.4 10565.8 9786.4 10562.6 10764.8 10767.1 10818.6 14:34:31 INFO - PROCESS | 18799 | -------- Summary: end -------- 14:34:31 INFO - PROCESS | 18799 | 14:34:31 INFO - TEST-INFO | 18799: exit 0 14:34:31 INFO - TEST-OK | dromaeo_css | took 1115958ms 14:34:31 INFO - TEST-START | kraken 14:34:31 INFO - operating with platform_type : linux_ 14:34:31 INFO - Initialising browser for kraken test... 14:34:31 INFO - TEST-INFO | started process 19107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV_nVRF/profile http://localhost:58210/getInfo.html) 14:34:36 INFO - PROCESS | 19107 | __metrics Screen width/height:1600/1200 14:34:36 INFO - PROCESS | 19107 | colorDepth:24 14:34:36 INFO - PROCESS | 19107 | Browser inner width/height: 1024/697 14:34:36 INFO - PROCESS | 19107 | __metrics 14:34:36 INFO - PROCESS | 19107 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:34:36 INFO - PROCESS | 19107 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:34:37 INFO - TEST-INFO | 19107: exit 0 14:34:37 INFO - Browser initialized. 14:34:37 INFO - Running cycle 1/1 for kraken test... 14:34:37 INFO - TEST-INFO | started process 19201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV_nVRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:49 INFO - PROCESS | 19201 | RSS: Main: 141684736 14:34:49 INFO - PROCESS | 19201 | 14:34:52 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58210/tests/kraken/driver.html?testName=audio-beat-detection) 14:34:52 INFO - PROCESS | 19201 | RSS: Main: 183619584 14:34:52 INFO - PROCESS | 19201 | 14:34:55 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58210/tests/kraken/driver.html?testName=audio-dft) 14:34:56 INFO - PROCESS | 19201 | RSS: Main: 173256704 14:34:56 INFO - PROCESS | 19201 | 14:34:58 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58210/tests/kraken/driver.html?testName=audio-fft) 14:34:59 INFO - PROCESS | 19201 | RSS: Main: 264564736 14:34:59 INFO - PROCESS | 19201 | 14:35:01 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58210/tests/kraken/driver.html?testName=audio-oscillator) 14:35:02 INFO - PROCESS | 19201 | RSS: Main: 171450368 14:35:02 INFO - PROCESS | 19201 | 14:35:04 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:04 INFO - PROCESS | 19201 | RSS: Main: 173699072 14:35:04 INFO - PROCESS | 19201 | 14:35:07 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58210/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:08 INFO - PROCESS | 19201 | RSS: Main: 212258816 14:35:08 INFO - PROCESS | 19201 | 14:35:11 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58210/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:12 INFO - PROCESS | 19201 | RSS: Main: 210694144 14:35:12 INFO - PROCESS | 19201 | 14:35:14 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58210/tests/kraken/driver.html?testName=json-parse-financial) 14:35:15 INFO - PROCESS | 19201 | RSS: Main: 208953344 14:35:15 INFO - PROCESS | 19201 | 14:35:16 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:17 INFO - PROCESS | 19201 | RSS: Main: 171819008 14:35:17 INFO - PROCESS | 19201 | 14:35:19 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:19 INFO - PROCESS | 19201 | RSS: Main: 178630656 14:35:19 INFO - PROCESS | 19201 | 14:35:21 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:22 INFO - PROCESS | 19201 | RSS: Main: 188522496 14:35:22 INFO - PROCESS | 19201 | 14:35:24 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:25 INFO - PROCESS | 19201 | RSS: Main: 197070848 14:35:25 INFO - PROCESS | 19201 | 14:35:28 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:28 INFO - PROCESS | 19201 | RSS: Main: 192917504 14:35:28 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | Cycle 1(1): loaded http://localhost:58210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58210/tests/kraken/driver.html?testName=ai-astar) 14:35:30 INFO - PROCESS | 19201 | RSS: Main: 245043200 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | __start_tp_report 14:35:30 INFO - PROCESS | 19201 | _x_x_mozilla_page_load 14:35:30 INFO - PROCESS | 19201 | _x_x_mozilla_page_load_details 14:35:30 INFO - PROCESS | 19201 | |i|pagename|runs| 14:35:30 INFO - PROCESS | 19201 | |0;ai-astar;102;112;110;111;110;111;111;112;112;112 14:35:30 INFO - PROCESS | 19201 | |1;audio-beat-detection;148;117;117;158;123;117;117;117;147;122 14:35:30 INFO - PROCESS | 19201 | |2;audio-dft;160;161;159;161;161;161;160;162;160;162 14:35:30 INFO - PROCESS | 19201 | |3;audio-fft;74;75;76;106;75;75;74;76;105;75 14:35:30 INFO - PROCESS | 19201 | |4;audio-oscillator;83;81;109;82;82;83;99;82;81;115 14:35:30 INFO - PROCESS | 19201 | |5;imaging-gaussian-blur;118;117;117;117;117;117;116;117;117;117 14:35:30 INFO - PROCESS | 19201 | |6;imaging-darkroom;146;145;146;145;145;146;146;145;146;146 14:35:30 INFO - PROCESS | 19201 | |7;imaging-desaturate;85;85;85;84;85;84;85;85;84;84 14:35:30 INFO - PROCESS | 19201 | |8;json-parse-financial;50;53;50;50;51;50;50;59;55;51 14:35:30 INFO - PROCESS | 19201 | |9;json-stringify-tinderbox;62;60;60;60;61;59;60;60;60;60 14:35:30 INFO - PROCESS | 19201 | |10;stanford-crypto-aes;74;74;74;75;83;75;76;74;75;74 14:35:30 INFO - PROCESS | 19201 | |11;stanford-crypto-ccm;124;122;127;142;123;120;119;119;166;133 14:35:30 INFO - PROCESS | 19201 | |12;stanford-crypto-pbkdf2;157;161;156;161;160;157;154;158;155;157 14:35:30 INFO - PROCESS | 19201 | |13;stanford-crypto-sha256-iterative;62;63;64;63;63;65;62;66;61;61 14:35:30 INFO - PROCESS | 19201 | __end_tp_report 14:35:30 INFO - PROCESS | 19201 | __start_cc_report 14:35:30 INFO - PROCESS | 19201 | _x_x_mozilla_cycle_collect,1616 14:35:30 INFO - PROCESS | 19201 | __end_cc_report 14:35:30 INFO - PROCESS | 19201 | __startTimestamp1487889330826__endTimestamp 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | ------- Summary: start ------- 14:35:30 INFO - PROCESS | 19201 | Number of tests: 14 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 14:35:30 INFO - PROCESS | 19201 | Values: 102.0 112.0 110.0 111.0 110.0 111.0 111.0 112.0 112.0 112.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:122.50 stddev:16.08 (13.1%) stddev-sans-first:15.39 14:35:30 INFO - PROCESS | 19201 | Values: 148.0 117.0 117.0 158.0 123.0 117.0 117.0 117.0 147.0 122.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 14:35:30 INFO - PROCESS | 19201 | Values: 160.0 161.0 159.0 161.0 161.0 161.0 160.0 162.0 160.0 162.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.88 (17.2%) stddev-sans-first:13.40 14:35:30 INFO - PROCESS | 19201 | Values: 74.0 75.0 76.0 106.0 75.0 75.0 74.0 76.0 105.0 75.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:12.99 (15.8%) stddev-sans-first:13.55 14:35:30 INFO - PROCESS | 19201 | Values: 83.0 81.0 109.0 82.0 82.0 83.0 99.0 82.0 81.0 115.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 14:35:30 INFO - PROCESS | 19201 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:35:30 INFO - PROCESS | 19201 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 14:35:30 INFO - PROCESS | 19201 | Values: 85.0 85.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:51.00 stddev:3.00 (5.9%) stddev-sans-first:3.10 14:35:30 INFO - PROCESS | 19201 | Values: 50.0 53.0 50.0 50.0 51.0 50.0 50.0 59.0 55.0 51.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.50 14:35:30 INFO - PROCESS | 19201 | Values: 62.0 60.0 60.0 60.0 61.0 59.0 60.0 60.0 60.0 60.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:2.76 (3.7%) stddev-sans-first:2.88 14:35:30 INFO - PROCESS | 19201 | Values: 74.0 74.0 74.0 75.0 83.0 75.0 76.0 74.0 75.0 74.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:125.50 stddev:14.71 (11.7%) stddev-sans-first:15.46 14:35:30 INFO - PROCESS | 19201 | Values: 124.0 122.0 127.0 142.0 123.0 120.0 119.0 119.0 166.0 133.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:157.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 14:35:30 INFO - PROCESS | 19201 | Values: 157.0 161.0 156.0 161.0 160.0 157.0 154.0 158.0 155.0 157.0 14:35:30 INFO - PROCESS | 19201 | 14:35:30 INFO - PROCESS | 19201 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.63 (2.6%) stddev-sans-first:1.69 14:35:30 INFO - PROCESS | 19201 | Values: 62.0 63.0 64.0 63.0 63.0 65.0 62.0 66.0 61.0 61.0 14:35:30 INFO - PROCESS | 19201 | -------- Summary: end -------- 14:35:30 INFO - PROCESS | 19201 | 14:35:31 INFO - TEST-INFO | 19201: exit 0 14:35:31 INFO - TEST-OK | kraken | took 59996ms 14:35:31 INFO - SUITE-END | took 1175s 14:35:31 INFO - Completed test suite (00:19:35) 14:35:31 INFO - javascript benchmark 14:35:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3190.1705556555294, 3215.067630387188, 3224.32289219264, 3255.2838375557367, 3266.901992940211, 5610.214569960203, 5665.0, 5677.744501497432, 5686.914696279559, 5689.630174038684, 5618.2415373924505, 5640.717964101788, 5686.516646085078, 5689.459501347375, 5718.628289161202, 5132.820351287705, 5137.948620513803, 5149.459306772791, 5184.792608295664, 5216.791328346881, 4990.500949905017, 5194.740262986855, 5195.480451954793, 5207.531322181003, 5215.843524694246, 4974.950250497503, 5054.368203974504, 5066.138756411419, 5092.745362731867, 5108.4636113208135, 5147.8455646330485, 5171.612129090315, 5175.482451754832, 5227.059129356714, 5228.111221092423, 5047.7476126193915, 5132.076226279269, 5172.069027575035, 5187.3775146982225, 5213.7914483421, 5273.077211488013, 5315.840524784263, 5461.644993075437, 5481.369642491125, 5505.256790333294, 5904.232449781501, 5909.2022576951995, 5919.0, 5960.165576819249, 5976.223090998143, 5984.611000285011, 5991.460768530809, 6005.879882402372, 6007.579469437097, 6009.549283803733, 5342.305500284938, 5381.461853814626, 5541.778328866881, 5595.21666966625, 5601.6358936668985, 6112.786052488142, 6146.0473626587955, 6146.7233974471255, 6151.138840562325, 6173.32093469718, 5918.852028699231, 5931.58478906481, 5932.762689492458, 5934.406559344031, 5935.495482884004, 5724.341700704473, 5795.1017592273265, 5839.270091238595, 5897.115432685046, 5911.172435858984, 5886.470217680429, 5889.764409423661, 5907.202527658797, 5914.8817023659285, 5920.526357891358, 5828.0966450200285, 5871.735771890275, 5879.529637629065, 5890.793822216202, 5896.705164741746, 4464.620507256855, 4500.774961251925, 4599.609033232213, 4637.907241855211, 4678.859634210911, 4102.098898962746, 4136.028033412145, 4156.210320039243, 4162.895927601774, 4173.332266837291, 5775.653460792366, 5791.62354446968, 5792.102224155263, 5797.768089276466, 5801.53587712982, 5775.27809023872, 5823.970880145572, 6098.085287206865, 6114.0828875669, 6117.449429551273, 5673.659580425187, 5686.0333743263745, 5702.087665973508, 5731.111677689964, 5748.770049198069, 5179.948200518022, 5182.455842136596, 5190.11767999441, 5195.376554813447, 5196.038732834362, 5902.291724993029, 6241.719122639583, 6246.281677607042, 6278.246610406689, 6291.6539590321145, 5765.077587586134, 5929.584929054925, 5962.940370596412, 5969.791057313147, 5983.162357270073, 6097.359777223328, 6118.388161183846, 6140.078988151813, 6143.324234334309, 6147.784827531015, 5826.300843898759, 5827.679477628772, 5828.0, 5829.854253643693, 5833.533317334688, 5657.745401456862, 5660.830175094754, 5872.119182122716, 5886.440788125121, 5943.702814859326, 5828.417158284307, 5856.853578660568, 5861.7655293787775, 5863.032599621015, 5878.588498805043, 5851.268591426072, 5861.912071318849, 5861.9413805863105, 5871.4715675589405, 5875.177475153568, 5515.338159420895, 5536.474034966672, 5708.514776244066, 5772.393898640582, 5817.563682723728, 5893.469587737124, 5893.9685555026845, 5895.793647222326, 5902.0, 5915.615484993462, 5518.365387980433, 5751.051076572318, 5761.337446193741, 5763.827085187451, 5769.105788602773], "value": 5508.028485520059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.0892598620165, 602.7619090459272, 607.5413063137333, 612.5497759147028, 646.2761706888285, 33636.327273454546, 45266.321005184946, 45295.77352113239, 45443.0, 45476.77261613696, 46026.539734602644, 46689.533104668946, 46970.53029469704, 47065.52934470654, 47129.29306060403, 8390.0, 9074.546272686355, 9223.0, 9229.21551668109, 9241.815163696756, 8433.072362040171, 10820.350778953289, 11105.111591072695, 11108.333499990027, 11432.428378581038, 11120.165987550925, 11172.553097876074, 11172.664820055412, 11173.21787474877, 11185.888141118607, 11009.504572294267, 11072.446377681124, 11073.667789966314, 11080.445977701123, 11084.667459976134, 10927.672169834917, 10999.395033273167, 11000.724981875517, 11002.229843910929, 11020.50407731654, 44418.0, 44613.0, 44694.55305446936, 44743.10513789706, 44743.32885006727, 3477.1828620274214, 3667.504886840269, 3670.926581468382, 3685.0787303174206, 3763.7929913854728, 33262.0, 33367.6663233367, 33420.49869251963, 33430.83284583561, 33655.4951675725, 4523.185826551219, 4576.107659006495, 4772.546608072227, 4787.473377928425, 4798.208295631217, 337352.0, 342530.0, 344773.0, 346445.0, 347492.0, 35340.64659353425, 35944.28111437757, 36414.27171456556, 62915.6854215726, 63642.045369319494, 39412.0, 39520.604793951694, 39663.801680991986, 39731.0, 39797.80101099534, 15695.764563531557, 15881.205939702968, 15887.28507217178, 15889.761653575206, 15893.364265429485, 11989.0, 12083.879161208451, 12221.144519883523, 12929.418176182095, 12981.675458113434, 9254.167124958785, 9358.11097945694, 9363.765905852271, 9414.340996130342, 9441.055894410503, 3504.2115524006895, 3547.627499112556, 3558.3594952908206, 3584.1577229351083, 3645.65366290202, 1022.7954409118206, 1058.7564860082225, 1093.8523299354645, 1122.7529943412437, 1188.4651906642046, 32918.177045574055, 33858.83070584631, 33867.66132338645, 33977.0, 34007.4898876517, 1094.9890501095047, 1106.789709955106, 1117.0951529261324, 1142.7600203957095, 1217.4704003758216, 17394.652106958045, 17821.287148513915, 17992.190351434216, 18013.009284489217, 18016.819831801775, 510784.0, 514493.0, 514630.0, 516824.0, 518230.0, 59734.70132649396, 60753.0, 60828.69585652043, 60964.0, 61070.694646526485, 1278.5397256987478, 1313.835770528684, 1334.5062326939094, 1367.0567308557263, 1389.423389293432, 30919.84540077285, 33576.664233357355, 33688.831555842065, 34563.654363456044, 34662.0, 52380.73809630927, 52943.735281323345, 52949.205761914374, 52995.73502132465, 53086.203706943656, 289292.0, 289437.0, 290601.0, 290705.0, 290974.0, 25869.0, 30402.391952161277, 30461.54307685342, 31649.8417507911, 31829.681703182672, 48243.27635085547, 48480.7575962132, 48664.27003594878, 48910.51089489202, 49057.0, 40836.1832763349, 40837.0, 41129.588704112575, 41274.79362603168, 43444.56555434405, 40283.0, 40447.0, 40452.19095618012, 40594.391084133174, 42754.572454276306, 40510.59489405068, 41931.37102943519, 41959.790201048796, 42259.78870105753, 42335.15329693327, 34447.0, 36801.963356660766, 36909.26181476302, 37308.25383492369, 37828.81085594554, 28227.476140348404, 28278.43443131085, 28450.715492844807, 28509.0, 28512.85743571352], "value": 19542.925849594423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.22356628141387, 407.472323341273, 411.0709795861353, 415.17173239387415, 417.96238338549523, 18252.45242642721, 18734.34429794954, 19640.116194771235, 19731.60536789265, 19756.802431975677, 18586.721199182022, 18834.15246313916, 19138.61722765544, 19574.314898978537, 19702.11340489678, 5657.0, 5672.773089076432, 5820.039693450575, 5852.853678658025, 5854.7072646367515, 5784.623999440044, 5888.793892213774, 5894.056950887859, 5894.086416605433, 5898.233229680136, 5672.290963629546, 5912.822615321547, 5945.940540594582, 6023.819285421422, 6033.366496517869, 5769.394213607553, 5952.672603006833, 5971.731272092745, 5983.311919129291, 6022.909656355158, 5828.358880523139, 5835.212246346731, 5837.066069428871, 5838.678872662002, 5838.854028649275, 14164.150150990974, 18510.629787404177, 19386.224551017942, 22904.65643015356, 23101.653475197887, 2303.6890019847274, 2320.431494283894, 2442.829001969863, 2642.484715480482, 2700.2034399851896, 10517.263791534595, 10700.78598428027, 10711.196660250434, 14102.435902563886, 14846.257687115709, 1947.269773834812, 1966.7738210105879, 1970.1725275384374, 1974.6050789842088, 2030.0661695620033, 80037.59981200115, 82569.0, 82953.0, 83326.0, 84304.99999999939, 10766.46167691628, 10941.507632156572, 11163.330200188015, 11197.185210359623, 11246.100311975186, 15802.525924222291, 15863.12752798584, 15987.040777553384, 15988.680226395407, 16024.118673472838, 8063.354931605458, 8169.42814003026, 8251.33989280856, 8339.416240863202, 8387.538685372363, 7809.843803123906, 7864.702324116457, 8037.03555573335, 8067.636956336979, 8071.959640201879, 4797.232442809203, 4871.561559459666, 4888.462269150391, 4889.168841296988, 4988.226824842155, 1993.4617653233545, 2007.8092581204762, 2015.7581090268968, 2028.2799606139904, 2029.3404643490924, 879.9824003519893, 929.5120061967522, 937.0957026469354, 966.2270183852889, 966.8114717630135, 17788.288468461375, 19440.125194366286, 19440.611187776165, 19554.608907821763, 19901.502462438555, 988.6243227573619, 996.4270544436978, 1000.7682867206171, 1017.9592816287413, 1024.882138554061, 10385.740356491147, 10812.621558245424, 10888.087215851394, 10967.287126336763, 10999.670009899715, 344162.0, 345213.0, 346251.0, 451699.0, 458094.0, 93546.0, 95993.0, 97062.0, 97898.51050744843, 100347.0, 998.8951160128082, 1025.6922923123182, 1047.989520104789, 1061.368485750977, 1064.7444613292755, 17142.485725428258, 17588.560285992953, 18017.729734053737, 18041.1881465337, 18223.271069157614, 41563.168736624495, 41586.168276634904, 41836.790816046945, 41994.58005420029, 42710.0, 54076.729616351666, 56103.0, 58112.4188758107, 61249.0, 62105.689471554164, 6837.2820853809635, 7932.6033698313695, 8677.392582519416, 8788.692395766118, 8994.775130621787, 12851.742965140831, 12946.158499697489, 13040.934795325962, 13279.601611951657, 13936.0, 11056.281341712764, 11149.665510034712, 11380.317180969168, 11456.083513319081, 11582.478788454708, 11160.218784684994, 11343.773124537298, 11521.0, 11714.121440892137, 11788.646340609796, 11639.301641901513, 11933.641990740292, 11993.0, 12027.0, 12032.578859739868, 8510.148985101441, 8678.967670099773, 8775.07861674515, 8827.0, 8914.955425222832, 10586.0, 11850.288982661068, 11996.64010079699, 12002.0, 12002.39988000579], "value": 9278.484307151048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.8307711536058, 1488.0179081806007, 1492.8731057860082, 1608.1557182479196, 1744.2935611077519, 7241.963790181048, 7668.424868134891, 8429.367797415203, 8698.956505217466, 8712.477251364922, 8652.30781537477, 8686.13138686131, 8714.25928796053, 8718.389712720113, 8719.651213951434, 2139.9786002139936, 2168.447046003267, 2169.0998235732154, 2174.63031284682, 2179.182806447582, 2318.049599664138, 2376.3465047112095, 2392.2105705117356, 2396.7962723168553, 2398.1726304424947, 2306.7001289832297, 2315.3285547191294, 2333.8249631277636, 2368.1948137633203, 2369.786719195272, 2265.3430505153488, 2273.1362082408664, 2287.6339785634386, 2290.690756747851, 2293.5986202414592, 2327.8836058197194, 2383.7258715247794, 2386.1648423051965, 2386.4153282445736, 2387.152560840894, 8681.869771953427, 8748.0, 8748.34387420946, 8750.693725719633, 8759.474431534129, 5085.898282034339, 5161.096808058613, 5322.0952438085615, 5323.733813309319, 5334.493223143795, 3103.5655008298854, 3190.0, 3223.7421006319437, 3225.0969728476066, 3226.8870589529256, 1013.5439052426364, 1053.039794761653, 1072.2601405030505, 1073.500822117719, 1092.2736380307085, 11702.414879256003, 11892.227005244631, 11935.820962685566, 11962.82055769164, 11965.880341196564, 4481.484629267676, 4595.356650068993, 4614.353990441341, 4632.467266264355, 4639.0, 9538.666146684971, 9540.522973851279, 9547.331686781998, 9549.140577348073, 9550.904490955141, 5309.070912590281, 5311.760970756325, 5314.149736042292, 5314.202869569595, 5314.681119132864, 4791.928121078186, 4796.378734055766, 4846.636502262274, 4846.7818948147415, 4859.95140048595, 3624.7643903146213, 3674.853005879735, 3742.120601658608, 3758.5489741231227, 3783.4892289541112, 1104.5140138339104, 1111.7998760223238, 1113.3097479562723, 1119.7144728094283, 1126.4311522680994, 848.809017970964, 932.6455946740195, 959.9040095990484, 993.344392700814, 1013.2653825976256, 5931.940680593225, 5986.6707331097205, 6016.488598469092, 6092.573519853568, 6229.595076320115, 454.3003774187714, 464.0625935610116, 468.3185964421758, 470.5811827473551, 487.9024195160982, 4164.66682665386, 4289.1421715657, 4299.914001719948, 4315.741055536678, 4332.935005974913, 10662.466876656292, 10855.67432977012, 10946.562137514411, 10954.287971281841, 10998.395088270061, 10240.0, 10630.787384252271, 10634.946825265824, 10941.4529273536, 10946.890531094587, 8178.550179740171, 8317.085120636724, 8356.080831108573, 8376.12050734664, 8382.958085209535, 5836.678982655994, 5935.169076329404, 5987.580869339278, 6012.969935150471, 6240.625562466085, 9948.0, 9950.651727189514, 9959.352642078242, 10028.097471227624, 10090.09189172978, 10073.496325183858, 10161.542730576994, 10170.338927969658, 10178.389296642225, 10225.43760093202, 7507.699692012258, 7711.614419278902, 7796.025496812898, 7836.80407989782, 8011.679532818622, 8487.151284871463, 8540.231379175655, 8559.914400855912, 8560.315174786127, 8566.400351975552, 7535.54786712799, 7643.656035478528, 7680.9231907680205, 7799.610019499116, 7840.3335716464735, 7386.778396648109, 7416.0, 7612.276833700789, 7614.390848732199, 7618.123915749759, 6796.18445786489, 6865.862682746417, 6916.723331066701, 6922.342377474132, 6926.619035953071, 5204.115300399017, 5393.9730301348245, 5396.622236443568, 5439.0, 5531.7234138293725, 5287.4976877196605, 5361.24942508057, 5410.269613602113, 5420.918686219631, 5484.067708489487], "value": 4497.847784693169, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.40379595849697, 323.4905024586277, 329.5386458957459, 335.2942056970078, 337.85978818790204, 5199.714015729143, 5294.226434144566, 5330.147176451768, 5359.839204823857, 5371.382291036527, 5151.871203219921, 5236.397814251362, 5258.421573626898, 5266.447023062581, 5319.734013299339, 4212.410262563244, 4213.768242746663, 4222.071144348239, 4222.472190976128, 4226.577342265779, 4126.298529250034, 4191.2874811282, 4199.748015119103, 4218.519721229982, 4232.74603523788, 4158.958410415888, 4170.791460426982, 4171.728837625545, 4182.602652747984, 4187.958120418787, 4168.7290326128705, 4175.394567787654, 4175.91648167038, 4176.436181115556, 4190.5180904195795, 3512.701420379271, 3605.242898991215, 3626.963730362689, 3633.509476220729, 3700.259948010382, 5141.922871156936, 5168.147255702805, 5168.431472538018, 5176.197689358118, 5179.964007198575, 4705.341252224691, 4708.163816111719, 4709.811607535695, 4721.952780472186, 4724.173269677793, 5391.838244852661, 5450.236966824647, 5484.862878428032, 5518.448155184489, 5529.170624406331, 3963.0, 3976.16500534888, 3978.6419222270133, 3984.541777695544, 3997.9205614483926, 5688.544916406678, 5748.48263656273, 5766.135079738073, 5766.394528574523, 5782.508486778629, 3934.350832112669, 4006.799660017046, 4031.8185681644395, 4055.141125506511, 4063.2889244382704, 4095.9180816383505, 4105.0, 4108.8356465741035, 4122.793860306972, 4127.772972486542, 4683.367745354401, 4695.413073365829, 4697.412823397075, 4699.976500117477, 4717.599004084691, 5446.863828404322, 5465.754041068161, 5533.889322213614, 5565.610407271533, 5583.832485025456, 1287.7746394381134, 1316.3878796359738, 1342.8254326937436, 1376.057400680537, 1380.2960490150097, 910.5538286239695, 939.3518472254123, 940.8118376324762, 949.7483166960761, 956.7560272130702, 5112.565431938327, 5145.794168233228, 5158.613104017214, 5196.53231209193, 5199.740012999335, 5450.400455949843, 5454.290942177571, 5454.372747134051, 5462.7268636568015, 5502.926929248838, 4928.29973659087, 5126.077306084866, 5142.714321419645, 5143.7685304161405, 5189.598808321732, 2904.5788360687584, 2904.6804851466322, 2909.185428080141, 2910.621619189534, 2921.1966709155154, 5639.436056394327, 5644.774209031592, 5651.491365777099, 5661.575381846378, 5669.092945128759, 5560.915621453778, 5578.944210557924, 5859.710863609999, 5915.290165180119, 5922.2597175353085, 5945.0, 5971.731272092679, 5984.311804142492, 5987.790427335022, 5989.281286245591, 5573.888522229451, 5757.884842303214, 5770.163326317745, 5779.624324418899, 5811.476967072984, 5618.2415373924, 5627.52166065889, 5629.7748090077575, 5680.7443665036, 5693.28833895763, 5900.881982360414, 5913.645181289136, 5971.522278217819, 5980.611260268069, 5998.25021872266, 3961.5840336764227, 4042.8787136385954, 4080.6531444827524, 4094.733842300241, 4107.322291821816, 5486.835394938158, 5685.361368723938, 5686.857828554319, 5723.112917497628, 5746.827595172152, 5481.451854814646, 5520.779168833202, 5609.148980836233, 5614.354349249888, 5617.943820561905, 5583.2462617547735, 5595.356533998643, 5603.047481928001, 5609.0, 5615.410381909841, 5320.467953204648, 5519.917201242065, 5544.7227638618715, 5568.805091821929, 5572.136318870582, 5590.245316882331, 5643.125315576092, 5671.716414179192, 5679.602427830012, 5681.431856814285, 5470.863228419322, 5481.424450432647, 5506.394296627448, 5506.559475241891, 5533.806316778893], "value": 4221.073800508414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.4875555266854, 819.6762278899835, 825.4139560911752, 857.9742607721771, 885.5306687455649, 15005.0, 15722.449714260003, 15741.763873541906, 15746.685066298667, 15751.60620984476, 14206.502772402968, 14338.0, 14362.497312594061, 14369.066010709297, 14370.712585748279, 793.3018943329876, 819.9549024803633, 821.8479581277453, 822.8148666550038, 823.1644880446322, 824.0358780227118, 824.6165533027141, 826.2976470000482, 826.3017750001239, 826.3513142183388, 883.0771843423605, 883.2580632268892, 883.6200433813458, 884.6549845560237, 884.8893888263967, 876.5923845411851, 876.7457437343163, 880.5289170293894, 880.828238493494, 882.6557642519423, 645.9773907913248, 646.356874909468, 646.5991085526956, 646.935306469354, 648.0959062108333, 13949.02356835022, 14007.0, 14020.43918243269, 14072.929635351758, 14087.647808804759, 12578.245305281713, 13734.313284335843, 13792.517261895786, 13823.101498402671, 13951.860481395157, 10510.474476276155, 10583.62957296491, 10720.517576709066, 10727.946360268148, 10776.137908967265, 3795.7153213508823, 3823.600846604904, 3824.9808750956345, 3846.9615303847163, 3937.7637341759587, 44021.55978440207, 45735.77132114351, 55349.446505535234, 58728.11907821429, 62101.37898621001, 10724.946375268073, 10750.408727519905, 10768.676939691823, 10940.617078402218, 11109.388983605979, 18426.631467370844, 18432.539186520175, 18432.907835461006, 18621.162047707887, 18704.438866834018, 7786.5440272767055, 7970.322522585645, 8010.359171266285, 8074.0, 8221.0, 4573.885652858705, 4629.8148074077335, 4651.976740116345, 4731.763411829464, 4772.618190544748, 3351.8324083795715, 3433.896983090511, 3470.5488286523096, 3473.3053389322235, 3483.547138871981, 622.4957784194817, 626.677261210477, 628.9182406287154, 628.9465395441439, 632.9335419780949, 666.0641798273433, 682.3585829320522, 700.9193942696553, 757.1217387830201, 798.3932211519287, 9406.43561386319, 9483.620655173854, 9596.856047159297, 9926.156276716416, 10315.080269497694, 662.5726406467801, 663.1776597019757, 711.9644017799089, 770.7032792374976, 812.544974814106, 4463.866084017484, 4744.667873248839, 4757.785899634525, 4836.46798852126, 4856.125897338442, 76839.2316076832, 79598.60200698959, 79639.20360796434, 87906.56046719853, 88016.55991720129, 72005.0, 73333.26666733371, 74399.0, 74895.25104748992, 74910.25089749142, 65926.0, 68430.0, 68559.3144068563, 70735.0, 71468.28531714616, 9000.909990900007, 9003.189712925869, 9243.352965292634, 9267.814643707223, 9307.301952353466, 41846.0, 42574.36138457864, 43345.34981975336, 43838.78080609577, 44397.33403999007, 56103.43896560982, 61546.69226653838, 61788.69105654443, 62585.37414625796, 63440.36559634344, 10305.330153539995, 10462.738431538968, 10828.675139745821, 10846.29499082557, 10945.288556243819, 13106.934465327993, 13160.80258796138, 13161.868381316064, 13260.336983150997, 13856.307184640526, 11933.105017123577, 12366.62900112998, 12662.556810511587, 12868.935655321664, 12896.0, 12399.380030998595, 12581.245125292511, 13064.934675326562, 13189.076764626385, 13410.195388276734, 11859.644210673694, 12180.939095304468, 12505.062120341192, 12696.619101426972, 12719.872801272239, 9893.604255829687, 10060.0, 10161.441120738431, 10335.379877207391, 10565.788684226427, 9786.432783310865, 10562.577496900038, 10764.838527422251, 10767.138628909512, 10818.621348252773], "value": 7039.687845288522, "unit": "score"}], "name": "dromaeo_css", "value": 7149.0456170186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 112.0, 112.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 117.0, 158.0, 123.0, 117.0, 117.0, 117.0, 147.0, 122.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 106.0, 75.0, 75.0, 74.0, 76.0, 105.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 109.0, 82.0, 82.0, 83.0, 99.0, 82.0, 81.0, 115.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 50.0, 50.0, 51.0, 50.0, 50.0, 59.0, 55.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 83.0, 75.0, 76.0, 74.0, 75.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 127.0, 142.0, 123.0, 120.0, 119.0, 119.0, 166.0, 133.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 156.0, 161.0, 160.0, 157.0, 154.0, 158.0, 155.0, 157.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 65.0, 62.0, 66.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1454.9, "alertThreshold": 2.0}]} 14:35:32 INFO - Return code: 0 14:35:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:35:32 INFO - # TBPL SUCCESS # 14:35:32 INFO - Running post-action listener: _resource_record_post_action 14:35:32 INFO - [mozharness: 2017-02-23 22:35:32.152777Z] Finished run-tests step (success) 14:35:32 INFO - Running post-run listener: _resource_record_post_run 14:35:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 337223680; Read time: 332; Write time: 198248 14:35:32 INFO - TinderboxPrint: CPU usage
12.9% 14:35:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 332 14:35:32 INFO - TinderboxPrint: I/O write bytes / time
337,223,680 / 198,248 14:35:32 INFO - TinderboxPrint: CPU idle
8,269.6 (87.0%) 14:35:32 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 14:35:32 INFO - TinderboxPrint: Swap in / out
0 / 0 14:35:32 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101085184; Read time: 68; Write time: 88420 14:35:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 218914816; Read time: 264; Write time: 105860 14:35:32 INFO - Running post-run listener: _upload_blobber_files 14:35:32 INFO - Blob upload gear active. 14:35:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:32 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 14:35:32 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:35:32 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:35:33 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:35:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:35:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:37 INFO - (blobuploader) - INFO - Done attempting. 14:35:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:38 INFO - (blobuploader) - INFO - Done attempting. 14:35:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:35:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:38 INFO - (blobuploader) - INFO - Done attempting. 14:35:38 INFO - (blobuploader) - INFO - Iteration through files over. 14:35:38 INFO - Return code: 0 14:35:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:35:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:35:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/871f8d237719b2b5056805dfad2938774bae294c13488be5e9fd0c40ab6e564a0abe6cb4717184c6dcbcbffe077caca12c32a3a36cc40a3b16093b60b99283b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e0df9aed704e0c769a96e1f749a78698e31b3b36038f5c8ef5caeb894001070d00d5ebd3314eb8a0517b47778357edc5a428d4c26ecfe27529d2d9ca25a337d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02aeeb4db32cf6f889fb0182ecf8d6332cfe8c8f6a4ec3fee4f91775a69bc2c0b843b799100c410f9dc58ceaeb0a53553668560d3a9b7ad2eb09d7bd211208dd"} 14:35:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:35:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:35:38 INFO - Contents: 14:35:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/871f8d237719b2b5056805dfad2938774bae294c13488be5e9fd0c40ab6e564a0abe6cb4717184c6dcbcbffe077caca12c32a3a36cc40a3b16093b60b99283b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e0df9aed704e0c769a96e1f749a78698e31b3b36038f5c8ef5caeb894001070d00d5ebd3314eb8a0517b47778357edc5a428d4c26ecfe27529d2d9ca25a337d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02aeeb4db32cf6f889fb0182ecf8d6332cfe8c8f6a4ec3fee4f91775a69bc2c0b843b799100c410f9dc58ceaeb0a53553668560d3a9b7ad2eb09d7bd211208dd"} 14:35:38 INFO - Running post-run listener: copy_logs_to_upload_dir 14:35:38 INFO - Copying logs to upload dir... 14:35:38 INFO - mkdir: /builds/slave/test/build/upload/logs 14:35:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.399093 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 14:35:38.726569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 14:35:38.729779) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/871f8d237719b2b5056805dfad2938774bae294c13488be5e9fd0c40ab6e564a0abe6cb4717184c6dcbcbffe077caca12c32a3a36cc40a3b16093b60b99283b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e0df9aed704e0c769a96e1f749a78698e31b3b36038f5c8ef5caeb894001070d00d5ebd3314eb8a0517b47778357edc5a428d4c26ecfe27529d2d9ca25a337d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02aeeb4db32cf6f889fb0182ecf8d6332cfe8c8f6a4ec3fee4f91775a69bc2c0b843b799100c410f9dc58ceaeb0a53553668560d3a9b7ad2eb09d7bd211208dd"} build_url:https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/CrYOxwWZRV22A6s47GtWww/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/871f8d237719b2b5056805dfad2938774bae294c13488be5e9fd0c40ab6e564a0abe6cb4717184c6dcbcbffe077caca12c32a3a36cc40a3b16093b60b99283b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0e0df9aed704e0c769a96e1f749a78698e31b3b36038f5c8ef5caeb894001070d00d5ebd3314eb8a0517b47778357edc5a428d4c26ecfe27529d2d9ca25a337d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/02aeeb4db32cf6f889fb0182ecf8d6332cfe8c8f6a4ec3fee4f91775a69bc2c0b843b799100c410f9dc58ceaeb0a53553668560d3a9b7ad2eb09d7bd211208dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 14:35:38.754198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:35:38.754592) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1487887810.260497-319244141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 14:35:38.838214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 14:35:38.838545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 14:35:38.838866) ========= ========= Total master_lag: 0.16 =========