builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1487899652.21 results: success (0) buildid: 20170223154122 builduid: 93c69c4dbd6549e4980e7d7cd80ea940 revision: dfab6e1129c8e430a6b1f360fc35644fc7d92591 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.209382) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.209838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.210111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.278517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.278821) ========= 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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-23 17:27:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-02-23 17:27:32 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.417696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.418002) ========= 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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015539 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:32.467092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 17:27:32.467972) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dfab6e1129c8e430a6b1f360fc35644fc7d92591 --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 dfab6e1129c8e430a6b1f360fc35644fc7d92591 --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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-23 17:27:33,015 truncating revision to first 12 chars 2017-02-23 17:27:33,015 Setting DEBUG logging. 2017-02-23 17:27:33,015 attempt 1/10 2017-02-23 17:27:33,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dfab6e1129c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 17:27:34,089 unpacking tar archive at: mozilla-beta-dfab6e1129c8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 17:27:33.861331) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:33.861721) ========= script_repo_revision: dfab6e1129c8e430a6b1f360fc35644fc7d92591 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:33.862107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:33.862393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 17:27:33.870304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 17:27:33.870988) ========= /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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:34 INFO - MultiFileLogger online at 20170223 17:27:34 in /builds/slave/test 17:27:34 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 17:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:34 INFO - {'append_to_log': False, 17:27:34 INFO - 'base_work_dir': '/builds/slave/test', 17:27:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:34 INFO - 'branch': 'Mozilla-Beta', 17:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:34 INFO - 'config_files': ('talos/linux_config.py',), 17:27:34 INFO - 'default_actions': ('clobber', 17:27:34 INFO - 'read-buildbot-config', 17:27:34 INFO - 'download-and-extract', 17:27:34 INFO - 'populate-webroot', 17:27:34 INFO - 'create-virtualenv', 17:27:34 INFO - 'install', 17:27:34 INFO - 'run-tests'), 17:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:34 INFO - 'download_minidump_stackwalk': True, 17:27:34 INFO - 'download_symbols': 'ondemand', 17:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:34 INFO - 'installer_path': 'installer.exe', 17:27:34 INFO - 'log_level': 'info', 17:27:34 INFO - 'log_name': 'talos', 17:27:34 INFO - 'log_to_console': True, 17:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:34 INFO - 'opt_config_files': (), 17:27:34 INFO - 'pip_index': False, 17:27:34 INFO - 'sps_profile': False, 17:27:34 INFO - 'sps_profile_interval': 0, 17:27:34 INFO - 'suite': 'dromaeojs', 17:27:34 INFO - 'system_bits': '32', 17:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:34 INFO - 'title': 'talos-linux64-ix-002', 17:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:34 INFO - 'use_talos_json': True, 17:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:34 INFO - 'work_dir': 'build'} 17:27:34 INFO - [mozharness: 2017-02-24 01:27:34.509675Z] Running clobber step. 17:27:34 INFO - Running pre-action listener: _resource_record_pre_action 17:27:34 INFO - Running main action method: clobber 17:27:34 INFO - rmtree: /builds/slave/test/build 17:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:34 INFO - Running post-action listener: _resource_record_post_action 17:27:34 INFO - [mozharness: 2017-02-24 01:27:34.970667Z] Finished clobber step (success) 17:27:34 INFO - [mozharness: 2017-02-24 01:27:34.970766Z] Running read-buildbot-config step. 17:27:34 INFO - Running pre-action listener: _resource_record_pre_action 17:27:34 INFO - Running main action method: read_buildbot_config 17:27:34 INFO - Using buildbot properties: 17:27:34 INFO - { 17:27:34 INFO - "project": "", 17:27:34 INFO - "product": "firefox", 17:27:34 INFO - "script_repo_revision": "production", 17:27:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:27:34 INFO - "repository": "", 17:27:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:27:34 INFO - "buildid": "20170223154122", 17:27:34 INFO - "pgo_build": "True", 17:27:34 INFO - "basedir": "/builds/slave/test", 17:27:34 INFO - "buildnumber": 29, 17:27:34 INFO - "slavename": "talos-linux64-ix-002", 17:27:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:27:34 INFO - "platform": "ubuntu64_hw", 17:27:34 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:27:34 INFO - "branch": "mozilla-beta", 17:27:34 INFO - "repo_path": "releases/mozilla-beta", 17:27:34 INFO - "revision": "dfab6e1129c8e430a6b1f360fc35644fc7d92591", 17:27:34 INFO - "stage_platform": "linux64-pgo", 17:27:34 INFO - "builduid": "93c69c4dbd6549e4980e7d7cd80ea940", 17:27:34 INFO - "slavebuilddir": "test" 17:27:34 INFO - } 17:27:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 17:27:34 INFO - Running post-action listener: _resource_record_post_action 17:27:34 INFO - [mozharness: 2017-02-24 01:27:34.973169Z] Finished read-buildbot-config step (success) 17:27:34 INFO - [mozharness: 2017-02-24 01:27:34.973257Z] Running download-and-extract step. 17:27:34 INFO - Running pre-action listener: _resource_record_pre_action 17:27:34 INFO - Running main action method: download_and_extract 17:27:34 INFO - mkdir: /builds/slave/test/build/tests 17:27: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')]} 17:27:34 INFO - trying https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 17:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/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 17:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/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 17:27:35 INFO - Downloaded 1327 bytes. 17:27:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 17:27:35 INFO - Using the following test package requirements: 17:27:35 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 17:27:35 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:27:35 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 17:27:35 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'jsshell-linux-x86_64.zip'], 17:27:35 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:27:35 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 17:27:35 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 17:27:35 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 17:27:35 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:27:35 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:27:35 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:27:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 17:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 17:27:36 INFO - Http code: 200 17:27:36 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 17:27:36 INFO - x-amz-cf-id: 1aVxic7tyxEm1aGX-nlJ4dKDWMgNMmE6jJfTuSmiOr3HtYU5QdZ5KQ== 17:27:36 INFO - x-amz-version-id: UREdb3TixK_DGPiZzdH6kEuhizwBGIYj 17:27:36 INFO - Expected file size: 21963487 17:27:36 INFO - Obtained file size: 21963487 17:27:40 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 17:27:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 17:27:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:27:40 INFO - Fetch https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 17:27:40 INFO - Http code: 200 17:27:40 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:27:40 INFO - x-amz-cf-id: mE390xotRFPcS-yruyKZ2sVNYbEcvnZ5VW-WpLE2yjHNmNsYM2aV_w== 17:27:40 INFO - x-amz-version-id: UREdb3TixK_DGPiZzdH6kEuhizwBGIYj 17:27:41 INFO - Expected file size: 21963487 17:27:41 INFO - Obtained file size: 21963487 17:27:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 17:27:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:27:45 INFO - Fetch https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 17:27:46 INFO - Http code: 200 17:27:46 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 17:27:46 INFO - x-amz-cf-id: 1KeJwLbO95z9GGANJAoQZtdReGk0GIimRO02T9fzf0GHAp7saIMwfw== 17:27:46 INFO - x-amz-version-id: sUYHYn3IK3bx5lEAu.UqIErBd0l.FMWI 17:27:46 INFO - Expected file size: 14402992 17:27:46 INFO - Obtained file size: 14402992 17:27:46 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')]} 17:27:46 INFO - trying https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:27:46 INFO - Downloading https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/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 17:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/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 17:27:47 INFO - Downloaded 57761187 bytes. 17:27:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:27:47 INFO - mkdir: /builds/slave/test/properties 17:27:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:27:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:27:47 INFO - Contents: 17:27:47 INFO - build_url:https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:27:48 INFO - Running post-action listener: _resource_record_post_action 17:27:48 INFO - Running post-action listener: set_extra_try_arguments 17:27:48 INFO - [mozharness: 2017-02-24 01:27:48.478364Z] Finished download-and-extract step (success) 17:27:48 INFO - [mozharness: 2017-02-24 01:27:48.478592Z] Running populate-webroot step. 17:27:48 INFO - Running pre-action listener: _resource_record_pre_action 17:27:48 INFO - Running main action method: populate_webroot 17:27:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:27:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:27:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:27:48 INFO - '--tppagecycles', 17:27:48 INFO - '7'], 17:27:48 INFO - 'tests': ['tsvgm']}}, 17:27:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:27:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:27:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:27:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:27:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['damp', 'tps']}, 17:27:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'tests': ['damp', 'tps']}, 17:27:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['dromaeo_dom']}, 17:27:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:27:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['basic_compositor_video']}, 17:27:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:27:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['a11yr', 17:27:48 INFO - 'ts_paint', 17:27:48 INFO - 'tpaint', 17:27:48 INFO - 'sessionrestore', 17:27:48 INFO - 'sessionrestore_no_auto_restore', 17:27:48 INFO - 'tabpaint']}, 17:27:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['tsvgx', 17:27:48 INFO - 'tsvgr_opacity', 17:27:48 INFO - 'tart', 17:27:48 INFO - 'tscrollx', 17:27:48 INFO - 'cart']}, 17:27:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:27:48 INFO - 'tsvgr_opacity', 17:27:48 INFO - 'tart', 17:27:48 INFO - 'tscrollx', 17:27:48 INFO - 'cart']}, 17:27:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'talos_options': ['--disable-e10s'], 17:27:48 INFO - 'tests': ['tp5o']}, 17:27:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'tests': ['tp5o']}, 17:27:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'talos_options': ['--disable-e10s', 17:27:48 INFO - '--xperf_path', 17:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:48 INFO - 'tests': ['tp5n']}, 17:27:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:48 INFO - 'talos_options': ['--xperf_path', 17:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:48 INFO - 'tests': ['tp5n']}}, 17:27:48 INFO - 'talos.zip': {'path': '', 17:27:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:27:48 INFO - Running post-action listener: _resource_record_post_action 17:27:48 INFO - [mozharness: 2017-02-24 01:27:48.496109Z] Finished populate-webroot step (success) 17:27:48 INFO - [mozharness: 2017-02-24 01:27:48.496196Z] Running create-virtualenv step. 17:27:48 INFO - Running pre-action listener: _resource_record_pre_action 17:27:48 INFO - Running main action method: create_virtualenv 17:27:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:27:48 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 17:27:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:27:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:27:48 INFO - Using real prefix '/usr' 17:27:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:27:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:27:51 INFO - Installing pip.................done. 17:27:51 INFO - Return code: 0 17:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:27:51 INFO - Reading from file tmpfile_stdout 17:27:51 INFO - Output received: 17:27:51 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) 17:27:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:27:51 INFO - Using env: {'DISPLAY': ':0', 17:27:51 INFO - 'HOME': '/home/cltbld', 17:27:51 INFO - 'LANG': 'en_US.UTF-8', 17:27:51 INFO - 'LANGUAGE': 'en_US:en', 17:27:51 INFO - 'LOGNAME': 'cltbld', 17:27:51 INFO - 'MAIL': '/var/mail/cltbld', 17:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:51 INFO - 'MOZ_NO_REMOTE': '1', 17:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:51 INFO - 'NO_EM_RESTART': '1', 17:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:51 INFO - 'PWD': '/builds/slave/test', 17:27:51 INFO - 'SHELL': '/bin/bash', 17:27:51 INFO - 'SHLVL': '1', 17:27:51 INFO - 'TERM': 'linux', 17:27:51 INFO - 'TMOUT': '86400', 17:27:51 INFO - 'USER': 'cltbld', 17:27:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:51 INFO - '_': '/tools/buildbot/bin/python'} 17:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:51 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 17:27:51 INFO - Cleaning up... 17:27:51 INFO - Return code: 0 17:27:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:27:51 INFO - Using env: {'DISPLAY': ':0', 17:27:51 INFO - 'HOME': '/home/cltbld', 17:27:51 INFO - 'LANG': 'en_US.UTF-8', 17:27:51 INFO - 'LANGUAGE': 'en_US:en', 17:27:51 INFO - 'LOGNAME': 'cltbld', 17:27:51 INFO - 'MAIL': '/var/mail/cltbld', 17:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:51 INFO - 'MOZ_NO_REMOTE': '1', 17:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:51 INFO - 'NO_EM_RESTART': '1', 17:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:51 INFO - 'PWD': '/builds/slave/test', 17:27:51 INFO - 'SHELL': '/bin/bash', 17:27:51 INFO - 'SHLVL': '1', 17:27:51 INFO - 'TERM': 'linux', 17:27:51 INFO - 'TMOUT': '86400', 17:27:51 INFO - 'USER': 'cltbld', 17:27:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:51 INFO - '_': '/tools/buildbot/bin/python'} 17:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:51 INFO - Downloading/unpacking psutil>=3.1.1 17:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:53 INFO - Installing collected packages: psutil 17:27:53 INFO - Running setup.py install for psutil 17:27:53 INFO - building 'psutil._psutil_linux' extension 17:27:53 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 17:27:54 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 17:27:54 INFO - building 'psutil._psutil_posix' extension 17:27:54 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 17:27:54 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 17:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:54 INFO - Successfully installed psutil 17:27:54 INFO - Cleaning up... 17:27:54 INFO - Return code: 0 17:27:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:27:54 INFO - Using env: {'DISPLAY': ':0', 17:27:54 INFO - 'HOME': '/home/cltbld', 17:27:54 INFO - 'LANG': 'en_US.UTF-8', 17:27:54 INFO - 'LANGUAGE': 'en_US:en', 17:27:54 INFO - 'LOGNAME': 'cltbld', 17:27:54 INFO - 'MAIL': '/var/mail/cltbld', 17:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:54 INFO - 'MOZ_NO_REMOTE': '1', 17:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:54 INFO - 'NO_EM_RESTART': '1', 17:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:54 INFO - 'PWD': '/builds/slave/test', 17:27:54 INFO - 'SHELL': '/bin/bash', 17:27:54 INFO - 'SHLVL': '1', 17:27:54 INFO - 'TERM': 'linux', 17:27:54 INFO - 'TMOUT': '86400', 17:27:54 INFO - 'USER': 'cltbld', 17:27:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:54 INFO - '_': '/tools/buildbot/bin/python'} 17:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:27:56 INFO - Installing collected packages: mozsystemmonitor 17:27:56 INFO - Running setup.py install for mozsystemmonitor 17:27:56 INFO - Successfully installed mozsystemmonitor 17:27:56 INFO - Cleaning up... 17:27:56 INFO - Return code: 0 17:27:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:56 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:56 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 17:27:56 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 17:27:56 INFO - Using env: {'DISPLAY': ':0', 17:27:56 INFO - 'HOME': '/home/cltbld', 17:27:56 INFO - 'LANG': 'en_US.UTF-8', 17:27:56 INFO - 'LANGUAGE': 'en_US:en', 17:27:56 INFO - 'LOGNAME': 'cltbld', 17:27:56 INFO - 'MAIL': '/var/mail/cltbld', 17:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:56 INFO - 'MOZ_NO_REMOTE': '1', 17:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:56 INFO - 'NO_EM_RESTART': '1', 17:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:56 INFO - 'PWD': '/builds/slave/test', 17:27:56 INFO - 'SHELL': '/bin/bash', 17:27:56 INFO - 'SHLVL': '1', 17:27:56 INFO - 'TERM': 'linux', 17:27:56 INFO - 'TMOUT': '86400', 17:27:56 INFO - 'USER': 'cltbld', 17:27:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:56 INFO - '_': '/tools/buildbot/bin/python'} 17:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:27:57 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 17:27:57 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 17:27:57 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 17:27:57 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 17:27:57 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 17:27:57 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 17:27:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:27:59 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 17:27:59 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 17:27:59 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 17:27:59 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 17:27:59 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 17:27:59 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 17:27:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:59 INFO - warning: no files found matching '*.txt' 17:27:59 INFO - no previously-included directories found matching 'build' 17:27:59 INFO - no previously-included directories found matching 'dist' 17:27:59 INFO - no previously-included directories found matching '.git*' 17:27:59 INFO - Installing collected packages: jsonschema, functools32 17:27:59 INFO - Running setup.py install for functools32 17:27:59 INFO - warning: no files found matching '*.txt' 17:27:59 INFO - no previously-included directories found matching 'build' 17:27:59 INFO - no previously-included directories found matching 'dist' 17:27:59 INFO - no previously-included directories found matching '.git*' 17:27:59 INFO - Successfully installed jsonschema functools32 17:27:59 INFO - Cleaning up... 17:27:59 INFO - Return code: 0 17:27:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:59 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:59 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 17:27:59 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 17:27:59 INFO - Using env: {'DISPLAY': ':0', 17:27:59 INFO - 'HOME': '/home/cltbld', 17:27:59 INFO - 'LANG': 'en_US.UTF-8', 17:27:59 INFO - 'LANGUAGE': 'en_US:en', 17:27:59 INFO - 'LOGNAME': 'cltbld', 17:27:59 INFO - 'MAIL': '/var/mail/cltbld', 17:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:59 INFO - 'MOZ_NO_REMOTE': '1', 17:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:59 INFO - 'NO_EM_RESTART': '1', 17:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:59 INFO - 'PWD': '/builds/slave/test', 17:27:59 INFO - 'SHELL': '/bin/bash', 17:27:59 INFO - 'SHLVL': '1', 17:27:59 INFO - 'TERM': 'linux', 17:27:59 INFO - 'TMOUT': '86400', 17:27:59 INFO - 'USER': 'cltbld', 17:27:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:59 INFO - '_': '/tools/buildbot/bin/python'} 17:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:27:59 INFO - Cleaning up... 17:27:59 INFO - Return code: 0 17:27:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:59 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:27:59 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 17:27:59 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 17:27:59 INFO - Using env: {'DISPLAY': ':0', 17:27:59 INFO - 'HOME': '/home/cltbld', 17:27:59 INFO - 'LANG': 'en_US.UTF-8', 17:27:59 INFO - 'LANGUAGE': 'en_US:en', 17:27:59 INFO - 'LOGNAME': 'cltbld', 17:27:59 INFO - 'MAIL': '/var/mail/cltbld', 17:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:59 INFO - 'MOZ_NO_REMOTE': '1', 17:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:59 INFO - 'NO_EM_RESTART': '1', 17:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:59 INFO - 'PWD': '/builds/slave/test', 17:27:59 INFO - 'SHELL': '/bin/bash', 17:27:59 INFO - 'SHLVL': '1', 17:27:59 INFO - 'TERM': 'linux', 17:27:59 INFO - 'TMOUT': '86400', 17:27:59 INFO - 'USER': 'cltbld', 17:27:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:59 INFO - '_': '/tools/buildbot/bin/python'} 17:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - Downloading docopt-0.6.1.tar.gz 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:02 INFO - Running setup.py install for blobuploader 17:28:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:02 INFO - Running setup.py install for requests 17:28:03 INFO - Running setup.py install for docopt 17:28:03 INFO - Successfully installed blobuploader requests docopt 17:28:03 INFO - Cleaning up... 17:28:03 INFO - Return code: 0 17:28:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:03 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:28:03 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 17:28:03 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 17:28:03 INFO - Using env: {'DISPLAY': ':0', 17:28:03 INFO - 'HOME': '/home/cltbld', 17:28:03 INFO - 'LANG': 'en_US.UTF-8', 17:28:03 INFO - 'LANGUAGE': 'en_US:en', 17:28:03 INFO - 'LOGNAME': 'cltbld', 17:28:03 INFO - 'MAIL': '/var/mail/cltbld', 17:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:03 INFO - 'MOZ_NO_REMOTE': '1', 17:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:03 INFO - 'NO_EM_RESTART': '1', 17:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:03 INFO - 'PWD': '/builds/slave/test', 17:28:03 INFO - 'SHELL': '/bin/bash', 17:28:03 INFO - 'SHLVL': '1', 17:28:03 INFO - 'TERM': 'linux', 17:28:03 INFO - 'TMOUT': '86400', 17:28:03 INFO - 'USER': 'cltbld', 17:28:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:03 INFO - '_': '/tools/buildbot/bin/python'} 17:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:03 INFO - Running setup.py (path:/tmp/pip-5v5XjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:03 INFO - Running setup.py (path:/tmp/pip-32Z19H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:03 INFO - Running setup.py (path:/tmp/pip-KEm1HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:03 INFO - Running setup.py (path:/tmp/pip-zz_SgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:03 INFO - Running setup.py (path:/tmp/pip-cDpZWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:04 INFO - Running setup.py (path:/tmp/pip-ISKtpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:04 INFO - Running setup.py (path:/tmp/pip-rBdI3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:04 INFO - Running setup.py (path:/tmp/pip-HoBTtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:04 INFO - Running setup.py (path:/tmp/pip-qXXFTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:04 INFO - Running setup.py (path:/tmp/pip-O5GOIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:04 INFO - Running setup.py (path:/tmp/pip-UHdjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:04 INFO - Running setup.py (path:/tmp/pip-fqTHK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:04 INFO - Running setup.py (path:/tmp/pip-fjf326-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:04 INFO - Running setup.py (path:/tmp/pip-osDqSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:04 INFO - Running setup.py (path:/tmp/pip-qLxkp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:04 INFO - Running setup.py (path:/tmp/pip-MxQ1go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:04 INFO - Running setup.py (path:/tmp/pip-2G1mIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:04 INFO - Running setup.py install for manifestparser 17:28:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozcrash 17:28:05 INFO - Running setup.py install for mozdebug 17:28:05 INFO - Running setup.py install for mozdevice 17:28:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozfile 17:28:05 INFO - Running setup.py install for mozhttpd 17:28:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozinfo 17:28:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozInstall 17:28:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozleak 17:28:05 INFO - Running setup.py install for mozlog 17:28:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for moznetwork 17:28:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozprocess 17:28:06 INFO - Running setup.py install for mozprofile 17:28:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozrunner 17:28:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozscreenshot 17:28:06 INFO - Running setup.py install for moztest 17:28:06 INFO - Running setup.py install for mozversion 17:28:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:06 INFO - Cleaning up... 17:28:06 INFO - Return code: 0 17:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:06 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:28:06 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 17:28:06 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 17:28:06 INFO - Using env: {'DISPLAY': ':0', 17:28:06 INFO - 'HOME': '/home/cltbld', 17:28:06 INFO - 'LANG': 'en_US.UTF-8', 17:28:06 INFO - 'LANGUAGE': 'en_US:en', 17:28:06 INFO - 'LOGNAME': 'cltbld', 17:28:06 INFO - 'MAIL': '/var/mail/cltbld', 17:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:06 INFO - 'MOZ_NO_REMOTE': '1', 17:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:06 INFO - 'NO_EM_RESTART': '1', 17:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:06 INFO - 'PWD': '/builds/slave/test', 17:28:06 INFO - 'SHELL': '/bin/bash', 17:28:06 INFO - 'SHLVL': '1', 17:28:06 INFO - 'TERM': 'linux', 17:28:06 INFO - 'TMOUT': '86400', 17:28:06 INFO - 'USER': 'cltbld', 17:28:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:06 INFO - '_': '/tools/buildbot/bin/python'} 17:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:06 INFO - Running setup.py (path:/tmp/pip-I58xLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:07 INFO - Running setup.py (path:/tmp/pip-0vWeYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:07 INFO - Running setup.py (path:/tmp/pip-OKlhvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:07 INFO - Running setup.py (path:/tmp/pip-wER8Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:07 INFO - Running setup.py (path:/tmp/pip-Th9ZqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:07 INFO - Running setup.py (path:/tmp/pip-LjWmIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:07 INFO - Running setup.py (path:/tmp/pip-7Af4iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:07 INFO - Running setup.py (path:/tmp/pip-qKqPdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:07 INFO - Running setup.py (path:/tmp/pip-gYZ9RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:07 INFO - Running setup.py (path:/tmp/pip-J7UAeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:07 INFO - Running setup.py (path:/tmp/pip-7gSe5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:07 INFO - Running setup.py (path:/tmp/pip-cEP_VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:07 INFO - Running setup.py (path:/tmp/pip-QeoIc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:07 INFO - Running setup.py (path:/tmp/pip-LP4nmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:07 INFO - Running setup.py (path:/tmp/pip-0slDep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:08 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)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:08 INFO - Running setup.py (path:/tmp/pip-hIIj6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:08 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)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:08 INFO - Running setup.py (path:/tmp/pip-E5UYuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:10 INFO - Downloading blessings-1.6.tar.gz 17:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:28:10 INFO - Installing collected packages: blessings 17:28:10 INFO - Running setup.py install for blessings 17:28:10 INFO - Successfully installed blessings 17:28:10 INFO - Cleaning up... 17:28:10 INFO - Return code: 0 17:28:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:10 INFO - Reading from file tmpfile_stdout 17:28:10 INFO - Current package versions: 17:28:10 INFO - argparse == 1.2.1 17:28:10 INFO - blessings == 1.6 17:28:10 INFO - blobuploader == 1.2.4 17:28:10 INFO - docopt == 0.6.1 17:28:10 INFO - functools32 == 3.2.3-2 17:28:10 INFO - jsonschema == 2.5.1 17:28:10 INFO - manifestparser == 1.1 17:28:10 INFO - mozInstall == 1.12 17:28:10 INFO - mozcrash == 1.0 17:28:10 INFO - mozdebug == 0.1 17:28:10 INFO - mozdevice == 0.48 17:28:10 INFO - mozfile == 1.2 17:28:10 INFO - mozhttpd == 0.7 17:28:10 INFO - mozinfo == 0.9 17:28:10 INFO - mozleak == 0.1 17:28:10 INFO - mozlog == 3.4 17:28:10 INFO - moznetwork == 0.27 17:28:10 INFO - mozprocess == 0.23 17:28:10 INFO - mozprofile == 0.28 17:28:10 INFO - mozrunner == 6.13 17:28:10 INFO - mozscreenshot == 0.1 17:28:10 INFO - mozsystemmonitor == 0.3 17:28:10 INFO - moztest == 0.8 17:28:10 INFO - mozversion == 1.4 17:28:10 INFO - psutil == 3.1.1 17:28:10 INFO - requests == 1.2.3 17:28:10 INFO - wsgiref == 0.1.2 17:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:28:10 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 17:28:10 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 17:28:10 INFO - Using env: {'DISPLAY': ':0', 17:28:10 INFO - 'HOME': '/home/cltbld', 17:28:10 INFO - 'LANG': 'en_US.UTF-8', 17:28:10 INFO - 'LANGUAGE': 'en_US:en', 17:28:10 INFO - 'LOGNAME': 'cltbld', 17:28:10 INFO - 'MAIL': '/var/mail/cltbld', 17:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:10 INFO - 'MOZ_NO_REMOTE': '1', 17:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:10 INFO - 'NO_EM_RESTART': '1', 17:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:10 INFO - 'PWD': '/builds/slave/test', 17:28:10 INFO - 'SHELL': '/bin/bash', 17:28:10 INFO - 'SHLVL': '1', 17:28:10 INFO - 'TERM': 'linux', 17:28:10 INFO - 'TMOUT': '86400', 17:28:10 INFO - 'USER': 'cltbld', 17:28:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:10 INFO - '_': '/tools/buildbot/bin/python'} 17:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 INFO - Cleaning up... 17:28:10 INFO - Return code: 0 17:28:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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 0x7ff4955b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', '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 17:28:10 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 17:28:10 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 17:28:10 INFO - Using env: {'DISPLAY': ':0', 17:28:10 INFO - 'HOME': '/home/cltbld', 17:28:10 INFO - 'LANG': 'en_US.UTF-8', 17:28:10 INFO - 'LANGUAGE': 'en_US:en', 17:28:10 INFO - 'LOGNAME': 'cltbld', 17:28:10 INFO - 'MAIL': '/var/mail/cltbld', 17:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:10 INFO - 'MOZ_NO_REMOTE': '1', 17:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:10 INFO - 'NO_EM_RESTART': '1', 17:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:10 INFO - 'PWD': '/builds/slave/test', 17:28:10 INFO - 'SHELL': '/bin/bash', 17:28:10 INFO - 'SHLVL': '1', 17:28:10 INFO - 'TERM': 'linux', 17:28:10 INFO - 'TMOUT': '86400', 17:28:10 INFO - 'USER': 'cltbld', 17:28:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:10 INFO - '_': '/tools/buildbot/bin/python'} 17:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:28:11 INFO - Cleaning up... 17:28:11 INFO - Return code: 0 17:28:11 INFO - Running post-action listener: _resource_record_post_action 17:28:11 INFO - Running post-action listener: _start_resource_monitoring 17:28:11 INFO - Starting resource monitoring. 17:28:11 INFO - [mozharness: 2017-02-24 01:28:11.166343Z] Finished create-virtualenv step (success) 17:28:11 INFO - [mozharness: 2017-02-24 01:28:11.166804Z] Running install step. 17:28:11 INFO - Running pre-action listener: _resource_record_pre_action 17:28:11 INFO - Running main action method: install 17:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:11 INFO - Reading from file tmpfile_stdout 17:28:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:28:11 INFO - Reading from file tmpfile_stdout 17:28:11 INFO - Output received: 17:28:11 INFO - Usage: mozinstall [options] installer 17:28:11 INFO - Options: 17:28:11 INFO - -h, --help show this help message and exit 17:28:11 INFO - -d DEST, --destination=DEST 17:28:11 INFO - Directory to install application into. [default: 17:28:11 INFO - "/builds/slave/test"] 17:28:11 INFO - --app=APP Application being installed. [default: firefox] 17:28:11 INFO - mkdir: /builds/slave/test/build/application 17:28:11 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'] 17:28:11 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 17:28:25 INFO - Reading from file tmpfile_stdout 17:28:25 INFO - Output received: 17:28:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:28:25 INFO - Running post-action listener: _resource_record_post_action 17:28:25 INFO - [mozharness: 2017-02-24 01:28:25.096896Z] Finished install step (success) 17:28:25 INFO - [mozharness: 2017-02-24 01:28:25.097136Z] Running run-tests step. 17:28:25 INFO - Running pre-action listener: _resource_record_pre_action 17:28:25 INFO - Running main action method: run_tests 17:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:28:25 INFO - Python 2.7.3 17:28:25 INFO - Return code: 0 17:28:25 INFO - grabbing minidump binary from tooltool 17:28: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')]} 17:28:25 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 0x25def60>, '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 0x25dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:28:25 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 17:28:25 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 17:28:25 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 17:28:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:28:25 INFO - Return code: 0 17:28:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:28:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:28:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:28:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:28:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:28:25 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/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:28:25 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/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 17:28:25 INFO - Using env: {'DISPLAY': ':0', 17:28:25 INFO - 'HOME': '/home/cltbld', 17:28:25 INFO - 'LANG': 'en_US.UTF-8', 17:28:25 INFO - 'LANGUAGE': 'en_US:en', 17:28:25 INFO - 'LOGNAME': 'cltbld', 17:28:25 INFO - 'MAIL': '/var/mail/cltbld', 17:28:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:25 INFO - 'MOZ_NO_REMOTE': '1', 17:28:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:25 INFO - 'NO_EM_RESTART': '1', 17:28:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:25 INFO - 'PWD': '/builds/slave/test', 17:28:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:25 INFO - 'SHELL': '/bin/bash', 17:28:25 INFO - 'SHLVL': '1', 17:28:25 INFO - 'TERM': 'linux', 17:28:25 INFO - 'TMOUT': '86400', 17:28:25 INFO - 'USER': 'cltbld', 17:28:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333', 17:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:25 INFO - '_': '/tools/buildbot/bin/python'} 17:28:25 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/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:28:25 INFO - mozversion application_buildid: 20170223154122 17:28:25 INFO - mozversion application_changeset: dfab6e1129c8e430a6b1f360fc35644fc7d92591 17:28:25 INFO - mozversion application_display_name: Firefox 17:28:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:28:25 INFO - mozversion application_name: Firefox 17:28:25 INFO - mozversion application_remotingname: firefox 17:28:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:28:25 INFO - mozversion application_vendor: Mozilla 17:28:25 INFO - mozversion application_version: 52.0 17:28:25 INFO - mozversion platform_buildid: 20170223154122 17:28:25 INFO - mozversion platform_changeset: dfab6e1129c8e430a6b1f360fc35644fc7d92591 17:28:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:28:25 INFO - mozversion platform_version: 52.0 17:28:25 INFO - using testdate: 1487899705 17:28:25 INFO - actual date: 1487899705 17:28:25 INFO - starting webserver on 'localhost:45867' 17:28:25 INFO - SUITE-START | Running 2 tests 17:28:25 INFO - TEST-START | dromaeo_css 17:28:25 INFO - operating with platform_type : linux_ 17:28:25 INFO - Initialising browser for dromaeo_css test... 17:28:25 INFO - TEST-INFO | started process 25296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiKPs2B/profile http://localhost:45867/getInfo.html) 17:28:29 INFO - PROCESS | 25296 | __metrics Screen width/height:1600/1200 17:28:29 INFO - PROCESS | 25296 | colorDepth:24 17:28:29 INFO - PROCESS | 25296 | Browser inner width/height: 1024/697 17:28:29 INFO - PROCESS | 25296 | __metrics 17:28:30 INFO - PROCESS | 25296 | 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" 17:28:30 INFO - PROCESS | 25296 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:30 INFO - PROCESS | 25296 | console.error: PushService: 17:28:30 INFO - PROCESS | 25296 | stateChangeProcessEnqueue: Error transitioning state 17:28:30 INFO - PROCESS | 25296 | UnknownError 17:28:31 INFO - TEST-INFO | 25296: exit 0 17:28:31 INFO - Browser initialized. 17:28:31 INFO - Running cycle 1/1 for dromaeo_css test... 17:28:31 INFO - TEST-INFO | started process 25387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiKPs2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:43 INFO - PROCESS | 25387 | RSS: Main: 141664256 17:28:43 INFO - PROCESS | 25387 | 17:31:44 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45867/tests/dromaeo/cssquery-ext.html) 17:31:45 INFO - PROCESS | 25387 | RSS: Main: 258809856 17:31:45 INFO - PROCESS | 25387 | 17:34:48 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-ext.html (next: http://localhost:45867/tests/dromaeo/cssquery-jquery.html) 17:34:48 INFO - PROCESS | 25387 | RSS: Main: 225767424 17:34:48 INFO - PROCESS | 25387 | 17:37:50 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45867/tests/dromaeo/cssquery-mootools.html) 17:37:51 INFO - PROCESS | 25387 | RSS: Main: 217358336 17:37:51 INFO - PROCESS | 25387 | 17:40:52 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45867/tests/dromaeo/cssquery-prototype.html) 17:40:53 INFO - PROCESS | 25387 | RSS: Main: 176128000 17:40:53 INFO - PROCESS | 25387 | 17:43:56 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45867/tests/dromaeo/cssquery-yui.html) 17:43:56 INFO - PROCESS | 25387 | RSS: Main: 175067136 17:43:56 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-yui.html (next: http://localhost:45867/tests/dromaeo/cssquery-dojo.html) 17:46:59 INFO - PROCESS | 25387 | RSS: Main: 254361600 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | __start_tp_report 17:46:59 INFO - PROCESS | 25387 | _x_x_mozilla_page_load 17:46:59 INFO - PROCESS | 25387 | _x_x_mozilla_page_load_details 17:46:59 INFO - PROCESS | 25387 | |i|pagename|runs| 17:46:59 INFO - PROCESS | 25387 | |0;dojo.html;3186.4264432402174;3226.4837625979835;3236.951445728314;3257.967420325799;3264.4450443424616;5596.5522758179295;5621.437856214377;5671.262735844334;5671.319441666996;5684.744186511606;5567.137093750465;5613.831585052445;5625.465580769831;5633.577481688869;5646.717664116798;5054.241863720435;5078.974605126988;5112.130937740593;5140.203268493389;5141.922871156936;5025.1708468102715;5108.386993560778;5152.510511501401;5167.224916262553;5167.405748338932;5002.674826136289;5015.122353588107;5032.11937910866;5044.167712327461;5058.747062646871;5087.974560127194;5129.1536896412235;5130;5191.558717509016;5200.8179713710215;5022;5096.9551241995305;5151.9484805152215;5165.328507294028;5191.766370513336;5305.946940530584;5366.302380690524;5495;5521.171824226358;5539;5890.204822348971;5896.941030589682;5898.233229680157;5901.76392944286;5921.61509501881;6005.6396616203165;6006.609570377956;6014.729337179838;6016.308124565643;6017.916774980502;5336.786528538853;5403.243545903538;5486.231927530149;5542;5578.191162281447;6125.7040322982075;6130.754769809158;6131.96934015336;6141.293751218578;6142.969285153635;5875.970620146872;5889.970550147222;5891.469767720926;5899.67551784656;5907.438793314628;5863.853403664943;5899.410058994152;5914.852128696817;5936.168936348915;5970.701464926737;5971.5222782177325;5976.073708575178;5998.01032829587;6007.038873780174;6010.188624535632;5923.289205295306;5980.372060933626;5982.46157845796;5985.910211346833;6007.399260074045;4529.184746745552;4569.405977222939;4647.930281045787;4654.604358629486;4660.464046634613;4046.069404037088;4071.043304823364;4090.5295890972325;4098.4876890388705;4149.688773342012;5596.2165296858475;5642.322921249476;5642.576806739511;5644.040513112781;5671.404502527258;5807.216025836458;6006.729697163638;6015.819525414245;6017.308009578867;6025.0962355646125;5477.178423236467;5498.3127109111365;5546.944530554642;5554.805581804699;5574.526165275915;5133.8716532087;5140.922886156711;5141.897162056738;5142.023015627094;5142.97428512855;5972.313183983897;6016.909746353808;6064.878702425926;6097.085437184458;6117.888303246664;6080.118382834553;6085.878282434415;6086.269647642312;6089.086637004485;6110.511159107172;6095.51235901118;6103.23709536308;6106.45041946227;6106.938930610637;6114.113453549299;5779.335376431764;5844.561657875762;5853.356130825691;5913.05391137416;5916.112583112395;6082.756689732538;6088.8782224356155;6092.847678808065;6093.238345206849;6104.389561044038;5929.644221346733;5946.226990491382;5947.583669143291;5948.405159484017;5951.285845698544;5568.832935011957;5608.747606357805;5716.5998380113;5745.2818397700285;5921.851953701192;5769.91345129815;5780.826575202751;5782.913256301074;5790.7973220937065;5804.76780928775;5814.94185058144;5846.327672317738;5852.209951656472;5853.590248682722;5857.414258574279;5428.945710542844;5451.4276001019325;5701.144828275792;5708.372079071381;5718.571107166896 17:46:59 INFO - PROCESS | 25387 | |1;ext.html;580.7589850212162;620.4230066038585;635.6154526511459;658.7628453756647;670.7853486884193;33234;36584.45123323149;36617.45073823895;44043.11913761723;45163.32255016169;47317;47714;47736;47813.28280075793;47928.760356198254;8958.596863141174;9086.818263634723;9136.72589822303;9148.817023659523;9162.86255706165;8365.12166222547;8589.098144694779;9040.728778136634;10706.625268115578;10939.45302734864;11002.50488728009;11072.280301780358;11074.833877491845;11075.612353567627;11076.944615276952;10695.358278503314;10739.83890241647;10743.301685390425;10746.086582640484;10755.462226888625;10773.78452430947;10831.458427078614;10844.403557804317;10848;10863.076638485738;44762.55237447649;44982.550174498494;45039;45089.77455112736;45218.54781452209;3849.69202463805;3860.7104467164795;4040.7561602358355;4152.1072969311745;4297.39836422901;33157.6684233157;34002.82998585016;34056;34100.97697069067;35208.64791352079;4298.935515967263;4419.315006174048;4490.618297444721;4509.594136527696;4706.858794236178;371410;371534;376033;376601;376645;32215.51676724851;32887.67112328846;64998;65341.673291634186;65550.67224663847;40013.39979900304;40157.598424015385;40185.598144018186;40214.1957160861;40232.396514052314;16562.337506499847;16765.077920714233;16767;16773;16775.664486710197;11982.460789264504;13806.723865522634;13893.930530347283;13895.513657021957;13903.721925561433;8911.777205569782;9231.769205769775;9519.904800951901;9525.28560357976;9643.035696430441;3610.711143108545;3620.728445366608;3635.5273814404486;3636.818159092035;3697.5008373869723;1081.9513121909533;1092.382803715898;1099.6096385783092;1101.7025403141267;1195.2469943935266;31381.52927706086;33138.83430582831;33390.49914251288;33406;33778.32443351119;1135.7898788724112;1156.450685924196;1162.2096974057554;1169.6841852699724;1171;14459.927700361432;17289.394871179447;17928.372506962456;18363.35728249505;18890.52773680669;516089;516182;517484;517972;522513;59726;60013.39986600165;60023.69988150118;60128;60159.09761353583;1291.1542939374724;1336.6658335416146;1356.85752995936;1417.4826188441145;1445.2340259662396;29623.407531849673;34355.65644343525;34672.65327346795;34787.652123479456;34802.82598586991;52840.73579632231;53411.46588534065;53436.73281633567;53523.19715204197;53527;367557;368653;369821;370020;370840;26964.32589185286;27679.861600692675;29623.111306660834;30852;31395.686043139278;47235.527644723115;47976.7601161992;48650.51349486601;48693.269600955304;49011.26483102685;40749.38875916923;40993.38509922294;41402.585974141075;41639.58360416357;43123.56876431195;40348.394774077824;41456.25950934172;42101;42341.36487952745;42438;39379.80310098431;41808.37287440752;42582.14835703206;42973.355399668406;43022.56977430185;35736;37725.245495090494;37809.243815122994;38573.4213986796;38766.8369948902;28833.56749648799;28874;29021;29124.27189320284;29161.56257656179 17:46:59 INFO - PROCESS | 25387 | |2;jquery.html;420.15968063872253;429.95700429957003;431.3981995116813;431.69219477333746;441.2146379444588;18494.537636559093;18761.812381876178;20091.497712557193;20193.19227230909;20320.983950802438;18947.62104757904;19497.51256218592;19563.315283965065;19576;19781.109850056746;5739.225204597367;5890.3226128995075;5890.64656120632;5905.822825315226;5917;5582.86042848928;5693.402192769761;5750.856228594298;5804.071348584227;5863.648181109126;5732.22614946981;5740.512056475204;5743.597948143632;5744.10966300222;5744.597878148531;5568.49883510484;5733.996550603649;5734.741936612862;5738.713064346766;5784.0167171580515;5244.65909715871;5251.789928402859;5254.448282930313;5255.710935898524;5257.947420525784;23126.76873231263;23342.53314933692;23393.53212935749;23403.297901062826;23428.297151085495;2197.626403511407;2469.77772000519;2484.95030099397;2532.7720505154625;3041.1180757580273;14306.713865722628;14445.855541444556;14524.273786310641;14838.925805371013;15227.771583426258;1891.877027993176;1939.8157175068345;1953.8925359105244;2017.465371676507;2081.323569839793;49874.50125498735;63104.684476577786;71891.64054179747;78863;79033.60483197604;10942.562297508011;11121.44299798029;11287.097032237401;11359.318440893572;11410.372429516456;16187.433439829549;16191.514254572381;16226.918865405598;16234.75647865283;16262.268197931122;8478.194571515696;8592.8711069334;8642.444360015257;8661.177188167114;8886.51124188163;8346.916530834735;8383.790405239917;8558;8574.22831945128;8637.568121593895;6792.898106528406;6844.589324640538;6924.307569243036;6934.306569343126;6971.477139214478;1936.1674479973465;2033.6339458897542;2052.2098991887933;2059.4748339173416;2094.4345026842666;801.2508304735092;926.092429419173;971.844504879216;980.2158273381409;1073.1575713065206;20134.29529966444;20239.392818215478;20309.89845050765;20547.794522054886;20670.483237919172;1066.7493139112303;1080.7514271717391;1084.9132069434584;1088.1240601316017;1088.216484131424;10837.18721095921;11824.349660768568;11842.230255033395;11846.822297665542;11889.821652675217;440788;458455;463681;467419;467698;79439;79995.20004799994;81292.18707812847;82238.58880705558;83248;1037.2531777120462;1078.2182917384832;1100;1104.320842681745;1110.8722496912796;15899;16166.838331616533;16208.270627821541;16501.422450214184;16546.917265413595;38258.80870595629;41618;42143.15713685648;42237.57762422459;42558.5744142567;53970.460295396544;54524;54761.72619136879;62150.37849621446;62814.6859265719;8226.958865205635;8336.916630833613;8584;8808.471491710518;8910.55447227649;6868.450523957971;9907.950460247652;11148.944255278997;12274.202176858476;12401.875981240433;10173.796524069625;10514.631987880388;10602.522886469973;10821.134309255398;11135.721606959567;10353.63762268317;10665.680029599125;10784;10826.512806923865;10909.509072091616;10843.918116744813;10947.616833410792;10987.626546681664;11056.170787190831;11107.777844442904;8294.502329860228;8726.82546349082;8767.956160219159;8806.779830504289;8900.554972251492;8332.458390204618;9768.755781105529;10418.166546676097;10500.94749526278;10514.684559463229 17:46:59 INFO - PROCESS | 25387 | |3;mootools.html;1469.7501424757793;1488.717143742689;1642.367688439951;1764.982350176498;1796.9730454043192;8014.078380986189;8536.658533658654;8537.573121343923;8538.615762290705;8551;7259.056322678044;7453.068366454193;8061.395395345343;8265.256126948574;8332.875006874887;2361.6339467382495;2395.796357309631;2399.148302352657;2404.483036147228;2407.3981504623844;2392.3899405651537;2418.697662792151;2472.81453890958;2478.9092799168398;2481.2184161988916;2411.8794060297005;2416.6254230594286;2445.7554244575576;2447.3514518652573;2447.8164137689746;2345.1791872844537;2363.515479326734;2375.0381095656285;2385.105585405473;2388.2477019738812;2319.3389883883015;2332.0555175153922;2344.742078371378;2346.0381243690003;2346.624540073597;8397.244248017707;8476.618552165106;8478.957605211996;8508.276796472308;8563.186497282748;5147.716875571842;5278.9208161877605;5279.102552566034;5279.260903473479;5282.7622756976025;3290.9177270568425;3305.140663427502;3385.2552438463745;3387.0516255448515;3438.948415773765;1099.384344766933;1101.1796211822243;1111.155521803427;1136.9829452558217;1150.0856818828968;11584.18910676253;11590.594329198437;11689.883101168965;11693.88306116945;11697.415129243589;4367.432233809648;4467.664925130628;4560.156371071363;4583;4618.284165954283;9175.220106290906;9248;9262.305327100494;9273.814523709623;9276;5271.156614941591;5271.4728527147745;5272.841814745564;5279.234510995884;5280.9471905281225;4200.424840684743;4239.40648309237;4592.334111553806;4623.42207224097;4890.437599676083;3813.599572044951;3880.708946828999;3904.2191561687778;3954.268460334847;3984.1234928315725;1197.9820302695293;1204.3556697167148;1219.3293688471483;1221.1635030004475;1238.207547169812;902.41794042842;942.3215284994793;944.9338546301693;949.7957939043139;969.185883857563;5503.3395992481155;5591.720413979285;5690.601657883991;5734.971325143431;6039.396060394013;475.25859658932177;479.52526998272157;482.582566080338;484.2639188433561;489.4493694593582;3893.279743247508;4015.8393664253686;4016.5983401660183;4057.107436363995;4112.485939257593;10073.445960472098;10290.536925838205;10354.11989980845;10359.689209323733;10377.636782712569;10041.648542300984;10317;10324.483775811179;10326;10329.276950613536;7832.569208693577;8037.879431808527;8041.075276343178;8043.477173983672;8043.6782528698195;5527.778888844401;5593.07714227148;5593.860153496195;5631.831045068655;5738.626989245686;9402.57688404037;9500.667476638284;9535.189508891823;9547.093026162504;9569.234461242944;9038.141376569216;9447;9491.905080949102;9577.664781732607;9596.9040309596;6717.832054198684;6907.93092069093;7384.150822655463;7599.810004749926;7747.6513556891205;7946.086200087064;8333.666653334041;8334.12491688364;8334.291585215324;8345.290650294794;7278.454115941219;7399.260073992557;7495.662695178621;7547.245275472409;7588.013558237614;7251.347378735939;7317.26827317264;7416;7420.6660700269695;7620.1998790128455;6807.489438292049;6910.997905303602;6914.412274956685;6921.965390173017;6926.44588432914;5023.974880125576;5074.289599456005;5091.59267258611;5092.923606145985;5322.201669749568;5094.770735316845;5115.43213245538;5161.380634323905;5267.157254839208;5285.656432331886 17:46:59 INFO - PROCESS | 25387 | |4;prototype.html;351.8944316704989;354.8686985815249;361.5679263280379;364.3296334744069;366.4082506751597;5263.236830659552;5263.736813159346;5294.152935530321;5305.575553955684;5308.566686994514;5167.224916262562;5207.739613019344;5231.163013917774;5257.5005374489365;5258.158694608864;3954.782486963216;4144.777290699251;4165.812538435777;4170.812313445902;4223.711767910786;4127.215828992482;4134.586541345856;4154.148399578079;4157.376393540978;4180.51924028736;3927.56796752357;4140.50313962325;4141.840284720268;4148.377743338493;4151.709380343377;4046.4941882264716;4047.9797601011805;4127.318992366256;4147.854825081107;4155.480564929384;3687.723420743428;3694.9445758313645;3697.759645623026;3701.6309561880416;3709.7217708671956;4919.2867034279825;5120.436751957282;5136.922946155773;5149.794008239666;5152.92270615941;4399.340098985146;4667.416572928384;4704.388429504143;4712.976435117803;4718.4809670936165;5417.729113544307;5446.183072539151;5447;5449.3188351456065;5454.836354909319;3868.6324799144318;4038.434619153321;4041.5756345583877;4044.0698639313123;4049.7165198436123;5651.547876169897;5686.772529098873;5689.800856970028;5690.7439165237665;5710.65736055838;4128.896777580585;4147.129102888367;4148.688848336386;4150.128473020639;4154.2759754702065;4135.953528612038;4204.62158405745;4216.177845320194;4216.641585465209;4221.852235171816;4667.509911459248;4692.7653617319;4694.436667599842;4722.338872557844;4737.644676649265;5501.779928802803;5504.174373843955;5522.834314970557;5531.363893152258;5538.16927460876;1396.218117854005;1404.3610157378369;1409.2319685771279;1409.7603407420763;1416.7945647881;946.3659348236698;976.1556253840376;977.5014742481386;986.6941248213077;989.1295659819313;5036.84889453317;5054.19132938728;5060.6336289202445;5080.644354895196;5088.949110508847;5376.784928602812;5379.435159308295;5385.946140538545;5409.891802163935;5430.484104010192;5095.745212739423;5101.362329708786;5129.948700512947;5267.815626453055;5339.199120131933;2809.2976755811046;2846.573014047868;2869.684334723179;2888.653361596622;2896.827379465401;5429.701366424805;5439.292891924025;5463.043967305705;5490.203920431515;5508.944910550843;5441.401445840955;5562.443755624405;5576.776928922797;5733.799317023884;5797.275340582427;5732.3121225453215;5732.369439361667;5745;5745.68398738065;5754;5528.391876893458;5663.688497132697;5683.8010669626365;5698.857528561819;5700.3444603871085;5580.935054030035;5581.158217788039;5592.69240191777;5597.748101335531;5614.799564248503;5686.630369026;5698.800541981011;5713.514351280188;5718.428157184415;5728.427157284238;4079.408485769606;4223.134257477148;4229.703920725519;4254.404383386266;4282.143571285693;5625.071863142699;5625.549956003428;5629.39562224764;5636.070048441961;5640.492355688008;5502.724863756876;5508.419527307282;5511.751971161227;5513.228148059195;5530.364008139116;5347.759350829144;5445.53712934405;5462.754176062007;5473.507384335429;5532;5369.865753356041;5435.565154787687;5442.238086667949;5448.645838020675;5470.945290547043;5505.587080969023;5517.310336207974;5531.529819965348;5531.612787105025;5548;5204.583633309402;5401.567874569946;5424.349078110652;5425.945740542544;5446 17:46:59 INFO - PROCESS | 25387 | |5;yui.html;750.9549427034382;767.0986590755864;835.4068611285988;841.8779277004835;873.4104479476351;13451.730965380699;13459.79810302845;15756.606084847885;15790.526284211477;15918.204089795521;12788.104832661717;13119.606411807637;13132;13243.801342979863;13244.404001819918;828.7886588919847;842.0442797424936;844.15162761425;844.4089137603702;845.3913182508614;846.6613354658125;849.3841964575695;849.5030407211758;849.6813694864426;850.4939560961218;884.7301573020226;884.747846863644;885.2165833237599;885.6103314541581;886.3751055505885;873.8296032273678;874.903760586335;878.1832895407268;879.3712495565669;879.687710862641;646.9902951455732;650.339904996429;651.3486513486514;651.3844417025913;651.6513665189149;13249.801252981213;13549.52576659822;13600.183988960594;14127.505537306248;14301.856981430261;11470.197086203969;12109.333986630732;12198.939005304917;12562.560310389184;12578.68553286166;9828.606855725762;10021.298509104365;10023.949880250624;10248.48757562119;10436.582536698523;3556.751027428081;3584.211473475831;3617.240379520304;3670.926581468356;3854.5181852268465;37965.24069518622;45286.77356613229;57401;58689.41310586925;65575.34424655788;10019.899801002042;10102.39385636864;10420.32267902584;10506.684799456028;10637.361758294372;20863.687044694343;21288.680669789966;21301.041453134647;21341.78658213429;21351.14595416197;7621.237876212334;8024.836398722153;8162.755117346489;8167.305779008851;8225.670973161006;4188.455500784939;4315.611594956469;4356.302991521341;4372.846950356722;4419.535948725402;3322.1860644141857;3427.0746898337807;3428.8628454861528;3429.9314013719586;3430.5540279763472;585.6515373352848;593.5044238061181;601.4316470935012;606.1211243696657;610.7679081948831;610.8503416662858;625.1810128731377;627.0688028278004;630.196499463188;631.9052142178618;8509.489430634181;8638.308935285162;8659.523726194993;8938.10618938101;8965.117325361616;549.8927709096688;608.3764141754737;660.4221306356937;663.6482664187988;671.53328436736;3941.743786653916;4035.414864844581;4069.8168582413864;4126.463559737215;4130;86872;87385.56307218423;89604.5519772397;92520;92969.5351523238;51271.74364128155;71382.64308678423;78099;82140;83052.58473707593;72079.63960180165;73530;73584.26415735774;74664;77304.61347693225;7655.1962043986805;7834.647440865061;8123.268905798506;8183.549904755296;8261.215184557457;51620.22569661383;52004;52133.47866521438;53192.20211696905;53986.73006634942;67041.66479167574;70071.64964175147;70246.29753702397;71665.64167179131;71828.64085679538;10670.786584268426;11133;11135.72160695989;11221.214514983873;11284;12265.325407102695;12281.631551053482;12501.374931253218;12771.93614031924;13348.399322030338;10286.228532859916;10410.635627752992;10584.100351470212;10850.945745271223;10951.123910087334;11123.27698699582;11167.776644467227;11352.375619340684;11559.537618495166;11607.6517704469;10848.67453976382;11045.834312485158;11277.097832173242;11287.153463490435;11530.481128349413;8132.593370331578;8297.543635100128;8446.704365347183;8466;11352.716182095513;10719.491386300748;10752.946235268773;10873.619423320146;10904.78190436171;11218 17:46:59 INFO - PROCESS | 25387 | __end_tp_report 17:46:59 INFO - PROCESS | 25387 | __start_cc_report 17:46:59 INFO - PROCESS | 25387 | _x_x_mozilla_cycle_collect,1100 17:46:59 INFO - PROCESS | 25387 | __end_cc_report 17:46:59 INFO - PROCESS | 25387 | __startTimestamp1487900819420__endTimestamp 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | ------- Summary: start ------- 17:46:59 INFO - PROCESS | 25387 | Number of tests: 6 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#0] dojo.html Cycles:165 Average:5541.11 Median:5718.57 stddev:622.49 (10.9%) stddev-sans-first:596.36 17:46:59 INFO - PROCESS | 25387 | Values: 3186.4 3226.5 3237.0 3258.0 3264.4 5596.6 5621.4 5671.3 5671.3 5684.7 5567.1 5613.8 5625.5 5633.6 5646.7 5054.2 5079.0 5112.1 5140.2 5141.9 5025.2 5108.4 5152.5 5167.2 5167.4 5002.7 5015.1 5032.1 5044.2 5058.7 5088.0 5129.2 5130.0 5191.6 5200.8 5022.0 5097.0 5151.9 5165.3 5191.8 5305.9 5366.3 5495.0 5521.2 5539.0 5890.2 5896.9 5898.2 5901.8 5921.6 6005.6 6006.6 6014.7 6016.3 6017.9 5336.8 5403.2 5486.2 5542.0 5578.2 6125.7 6130.8 6132.0 6141.3 6143.0 5876.0 5890.0 5891.5 5899.7 5907.4 5863.9 5899.4 5914.9 5936.2 5970.7 5971.5 5976.1 5998.0 6007.0 6010.2 5923.3 5980.4 5982.5 5985.9 6007.4 4529.2 4569.4 4647.9 4654.6 4660.5 4046.1 4071.0 4090.5 4098.5 4149.7 5596.2 5642.3 5642.6 5644.0 5671.4 5807.2 6006.7 6015.8 6017.3 6025.1 5477.2 5498.3 5546.9 5554.8 5574.5 5133.9 5140.9 5141.9 5142.0 5143.0 5972.3 6016.9 6064.9 6097.1 6117.9 6080.1 6085.9 6086.3 6089.1 6110.5 6095.5 6103.2 6106.5 6106.9 6114.1 5779.3 5844.6 5853.4 5913.1 5916.1 6082.8 6088.9 6092.8 6093.2 6104.4 5929.6 5946.2 5947.6 5948.4 5951.3 5568.8 5608.7 5716.6 5745.3 5921.9 5769.9 5780.8 5782.9 5790.8 5804.8 5814.9 5846.3 5852.2 5853.6 5857.4 5428.9 5451.4 5701.1 5708.4 5718.6 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#1] ext.html Cycles:180 Average:58180.49 Median:376317.00 stddev:112810.68 (30.0%) stddev-sans-first:113044.25 17:46:59 INFO - PROCESS | 25387 | Values: 580.8 620.4 635.6 658.8 670.8 33234.0 36584.5 36617.5 44043.1 45163.3 47317.0 47714.0 47736.0 47813.3 47928.8 8958.6 9086.8 9136.7 9148.8 9162.9 8365.1 8589.1 9040.7 10706.6 10939.5 11002.5 11072.3 11074.8 11075.6 11076.9 10695.4 10739.8 10743.3 10746.1 10755.5 10773.8 10831.5 10844.4 10848.0 10863.1 44762.6 44982.6 45039.0 45089.8 45218.5 3849.7 3860.7 4040.8 4152.1 4297.4 33157.7 34002.8 34056.0 34101.0 35208.6 4298.9 4419.3 4490.6 4509.6 4706.9 371410.0 371534.0 376033.0 376601.0 376645.0 32215.5 32887.7 64998.0 65341.7 65550.7 40013.4 40157.6 40185.6 40214.2 40232.4 16562.3 16765.1 16767.0 16773.0 16775.7 11982.5 13806.7 13893.9 13895.5 13903.7 8911.8 9231.8 9519.9 9525.3 9643.0 3610.7 3620.7 3635.5 3636.8 3697.5 1082.0 1092.4 1099.6 1101.7 1195.2 31381.5 33138.8 33390.5 33406.0 33778.3 1135.8 1156.5 1162.2 1169.7 1171.0 14459.9 17289.4 17928.4 18363.4 18890.5 516089.0 516182.0 517484.0 517972.0 522513.0 59726.0 60013.4 60023.7 60128.0 60159.1 1291.2 1336.7 1356.9 1417.5 1445.2 29623.4 34355.7 34672.7 34787.7 34802.8 52840.7 53411.5 53436.7 53523.2 53527.0 367557.0 368653.0 369821.0 370020.0 370840.0 26964.3 27679.9 29623.1 30852.0 31395.7 47235.5 47976.8 48650.5 48693.3 49011.3 40749.4 40993.4 41402.6 41639.6 43123.6 40348.4 41456.3 42101.0 42341.4 42438.0 39379.8 41808.4 42582.1 42973.4 43022.6 35736.0 37725.2 37809.2 38573.4 38766.8 28833.6 28874.0 29021.0 29124.3 29161.6 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#2] jquery.html Cycles:180 Average:27603.18 Median:2786.95 stddev:75523.86 (2709.9%) stddev-sans-first:75708.14 17:46:59 INFO - PROCESS | 25387 | Values: 420.2 430.0 431.4 431.7 441.2 18494.5 18761.8 20091.5 20193.2 20321.0 18947.6 19497.5 19563.3 19576.0 19781.1 5739.2 5890.3 5890.6 5905.8 5917.0 5582.9 5693.4 5750.9 5804.1 5863.6 5732.2 5740.5 5743.6 5744.1 5744.6 5568.5 5734.0 5734.7 5738.7 5784.0 5244.7 5251.8 5254.4 5255.7 5257.9 23126.8 23342.5 23393.5 23403.3 23428.3 2197.6 2469.8 2485.0 2532.8 3041.1 14306.7 14445.9 14524.3 14838.9 15227.8 1891.9 1939.8 1953.9 2017.5 2081.3 49874.5 63104.7 71891.6 78863.0 79033.6 10942.6 11121.4 11287.1 11359.3 11410.4 16187.4 16191.5 16226.9 16234.8 16262.3 8478.2 8592.9 8642.4 8661.2 8886.5 8346.9 8383.8 8558.0 8574.2 8637.6 6792.9 6844.6 6924.3 6934.3 6971.5 1936.2 2033.6 2052.2 2059.5 2094.4 801.3 926.1 971.8 980.2 1073.2 20134.3 20239.4 20309.9 20547.8 20670.5 1066.7 1080.8 1084.9 1088.1 1088.2 10837.2 11824.3 11842.2 11846.8 11889.8 440788.0 458455.0 463681.0 467419.0 467698.0 79439.0 79995.2 81292.2 82238.6 83248.0 1037.3 1078.2 1100.0 1104.3 1110.9 15899.0 16166.8 16208.3 16501.4 16546.9 38258.8 41618.0 42143.2 42237.6 42558.6 53970.5 54524.0 54761.7 62150.4 62814.7 8227.0 8336.9 8584.0 8808.5 8910.6 6868.5 9908.0 11148.9 12274.2 12401.9 10173.8 10514.6 10602.5 10821.1 11135.7 10353.6 10665.7 10784.0 10826.5 10909.5 10843.9 10947.6 10987.6 11056.2 11107.8 8294.5 8726.8 8768.0 8806.8 8900.6 8332.5 9768.8 10418.2 10500.9 10514.7 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#3] mootools.html Cycles:180 Average:5565.11 Median:5131.57 stddev:3070.35 (59.8%) stddev-sans-first:3063.54 17:46:59 INFO - PROCESS | 25387 | Values: 1469.8 1488.7 1642.4 1765.0 1797.0 8014.1 8536.7 8537.6 8538.6 8551.0 7259.1 7453.1 8061.4 8265.3 8332.9 2361.6 2395.8 2399.1 2404.5 2407.4 2392.4 2418.7 2472.8 2478.9 2481.2 2411.9 2416.6 2445.8 2447.4 2447.8 2345.2 2363.5 2375.0 2385.1 2388.2 2319.3 2332.1 2344.7 2346.0 2346.6 8397.2 8476.6 8479.0 8508.3 8563.2 5147.7 5278.9 5279.1 5279.3 5282.8 3290.9 3305.1 3385.3 3387.1 3438.9 1099.4 1101.2 1111.2 1137.0 1150.1 11584.2 11590.6 11689.9 11693.9 11697.4 4367.4 4467.7 4560.2 4583.0 4618.3 9175.2 9248.0 9262.3 9273.8 9276.0 5271.2 5271.5 5272.8 5279.2 5280.9 4200.4 4239.4 4592.3 4623.4 4890.4 3813.6 3880.7 3904.2 3954.3 3984.1 1198.0 1204.4 1219.3 1221.2 1238.2 902.4 942.3 944.9 949.8 969.2 5503.3 5591.7 5690.6 5735.0 6039.4 475.3 479.5 482.6 484.3 489.4 3893.3 4015.8 4016.6 4057.1 4112.5 10073.4 10290.5 10354.1 10359.7 10377.6 10041.6 10317.0 10324.5 10326.0 10329.3 7832.6 8037.9 8041.1 8043.5 8043.7 5527.8 5593.1 5593.9 5631.8 5738.6 9402.6 9500.7 9535.2 9547.1 9569.2 9038.1 9447.0 9491.9 9577.7 9596.9 6717.8 6907.9 7384.2 7599.8 7747.7 7946.1 8333.7 8334.1 8334.3 8345.3 7278.5 7399.3 7495.7 7547.2 7588.0 7251.3 7317.3 7416.0 7420.7 7620.2 6807.5 6911.0 6914.4 6922.0 6926.4 5024.0 5074.3 5091.6 5092.9 5322.2 5094.8 5115.4 5161.4 5267.2 5285.7 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#4] prototype.html Cycles:180 Average:4620.34 Median:5265.78 stddev:1329.50 (25.2%) stddev-sans-first:1294.05 17:46:59 INFO - PROCESS | 25387 | Values: 351.9 354.9 361.6 364.3 366.4 5263.2 5263.7 5294.2 5305.6 5308.6 5167.2 5207.7 5231.2 5257.5 5258.2 3954.8 4144.8 4165.8 4170.8 4223.7 4127.2 4134.6 4154.1 4157.4 4180.5 3927.6 4140.5 4141.8 4148.4 4151.7 4046.5 4048.0 4127.3 4147.9 4155.5 3687.7 3694.9 3697.8 3701.6 3709.7 4919.3 5120.4 5136.9 5149.8 5152.9 4399.3 4667.4 4704.4 4713.0 4718.5 5417.7 5446.2 5447.0 5449.3 5454.8 3868.6 4038.4 4041.6 4044.1 4049.7 5651.5 5686.8 5689.8 5690.7 5710.7 4128.9 4147.1 4148.7 4150.1 4154.3 4136.0 4204.6 4216.2 4216.6 4221.9 4667.5 4692.8 4694.4 4722.3 4737.6 5501.8 5504.2 5522.8 5531.4 5538.2 1396.2 1404.4 1409.2 1409.8 1416.8 946.4 976.2 977.5 986.7 989.1 5036.8 5054.2 5060.6 5080.6 5088.9 5376.8 5379.4 5385.9 5409.9 5430.5 5095.7 5101.4 5129.9 5267.8 5339.2 2809.3 2846.6 2869.7 2888.7 2896.8 5429.7 5439.3 5463.0 5490.2 5508.9 5441.4 5562.4 5576.8 5733.8 5797.3 5732.3 5732.4 5745.0 5745.7 5754.0 5528.4 5663.7 5683.8 5698.9 5700.3 5580.9 5581.2 5592.7 5597.7 5614.8 5686.6 5698.8 5713.5 5718.4 5728.4 4079.4 4223.1 4229.7 4254.4 4282.1 5625.1 5625.5 5629.4 5636.1 5640.5 5502.7 5508.4 5511.8 5513.2 5530.4 5347.8 5445.5 5462.8 5473.5 5532.0 5369.9 5435.6 5442.2 5448.6 5470.9 5505.6 5517.3 5531.5 5531.6 5548.0 5204.6 5401.6 5424.3 5425.9 5446.0 17:46:59 INFO - PROCESS | 25387 | 17:46:59 INFO - PROCESS | 25387 | [#5] yui.html Cycles:180 Average:17566.57 Median:52662.84 stddev:24273.98 (46.1%) stddev-sans-first:24309.24 17:46:59 INFO - PROCESS | 25387 | Values: 751.0 767.1 835.4 841.9 873.4 13451.7 13459.8 15756.6 15790.5 15918.2 12788.1 13119.6 13132.0 13243.8 13244.4 828.8 842.0 844.2 844.4 845.4 846.7 849.4 849.5 849.7 850.5 884.7 884.7 885.2 885.6 886.4 873.8 874.9 878.2 879.4 879.7 647.0 650.3 651.3 651.4 651.7 13249.8 13549.5 13600.2 14127.5 14301.9 11470.2 12109.3 12198.9 12562.6 12578.7 9828.6 10021.3 10023.9 10248.5 10436.6 3556.8 3584.2 3617.2 3670.9 3854.5 37965.2 45286.8 57401.0 58689.4 65575.3 10019.9 10102.4 10420.3 10506.7 10637.4 20863.7 21288.7 21301.0 21341.8 21351.1 7621.2 8024.8 8162.8 8167.3 8225.7 4188.5 4315.6 4356.3 4372.8 4419.5 3322.2 3427.1 3428.9 3429.9 3430.6 585.7 593.5 601.4 606.1 610.8 610.9 625.2 627.1 630.2 631.9 8509.5 8638.3 8659.5 8938.1 8965.1 549.9 608.4 660.4 663.6 671.5 3941.7 4035.4 4069.8 4126.5 4130.0 86872.0 87385.6 89604.6 92520.0 92969.5 51271.7 71382.6 78099.0 82140.0 83052.6 72079.6 73530.0 73584.3 74664.0 77304.6 7655.2 7834.6 8123.3 8183.5 8261.2 51620.2 52004.0 52133.5 53192.2 53986.7 67041.7 70071.6 70246.3 71665.6 71828.6 10670.8 11133.0 11135.7 11221.2 11284.0 12265.3 12281.6 12501.4 12771.9 13348.4 10286.2 10410.6 10584.1 10850.9 10951.1 11123.3 11167.8 11352.4 11559.5 11607.7 10848.7 11045.8 11277.1 11287.2 11530.5 8132.6 8297.5 8446.7 8466.0 11352.7 10719.5 10752.9 10873.6 10904.8 11218.0 17:46:59 INFO - PROCESS | 25387 | -------- Summary: end -------- 17:46:59 INFO - PROCESS | 25387 | 17:47:00 INFO - TEST-INFO | 25387: exit 0 17:47:00 INFO - TEST-OK | dromaeo_css | took 1114719ms 17:47:00 INFO - TEST-START | kraken 17:47:00 INFO - operating with platform_type : linux_ 17:47:00 INFO - Initialising browser for kraken test... 17:47:00 INFO - TEST-INFO | started process 25695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcAV_D/profile http://localhost:45867/getInfo.html) 17:47:04 INFO - PROCESS | 25695 | __metrics Screen width/height:1600/1200 17:47:04 INFO - PROCESS | 25695 | colorDepth:24 17:47:04 INFO - PROCESS | 25695 | Browser inner width/height: 1024/697 17:47:04 INFO - PROCESS | 25695 | __metrics 17:47:04 INFO - PROCESS | 25695 | 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" 17:47:04 INFO - PROCESS | 25695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:47:05 INFO - PROCESS | 25695 | console.error: PushService: 17:47:05 INFO - PROCESS | 25695 | stateChangeProcessEnqueue: Error transitioning state 17:47:05 INFO - PROCESS | 25695 | UnknownError 17:47:05 INFO - TEST-INFO | 25695: exit 0 17:47:05 INFO - Browser initialized. 17:47:05 INFO - Running cycle 1/1 for kraken test... 17:47:05 INFO - TEST-INFO | started process 25787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcAV_D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:17 INFO - PROCESS | 25787 | RSS: Main: 141910016 17:47:17 INFO - PROCESS | 25787 | 17:47:20 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:21 INFO - PROCESS | 25787 | RSS: Main: 183508992 17:47:21 INFO - PROCESS | 25787 | 17:47:23 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-dft) 17:47:24 INFO - PROCESS | 25787 | RSS: Main: 172732416 17:47:24 INFO - PROCESS | 25787 | 17:47:26 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-fft) 17:47:27 INFO - PROCESS | 25787 | RSS: Main: 264249344 17:47:27 INFO - PROCESS | 25787 | 17:47:29 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-oscillator) 17:47:30 INFO - PROCESS | 25787 | RSS: Main: 171663360 17:47:30 INFO - PROCESS | 25787 | 17:47:32 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:47:32 INFO - PROCESS | 25787 | RSS: Main: 174137344 17:47:32 INFO - PROCESS | 25787 | 17:47:35 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-darkroom) 17:47:36 INFO - PROCESS | 25787 | RSS: Main: 209080320 17:47:36 INFO - PROCESS | 25787 | 17:47:39 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-desaturate) 17:47:40 INFO - PROCESS | 25787 | RSS: Main: 210272256 17:47:40 INFO - PROCESS | 25787 | 17:47:42 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45867/tests/kraken/driver.html?testName=json-parse-financial) 17:47:43 INFO - PROCESS | 25787 | RSS: Main: 209956864 17:47:43 INFO - PROCESS | 25787 | 17:47:45 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:47:45 INFO - PROCESS | 25787 | RSS: Main: 171831296 17:47:45 INFO - PROCESS | 25787 | 17:47:47 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:47:47 INFO - PROCESS | 25787 | RSS: Main: 179015680 17:47:47 INFO - PROCESS | 25787 | 17:47:49 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:50 INFO - PROCESS | 25787 | RSS: Main: 188448768 17:47:50 INFO - PROCESS | 25787 | 17:47:53 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:53 INFO - PROCESS | 25787 | RSS: Main: 196706304 17:47:53 INFO - PROCESS | 25787 | 17:47:56 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:57 INFO - PROCESS | 25787 | RSS: Main: 192483328 17:47:57 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45867/tests/kraken/driver.html?testName=ai-astar) 17:47:58 INFO - PROCESS | 25787 | RSS: Main: 244428800 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | __start_tp_report 17:47:58 INFO - PROCESS | 25787 | _x_x_mozilla_page_load 17:47:58 INFO - PROCESS | 25787 | _x_x_mozilla_page_load_details 17:47:58 INFO - PROCESS | 25787 | |i|pagename|runs| 17:47:58 INFO - PROCESS | 25787 | |0;ai-astar;101;111;110;110;110;111;110;110;111;109 17:47:58 INFO - PROCESS | 25787 | |1;audio-beat-detection;145;118;117;145;133;123;119;117;144;117 17:47:58 INFO - PROCESS | 25787 | |2;audio-dft;160;161;163;160;160;160;160;159;159;160 17:47:58 INFO - PROCESS | 25787 | |3;audio-fft;73;73;75;105;76;76;74;75;100;74 17:47:58 INFO - PROCESS | 25787 | |4;audio-oscillator;82;82;111;82;83;83;98;83;82;107 17:47:58 INFO - PROCESS | 25787 | |5;imaging-gaussian-blur;117;117;119;117;117;117;117;117;116;117 17:47:58 INFO - PROCESS | 25787 | |6;imaging-darkroom;146;146;148;147;147;146;147;147;147;146 17:47:58 INFO - PROCESS | 25787 | |7;imaging-desaturate;85;85;84;84;84;84;84;84;85;84 17:47:58 INFO - PROCESS | 25787 | |8;json-parse-financial;51;51;52;52;51;53;51;51;51;51 17:47:58 INFO - PROCESS | 25787 | |9;json-stringify-tinderbox;57;58;58;58;58;59;59;58;59;58 17:47:58 INFO - PROCESS | 25787 | |10;stanford-crypto-aes;75;80;81;77;77;75;78;80;78;75 17:47:58 INFO - PROCESS | 25787 | |11;stanford-crypto-ccm;125;122;122;121;120;121;131;133;160;122 17:47:58 INFO - PROCESS | 25787 | |12;stanford-crypto-pbkdf2;154;158;155;159;158;157;162;157;157;158 17:47:58 INFO - PROCESS | 25787 | |13;stanford-crypto-sha256-iterative;63;62;64;71;63;61;65;62;63;61 17:47:58 INFO - PROCESS | 25787 | __end_tp_report 17:47:58 INFO - PROCESS | 25787 | __start_cc_report 17:47:58 INFO - PROCESS | 25787 | _x_x_mozilla_cycle_collect,1618 17:47:58 INFO - PROCESS | 25787 | __end_cc_report 17:47:58 INFO - PROCESS | 25787 | __startTimestamp1487900878963__endTimestamp 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | ------- Summary: start ------- 17:47:58 INFO - PROCESS | 25787 | Number of tests: 14 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.98 (2.7%) stddev-sans-first:0.67 17:47:58 INFO - PROCESS | 25787 | Values: 101.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 111.0 109.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:128.00 stddev:12.59 (9.8%) stddev-sans-first:11.72 17:47:58 INFO - PROCESS | 25787 | Values: 145.0 118.0 117.0 145.0 133.0 123.0 119.0 117.0 144.0 117.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 17:47:58 INFO - PROCESS | 25787 | Values: 160.0 161.0 163.0 160.0 160.0 160.0 160.0 159.0 159.0 160.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.50 stddev:11.91 (16.0%) stddev-sans-first:12.35 17:47:58 INFO - PROCESS | 25787 | Values: 73.0 73.0 75.0 105.0 76.0 76.0 74.0 75.0 100.0 74.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.50 stddev:11.51 (14.0%) stddev-sans-first:11.90 17:47:58 INFO - PROCESS | 25787 | Values: 82.0 82.0 111.0 82.0 83.0 83.0 98.0 83.0 82.0 107.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 17:47:58 INFO - PROCESS | 25787 | Values: 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:47:58 INFO - PROCESS | 25787 | Values: 146.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 17:47:58 INFO - PROCESS | 25787 | Values: 85.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 17:47:58 INFO - PROCESS | 25787 | Values: 51.0 51.0 52.0 52.0 51.0 53.0 51.0 51.0 51.0 51.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 17:47:58 INFO - PROCESS | 25787 | Values: 57.0 58.0 58.0 58.0 58.0 59.0 59.0 58.0 59.0 58.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:2.22 (2.8%) stddev-sans-first:2.15 17:47:58 INFO - PROCESS | 25787 | Values: 75.0 80.0 81.0 77.0 77.0 75.0 78.0 80.0 78.0 75.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:123.50 stddev:12.18 (9.9%) stddev-sans-first:12.88 17:47:58 INFO - PROCESS | 25787 | Values: 125.0 122.0 122.0 121.0 120.0 121.0 131.0 133.0 160.0 122.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:158.00 stddev:2.17 (1.4%) stddev-sans-first:1.90 17:47:58 INFO - PROCESS | 25787 | Values: 154.0 158.0 155.0 159.0 158.0 157.0 162.0 157.0 157.0 158.0 17:47:58 INFO - PROCESS | 25787 | 17:47:58 INFO - PROCESS | 25787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.92 (4.6%) stddev-sans-first:3.09 17:47:58 INFO - PROCESS | 25787 | Values: 63.0 62.0 64.0 71.0 63.0 61.0 65.0 62.0 63.0 61.0 17:47:58 INFO - PROCESS | 25787 | -------- Summary: end -------- 17:47:58 INFO - PROCESS | 25787 | 17:48:00 INFO - TEST-INFO | 25787: exit 0 17:48:00 INFO - TEST-OK | kraken | took 60013ms 17:48:00 INFO - SUITE-END | took 1174s 17:48:00 INFO - Completed test suite (00:19:34) 17:48:00 INFO - javascript benchmark 17:48:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3186.4264432402174, 3226.4837625979835, 3236.951445728314, 3257.967420325799, 3264.4450443424616, 5596.5522758179295, 5621.437856214377, 5671.262735844334, 5671.319441666996, 5684.744186511606, 5567.137093750465, 5613.831585052445, 5625.465580769831, 5633.577481688869, 5646.717664116798, 5054.241863720435, 5078.974605126988, 5112.130937740593, 5140.203268493389, 5141.922871156936, 5025.1708468102715, 5108.386993560778, 5152.510511501401, 5167.224916262553, 5167.405748338932, 5002.674826136289, 5015.122353588107, 5032.11937910866, 5044.167712327461, 5058.747062646871, 5087.974560127194, 5129.1536896412235, 5130.0, 5191.558717509016, 5200.8179713710215, 5022.0, 5096.9551241995305, 5151.9484805152215, 5165.328507294028, 5191.766370513336, 5305.946940530584, 5366.302380690524, 5495.0, 5521.171824226358, 5539.0, 5890.204822348971, 5896.941030589682, 5898.233229680157, 5901.76392944286, 5921.61509501881, 6005.6396616203165, 6006.609570377956, 6014.729337179838, 6016.308124565643, 6017.916774980502, 5336.786528538853, 5403.243545903538, 5486.231927530149, 5542.0, 5578.191162281447, 6125.7040322982075, 6130.754769809158, 6131.96934015336, 6141.293751218578, 6142.969285153635, 5875.970620146872, 5889.970550147222, 5891.469767720926, 5899.67551784656, 5907.438793314628, 5863.853403664943, 5899.410058994152, 5914.852128696817, 5936.168936348915, 5970.701464926737, 5971.5222782177325, 5976.073708575178, 5998.01032829587, 6007.038873780174, 6010.188624535632, 5923.289205295306, 5980.372060933626, 5982.46157845796, 5985.910211346833, 6007.399260074045, 4529.184746745552, 4569.405977222939, 4647.930281045787, 4654.604358629486, 4660.464046634613, 4046.069404037088, 4071.043304823364, 4090.5295890972325, 4098.4876890388705, 4149.688773342012, 5596.2165296858475, 5642.322921249476, 5642.576806739511, 5644.040513112781, 5671.404502527258, 5807.216025836458, 6006.729697163638, 6015.819525414245, 6017.308009578867, 6025.0962355646125, 5477.178423236467, 5498.3127109111365, 5546.944530554642, 5554.805581804699, 5574.526165275915, 5133.8716532087, 5140.922886156711, 5141.897162056738, 5142.023015627094, 5142.97428512855, 5972.313183983897, 6016.909746353808, 6064.878702425926, 6097.085437184458, 6117.888303246664, 6080.118382834553, 6085.878282434415, 6086.269647642312, 6089.086637004485, 6110.511159107172, 6095.51235901118, 6103.23709536308, 6106.45041946227, 6106.938930610637, 6114.113453549299, 5779.335376431764, 5844.561657875762, 5853.356130825691, 5913.05391137416, 5916.112583112395, 6082.756689732538, 6088.8782224356155, 6092.847678808065, 6093.238345206849, 6104.389561044038, 5929.644221346733, 5946.226990491382, 5947.583669143291, 5948.405159484017, 5951.285845698544, 5568.832935011957, 5608.747606357805, 5716.5998380113, 5745.2818397700285, 5921.851953701192, 5769.91345129815, 5780.826575202751, 5782.913256301074, 5790.7973220937065, 5804.76780928775, 5814.94185058144, 5846.327672317738, 5852.209951656472, 5853.590248682722, 5857.414258574279, 5428.945710542844, 5451.4276001019325, 5701.144828275792, 5708.372079071381, 5718.571107166896], "value": 5499.54565828278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7589850212162, 620.4230066038585, 635.6154526511459, 658.7628453756647, 670.7853486884193, 33234.0, 36584.45123323149, 36617.45073823895, 44043.11913761723, 45163.32255016169, 47317.0, 47714.0, 47736.0, 47813.28280075793, 47928.760356198254, 8958.596863141174, 9086.818263634723, 9136.72589822303, 9148.817023659523, 9162.86255706165, 8365.12166222547, 8589.098144694779, 9040.728778136634, 10706.625268115578, 10939.45302734864, 11002.50488728009, 11072.280301780358, 11074.833877491845, 11075.612353567627, 11076.944615276952, 10695.358278503314, 10739.83890241647, 10743.301685390425, 10746.086582640484, 10755.462226888625, 10773.78452430947, 10831.458427078614, 10844.403557804317, 10848.0, 10863.076638485738, 44762.55237447649, 44982.550174498494, 45039.0, 45089.77455112736, 45218.54781452209, 3849.69202463805, 3860.7104467164795, 4040.7561602358355, 4152.1072969311745, 4297.39836422901, 33157.6684233157, 34002.82998585016, 34056.0, 34100.97697069067, 35208.64791352079, 4298.935515967263, 4419.315006174048, 4490.618297444721, 4509.594136527696, 4706.858794236178, 371410.0, 371534.0, 376033.0, 376601.0, 376645.0, 32215.51676724851, 32887.67112328846, 64998.0, 65341.673291634186, 65550.67224663847, 40013.39979900304, 40157.598424015385, 40185.598144018186, 40214.1957160861, 40232.396514052314, 16562.337506499847, 16765.077920714233, 16767.0, 16773.0, 16775.664486710197, 11982.460789264504, 13806.723865522634, 13893.930530347283, 13895.513657021957, 13903.721925561433, 8911.777205569782, 9231.769205769775, 9519.904800951901, 9525.28560357976, 9643.035696430441, 3610.711143108545, 3620.728445366608, 3635.5273814404486, 3636.818159092035, 3697.5008373869723, 1081.9513121909533, 1092.382803715898, 1099.6096385783092, 1101.7025403141267, 1195.2469943935266, 31381.52927706086, 33138.83430582831, 33390.49914251288, 33406.0, 33778.32443351119, 1135.7898788724112, 1156.450685924196, 1162.2096974057554, 1169.6841852699724, 1171.0, 14459.927700361432, 17289.394871179447, 17928.372506962456, 18363.35728249505, 18890.52773680669, 516089.0, 516182.0, 517484.0, 517972.0, 522513.0, 59726.0, 60013.39986600165, 60023.69988150118, 60128.0, 60159.09761353583, 1291.1542939374724, 1336.6658335416146, 1356.85752995936, 1417.4826188441145, 1445.2340259662396, 29623.407531849673, 34355.65644343525, 34672.65327346795, 34787.652123479456, 34802.82598586991, 52840.73579632231, 53411.46588534065, 53436.73281633567, 53523.19715204197, 53527.0, 367557.0, 368653.0, 369821.0, 370020.0, 370840.0, 26964.32589185286, 27679.861600692675, 29623.111306660834, 30852.0, 31395.686043139278, 47235.527644723115, 47976.7601161992, 48650.51349486601, 48693.269600955304, 49011.26483102685, 40749.38875916923, 40993.38509922294, 41402.585974141075, 41639.58360416357, 43123.56876431195, 40348.394774077824, 41456.25950934172, 42101.0, 42341.36487952745, 42438.0, 39379.80310098431, 41808.37287440752, 42582.14835703206, 42973.355399668406, 43022.56977430185, 35736.0, 37725.245495090494, 37809.243815122994, 38573.4213986796, 38766.8369948902, 28833.56749648799, 28874.0, 29021.0, 29124.27189320284, 29161.56257656179], "value": 19851.180634332097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.15968063872253, 429.95700429957003, 431.3981995116813, 431.69219477333746, 441.2146379444588, 18494.537636559093, 18761.812381876178, 20091.497712557193, 20193.19227230909, 20320.983950802438, 18947.62104757904, 19497.51256218592, 19563.315283965065, 19576.0, 19781.109850056746, 5739.225204597367, 5890.3226128995075, 5890.64656120632, 5905.822825315226, 5917.0, 5582.86042848928, 5693.402192769761, 5750.856228594298, 5804.071348584227, 5863.648181109126, 5732.22614946981, 5740.512056475204, 5743.597948143632, 5744.10966300222, 5744.597878148531, 5568.49883510484, 5733.996550603649, 5734.741936612862, 5738.713064346766, 5784.0167171580515, 5244.65909715871, 5251.789928402859, 5254.448282930313, 5255.710935898524, 5257.947420525784, 23126.76873231263, 23342.53314933692, 23393.53212935749, 23403.297901062826, 23428.297151085495, 2197.626403511407, 2469.77772000519, 2484.95030099397, 2532.7720505154625, 3041.1180757580273, 14306.713865722628, 14445.855541444556, 14524.273786310641, 14838.925805371013, 15227.771583426258, 1891.877027993176, 1939.8157175068345, 1953.8925359105244, 2017.465371676507, 2081.323569839793, 49874.50125498735, 63104.684476577786, 71891.64054179747, 78863.0, 79033.60483197604, 10942.562297508011, 11121.44299798029, 11287.097032237401, 11359.318440893572, 11410.372429516456, 16187.433439829549, 16191.514254572381, 16226.918865405598, 16234.75647865283, 16262.268197931122, 8478.194571515696, 8592.8711069334, 8642.444360015257, 8661.177188167114, 8886.51124188163, 8346.916530834735, 8383.790405239917, 8558.0, 8574.22831945128, 8637.568121593895, 6792.898106528406, 6844.589324640538, 6924.307569243036, 6934.306569343126, 6971.477139214478, 1936.1674479973465, 2033.6339458897542, 2052.2098991887933, 2059.4748339173416, 2094.4345026842666, 801.2508304735092, 926.092429419173, 971.844504879216, 980.2158273381409, 1073.1575713065206, 20134.29529966444, 20239.392818215478, 20309.89845050765, 20547.794522054886, 20670.483237919172, 1066.7493139112303, 1080.7514271717391, 1084.9132069434584, 1088.1240601316017, 1088.216484131424, 10837.18721095921, 11824.349660768568, 11842.230255033395, 11846.822297665542, 11889.821652675217, 440788.0, 458455.0, 463681.0, 467419.0, 467698.0, 79439.0, 79995.20004799994, 81292.18707812847, 82238.58880705558, 83248.0, 1037.2531777120462, 1078.2182917384832, 1100.0, 1104.320842681745, 1110.8722496912796, 15899.0, 16166.838331616533, 16208.270627821541, 16501.422450214184, 16546.917265413595, 38258.80870595629, 41618.0, 42143.15713685648, 42237.57762422459, 42558.5744142567, 53970.460295396544, 54524.0, 54761.72619136879, 62150.37849621446, 62814.6859265719, 8226.958865205635, 8336.916630833613, 8584.0, 8808.471491710518, 8910.55447227649, 6868.450523957971, 9907.950460247652, 11148.944255278997, 12274.202176858476, 12401.875981240433, 10173.796524069625, 10514.631987880388, 10602.522886469973, 10821.134309255398, 11135.721606959567, 10353.63762268317, 10665.680029599125, 10784.0, 10826.512806923865, 10909.509072091616, 10843.918116744813, 10947.616833410792, 10987.626546681664, 11056.170787190831, 11107.777844442904, 8294.502329860228, 8726.82546349082, 8767.956160219159, 8806.779830504289, 8900.554972251492, 8332.458390204618, 9768.755781105529, 10418.166546676097, 10500.94749526278, 10514.684559463229], "value": 9320.69262118907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.7501424757793, 1488.717143742689, 1642.367688439951, 1764.982350176498, 1796.9730454043192, 8014.078380986189, 8536.658533658654, 8537.573121343923, 8538.615762290705, 8551.0, 7259.056322678044, 7453.068366454193, 8061.395395345343, 8265.256126948574, 8332.875006874887, 2361.6339467382495, 2395.796357309631, 2399.148302352657, 2404.483036147228, 2407.3981504623844, 2392.3899405651537, 2418.697662792151, 2472.81453890958, 2478.9092799168398, 2481.2184161988916, 2411.8794060297005, 2416.6254230594286, 2445.7554244575576, 2447.3514518652573, 2447.8164137689746, 2345.1791872844537, 2363.515479326734, 2375.0381095656285, 2385.105585405473, 2388.2477019738812, 2319.3389883883015, 2332.0555175153922, 2344.742078371378, 2346.0381243690003, 2346.624540073597, 8397.244248017707, 8476.618552165106, 8478.957605211996, 8508.276796472308, 8563.186497282748, 5147.716875571842, 5278.9208161877605, 5279.102552566034, 5279.260903473479, 5282.7622756976025, 3290.9177270568425, 3305.140663427502, 3385.2552438463745, 3387.0516255448515, 3438.948415773765, 1099.384344766933, 1101.1796211822243, 1111.155521803427, 1136.9829452558217, 1150.0856818828968, 11584.18910676253, 11590.594329198437, 11689.883101168965, 11693.88306116945, 11697.415129243589, 4367.432233809648, 4467.664925130628, 4560.156371071363, 4583.0, 4618.284165954283, 9175.220106290906, 9248.0, 9262.305327100494, 9273.814523709623, 9276.0, 5271.156614941591, 5271.4728527147745, 5272.841814745564, 5279.234510995884, 5280.9471905281225, 4200.424840684743, 4239.40648309237, 4592.334111553806, 4623.42207224097, 4890.437599676083, 3813.599572044951, 3880.708946828999, 3904.2191561687778, 3954.268460334847, 3984.1234928315725, 1197.9820302695293, 1204.3556697167148, 1219.3293688471483, 1221.1635030004475, 1238.207547169812, 902.41794042842, 942.3215284994793, 944.9338546301693, 949.7957939043139, 969.185883857563, 5503.3395992481155, 5591.720413979285, 5690.601657883991, 5734.971325143431, 6039.396060394013, 475.25859658932177, 479.52526998272157, 482.582566080338, 484.2639188433561, 489.4493694593582, 3893.279743247508, 4015.8393664253686, 4016.5983401660183, 4057.107436363995, 4112.485939257593, 10073.445960472098, 10290.536925838205, 10354.11989980845, 10359.689209323733, 10377.636782712569, 10041.648542300984, 10317.0, 10324.483775811179, 10326.0, 10329.276950613536, 7832.569208693577, 8037.879431808527, 8041.075276343178, 8043.477173983672, 8043.6782528698195, 5527.778888844401, 5593.07714227148, 5593.860153496195, 5631.831045068655, 5738.626989245686, 9402.57688404037, 9500.667476638284, 9535.189508891823, 9547.093026162504, 9569.234461242944, 9038.141376569216, 9447.0, 9491.905080949102, 9577.664781732607, 9596.9040309596, 6717.832054198684, 6907.93092069093, 7384.150822655463, 7599.810004749926, 7747.6513556891205, 7946.086200087064, 8333.666653334041, 8334.12491688364, 8334.291585215324, 8345.290650294794, 7278.454115941219, 7399.260073992557, 7495.662695178621, 7547.245275472409, 7588.013558237614, 7251.347378735939, 7317.26827317264, 7416.0, 7420.6660700269695, 7620.1998790128455, 6807.489438292049, 6910.997905303602, 6914.412274956685, 6921.965390173017, 6926.44588432914, 5023.974880125576, 5074.289599456005, 5091.59267258611, 5092.923606145985, 5322.201669749568, 5094.770735316845, 5115.43213245538, 5161.380634323905, 5267.157254839208, 5285.656432331886], "value": 4447.241338915639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8944316704989, 354.8686985815249, 361.5679263280379, 364.3296334744069, 366.4082506751597, 5263.236830659552, 5263.736813159346, 5294.152935530321, 5305.575553955684, 5308.566686994514, 5167.224916262562, 5207.739613019344, 5231.163013917774, 5257.5005374489365, 5258.158694608864, 3954.782486963216, 4144.777290699251, 4165.812538435777, 4170.812313445902, 4223.711767910786, 4127.215828992482, 4134.586541345856, 4154.148399578079, 4157.376393540978, 4180.51924028736, 3927.56796752357, 4140.50313962325, 4141.840284720268, 4148.377743338493, 4151.709380343377, 4046.4941882264716, 4047.9797601011805, 4127.318992366256, 4147.854825081107, 4155.480564929384, 3687.723420743428, 3694.9445758313645, 3697.759645623026, 3701.6309561880416, 3709.7217708671956, 4919.2867034279825, 5120.436751957282, 5136.922946155773, 5149.794008239666, 5152.92270615941, 4399.340098985146, 4667.416572928384, 4704.388429504143, 4712.976435117803, 4718.4809670936165, 5417.729113544307, 5446.183072539151, 5447.0, 5449.3188351456065, 5454.836354909319, 3868.6324799144318, 4038.434619153321, 4041.5756345583877, 4044.0698639313123, 4049.7165198436123, 5651.547876169897, 5686.772529098873, 5689.800856970028, 5690.7439165237665, 5710.65736055838, 4128.896777580585, 4147.129102888367, 4148.688848336386, 4150.128473020639, 4154.2759754702065, 4135.953528612038, 4204.62158405745, 4216.177845320194, 4216.641585465209, 4221.852235171816, 4667.509911459248, 4692.7653617319, 4694.436667599842, 4722.338872557844, 4737.644676649265, 5501.779928802803, 5504.174373843955, 5522.834314970557, 5531.363893152258, 5538.16927460876, 1396.218117854005, 1404.3610157378369, 1409.2319685771279, 1409.7603407420763, 1416.7945647881, 946.3659348236698, 976.1556253840376, 977.5014742481386, 986.6941248213077, 989.1295659819313, 5036.84889453317, 5054.19132938728, 5060.6336289202445, 5080.644354895196, 5088.949110508847, 5376.784928602812, 5379.435159308295, 5385.946140538545, 5409.891802163935, 5430.484104010192, 5095.745212739423, 5101.362329708786, 5129.948700512947, 5267.815626453055, 5339.199120131933, 2809.2976755811046, 2846.573014047868, 2869.684334723179, 2888.653361596622, 2896.827379465401, 5429.701366424805, 5439.292891924025, 5463.043967305705, 5490.203920431515, 5508.944910550843, 5441.401445840955, 5562.443755624405, 5576.776928922797, 5733.799317023884, 5797.275340582427, 5732.3121225453215, 5732.369439361667, 5745.0, 5745.68398738065, 5754.0, 5528.391876893458, 5663.688497132697, 5683.8010669626365, 5698.857528561819, 5700.3444603871085, 5580.935054030035, 5581.158217788039, 5592.69240191777, 5597.748101335531, 5614.799564248503, 5686.630369026, 5698.800541981011, 5713.514351280188, 5718.428157184415, 5728.427157284238, 4079.408485769606, 4223.134257477148, 4229.703920725519, 4254.404383386266, 4282.143571285693, 5625.071863142699, 5625.549956003428, 5629.39562224764, 5636.070048441961, 5640.492355688008, 5502.724863756876, 5508.419527307282, 5511.751971161227, 5513.228148059195, 5530.364008139116, 5347.759350829144, 5445.53712934405, 5462.754176062007, 5473.507384335429, 5532.0, 5369.865753356041, 5435.565154787687, 5442.238086667949, 5448.645838020675, 5470.945290547043, 5505.587080969023, 5517.310336207974, 5531.529819965348, 5531.612787105025, 5548.0, 5204.583633309402, 5401.567874569946, 5424.349078110652, 5425.945740542544, 5446.0], "value": 4206.262495613511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.9549427034382, 767.0986590755864, 835.4068611285988, 841.8779277004835, 873.4104479476351, 13451.730965380699, 13459.79810302845, 15756.606084847885, 15790.526284211477, 15918.204089795521, 12788.104832661717, 13119.606411807637, 13132.0, 13243.801342979863, 13244.404001819918, 828.7886588919847, 842.0442797424936, 844.15162761425, 844.4089137603702, 845.3913182508614, 846.6613354658125, 849.3841964575695, 849.5030407211758, 849.6813694864426, 850.4939560961218, 884.7301573020226, 884.747846863644, 885.2165833237599, 885.6103314541581, 886.3751055505885, 873.8296032273678, 874.903760586335, 878.1832895407268, 879.3712495565669, 879.687710862641, 646.9902951455732, 650.339904996429, 651.3486513486514, 651.3844417025913, 651.6513665189149, 13249.801252981213, 13549.52576659822, 13600.183988960594, 14127.505537306248, 14301.856981430261, 11470.197086203969, 12109.333986630732, 12198.939005304917, 12562.560310389184, 12578.68553286166, 9828.606855725762, 10021.298509104365, 10023.949880250624, 10248.48757562119, 10436.582536698523, 3556.751027428081, 3584.211473475831, 3617.240379520304, 3670.926581468356, 3854.5181852268465, 37965.24069518622, 45286.77356613229, 57401.0, 58689.41310586925, 65575.34424655788, 10019.899801002042, 10102.39385636864, 10420.32267902584, 10506.684799456028, 10637.361758294372, 20863.687044694343, 21288.680669789966, 21301.041453134647, 21341.78658213429, 21351.14595416197, 7621.237876212334, 8024.836398722153, 8162.755117346489, 8167.305779008851, 8225.670973161006, 4188.455500784939, 4315.611594956469, 4356.302991521341, 4372.846950356722, 4419.535948725402, 3322.1860644141857, 3427.0746898337807, 3428.8628454861528, 3429.9314013719586, 3430.5540279763472, 585.6515373352848, 593.5044238061181, 601.4316470935012, 606.1211243696657, 610.7679081948831, 610.8503416662858, 625.1810128731377, 627.0688028278004, 630.196499463188, 631.9052142178618, 8509.489430634181, 8638.308935285162, 8659.523726194993, 8938.10618938101, 8965.117325361616, 549.8927709096688, 608.3764141754737, 660.4221306356937, 663.6482664187988, 671.53328436736, 3941.743786653916, 4035.414864844581, 4069.8168582413864, 4126.463559737215, 4130.0, 86872.0, 87385.56307218423, 89604.5519772397, 92520.0, 92969.5351523238, 51271.74364128155, 71382.64308678423, 78099.0, 82140.0, 83052.58473707593, 72079.63960180165, 73530.0, 73584.26415735774, 74664.0, 77304.61347693225, 7655.1962043986805, 7834.647440865061, 8123.268905798506, 8183.549904755296, 8261.215184557457, 51620.22569661383, 52004.0, 52133.47866521438, 53192.20211696905, 53986.73006634942, 67041.66479167574, 70071.64964175147, 70246.29753702397, 71665.64167179131, 71828.64085679538, 10670.786584268426, 11133.0, 11135.72160695989, 11221.214514983873, 11284.0, 12265.325407102695, 12281.631551053482, 12501.374931253218, 12771.93614031924, 13348.399322030338, 10286.228532859916, 10410.635627752992, 10584.100351470212, 10850.945745271223, 10951.123910087334, 11123.27698699582, 11167.776644467227, 11352.375619340684, 11559.537618495166, 11607.6517704469, 10848.67453976382, 11045.834312485158, 11277.097832173242, 11287.153463490435, 11530.481128349413, 8132.593370331578, 8297.543635100128, 8446.704365347183, 8466.0, 11352.716182095513, 10719.491386300748, 10752.946235268773, 10873.619423320146, 10904.78190436171, 11218.0], "value": 6831.53591786617, "unit": "score"}], "name": "dromaeo_css", "value": 7117.90352457477, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 117.0, 145.0, 133.0, 123.0, 119.0, 117.0, 144.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 160.0, 160.0, 160.0, 160.0, 159.0, 159.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 105.0, 76.0, 76.0, 74.0, 75.0, 100.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 82.0, 83.0, 83.0, 98.0, 83.0, 82.0, 107.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 51.0, 53.0, 51.0, 51.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 81.0, 77.0, 77.0, 75.0, 78.0, 80.0, 78.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 122.0, 121.0, 120.0, 121.0, 131.0, 133.0, 160.0, 122.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 155.0, 159.0, 158.0, 157.0, 162.0, 157.0, 157.0, 158.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 71.0, 63.0, 61.0, 65.0, 62.0, 63.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1450.6999999999998, "alertThreshold": 2.0}]} 17:48:00 INFO - Return code: 0 17:48:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:48:00 INFO - # TBPL SUCCESS # 17:48:00 INFO - Running post-action listener: _resource_record_post_action 17:48:00 INFO - [mozharness: 2017-02-24 01:48:00.286092Z] Finished run-tests step (success) 17:48:00 INFO - Running post-run listener: _resource_record_post_run 17:48:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333803520; Read time: 12; Write time: 165160 17:48:00 INFO - TinderboxPrint: CPU usage
12.9% 17:48:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:48:00 INFO - TinderboxPrint: I/O write bytes / time
333,803,520 / 165,160 17:48:00 INFO - TinderboxPrint: CPU idle
8,263.5 (87.0%) 17:48:00 INFO - TinderboxPrint: CPU user
1,185.4 (12.5%) 17:48:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:48:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 112398336; Read time: 0; Write time: 57692 17:48:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221405184; Read time: 12; Write time: 107468 17:48:00 INFO - Running post-run listener: _upload_blobber_files 17:48:00 INFO - Blob upload gear active. 17:48:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:00 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 17:48:00 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'] 17:48:00 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 17:48:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:02 INFO - (blobuploader) - INFO - Done attempting. 17:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:09 INFO - (blobuploader) - INFO - Done attempting. 17:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:48:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:10 INFO - (blobuploader) - INFO - Done attempting. 17:48:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:10 INFO - Return code: 0 17:48:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ad013b1b583c975540a81989b1c9d4cf0898dc3ebdbfa36b39b42ad0f51f0100ab39d99b07f970c3e3730184bb4794863b2c590f999eba1ac7c10afd0a013f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e40bd1550fbad50282b01542e4d8e0cdfd649bc46945f05afa9c46dc63b3c53d6d781530fd300d7f0970bc8da965ede650678987d1c4d27baf7b03ebcd41329", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01071077668c7bdf85c913111534d11538eac026f892aa54b3497d0c780b3b5c2b8170dfe6f8654606a5f3b3d67f4d0c97db4aefb5736272ab4bfac3e122c890"} 17:48:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:10 INFO - Contents: 17:48:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ad013b1b583c975540a81989b1c9d4cf0898dc3ebdbfa36b39b42ad0f51f0100ab39d99b07f970c3e3730184bb4794863b2c590f999eba1ac7c10afd0a013f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e40bd1550fbad50282b01542e4d8e0cdfd649bc46945f05afa9c46dc63b3c53d6d781530fd300d7f0970bc8da965ede650678987d1c4d27baf7b03ebcd41329", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01071077668c7bdf85c913111534d11538eac026f892aa54b3497d0c780b3b5c2b8170dfe6f8654606a5f3b3d67f4d0c97db4aefb5736272ab4bfac3e122c890"} 17:48:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:10 INFO - Copying logs to upload dir... 17:48:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.834321 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-23 17:48:09.721106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 17:48:09.724767) ========= 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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 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/7ad013b1b583c975540a81989b1c9d4cf0898dc3ebdbfa36b39b42ad0f51f0100ab39d99b07f970c3e3730184bb4794863b2c590f999eba1ac7c10afd0a013f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e40bd1550fbad50282b01542e4d8e0cdfd649bc46945f05afa9c46dc63b3c53d6d781530fd300d7f0970bc8da965ede650678987d1c4d27baf7b03ebcd41329", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01071077668c7bdf85c913111534d11538eac026f892aa54b3497d0c780b3b5c2b8170dfe6f8654606a5f3b3d67f4d0c97db4aefb5736272ab4bfac3e122c890"} build_url:https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/USOt3uJJT92qzz9D7nr8Yw/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/7ad013b1b583c975540a81989b1c9d4cf0898dc3ebdbfa36b39b42ad0f51f0100ab39d99b07f970c3e3730184bb4794863b2c590f999eba1ac7c10afd0a013f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e40bd1550fbad50282b01542e4d8e0cdfd649bc46945f05afa9c46dc63b3c53d6d781530fd300d7f0970bc8da965ede650678987d1c4d27baf7b03ebcd41329", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01071077668c7bdf85c913111534d11538eac026f892aa54b3497d0c780b3b5c2b8170dfe6f8654606a5f3b3d67f4d0c97db4aefb5736272ab4bfac3e122c890"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 17:48:09.749428) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:48:09.749752) ========= 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=a0d2d2de893abaa8702a9954000001a7-1487899597.72796-752579333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 17:48:09.832488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 17:48:09.832837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 17:48:09.833165) ========= ========= Total master_lag: 0.17 =========