builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1486409096.55 results: success (0) buildid: 20170206093855 builduid: 23fb7832be29419781f8e14833bb9a68 revision: c48c37867d35fb2ffc8457834e12192a799d020c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.555099) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.555563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.555858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.572991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.573361) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 11:24:57-- 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% 54.5M=0s 2017-02-06 11:24:57 (54.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.672631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.672943) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:56.722764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:24:56.723138) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c48c37867d35fb2ffc8457834e12192a799d020c --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 c48c37867d35fb2ffc8457834e12192a799d020c --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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 11:24:57,725 truncating revision to first 12 chars 2017-02-06 11:24:57,726 Setting DEBUG logging. 2017-02-06 11:24:57,726 attempt 1/10 2017-02-06 11:24:57,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c48c37867d35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 11:24:58,560 unpacking tar archive at: mozilla-beta-c48c37867d35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 11:24:57.841848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:57.842196) ========= script_repo_revision: c48c37867d35fb2ffc8457834e12192a799d020c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:57.842583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:57.842847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 11:24:57.852837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 11:24:57.853161) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:58 INFO - MultiFileLogger online at 20170206 11:24:58 in /builds/slave/test 11:24:58 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 11:24:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:58 INFO - {'append_to_log': False, 11:24:58 INFO - 'base_work_dir': '/builds/slave/test', 11:24:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:58 INFO - 'branch': 'Mozilla-Beta', 11:24:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:58 INFO - 'config_files': ('talos/linux_config.py',), 11:24:58 INFO - 'default_actions': ('clobber', 11:24:58 INFO - 'read-buildbot-config', 11:24:58 INFO - 'download-and-extract', 11:24:58 INFO - 'populate-webroot', 11:24:58 INFO - 'create-virtualenv', 11:24:58 INFO - 'install', 11:24:58 INFO - 'run-tests'), 11:24:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:58 INFO - 'download_minidump_stackwalk': True, 11:24:58 INFO - 'download_symbols': 'ondemand', 11:24:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:58 INFO - 'installer_path': 'installer.exe', 11:24:58 INFO - 'log_level': 'info', 11:24:58 INFO - 'log_name': 'talos', 11:24:58 INFO - 'log_to_console': True, 11:24:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:58 INFO - 'opt_config_files': (), 11:24:58 INFO - 'pip_index': False, 11:24:58 INFO - 'sps_profile': False, 11:24:58 INFO - 'sps_profile_interval': 0, 11:24:58 INFO - 'suite': 'dromaeojs', 11:24:58 INFO - 'system_bits': '32', 11:24:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:58 INFO - 'title': 'talos-linux64-ix-061', 11:24:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:58 INFO - 'use_talos_json': True, 11:24:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:58 INFO - 'work_dir': 'build'} 11:24:58 INFO - [mozharness: 2017-02-06 19:24:58.954514Z] Running clobber step. 11:24:58 INFO - Running pre-action listener: _resource_record_pre_action 11:24:58 INFO - Running main action method: clobber 11:24:58 INFO - rmtree: /builds/slave/test/build 11:24:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:59 INFO - Running post-action listener: _resource_record_post_action 11:24:59 INFO - [mozharness: 2017-02-06 19:24:59.414310Z] Finished clobber step (success) 11:24:59 INFO - [mozharness: 2017-02-06 19:24:59.414410Z] Running read-buildbot-config step. 11:24:59 INFO - Running pre-action listener: _resource_record_pre_action 11:24:59 INFO - Running main action method: read_buildbot_config 11:24:59 INFO - Using buildbot properties: 11:24:59 INFO - { 11:24:59 INFO - "project": "", 11:24:59 INFO - "product": "firefox", 11:24:59 INFO - "script_repo_revision": "production", 11:24:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:24:59 INFO - "repository": "", 11:24:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:24:59 INFO - "buildid": "20170206093855", 11:24:59 INFO - "pgo_build": "True", 11:24:59 INFO - "basedir": "/builds/slave/test", 11:24:59 INFO - "buildnumber": 130, 11:24:59 INFO - "slavename": "talos-linux64-ix-061", 11:24:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:24:59 INFO - "platform": "ubuntu64_hw", 11:24:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:59 INFO - "branch": "mozilla-beta", 11:24:59 INFO - "repo_path": "releases/mozilla-beta", 11:24:59 INFO - "revision": "c48c37867d35fb2ffc8457834e12192a799d020c", 11:24:59 INFO - "stage_platform": "linux64-pgo", 11:24:59 INFO - "builduid": "23fb7832be29419781f8e14833bb9a68", 11:24:59 INFO - "slavebuilddir": "test" 11:24:59 INFO - } 11:24:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 11:24:59 INFO - Running post-action listener: _resource_record_post_action 11:24:59 INFO - [mozharness: 2017-02-06 19:24:59.417150Z] Finished read-buildbot-config step (success) 11:24:59 INFO - [mozharness: 2017-02-06 19:24:59.417238Z] Running download-and-extract step. 11:24:59 INFO - Running pre-action listener: _resource_record_pre_action 11:24:59 INFO - Running main action method: download_and_extract 11:24:59 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:59 INFO - trying https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:24:59 INFO - Downloading https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/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 11:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/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 11:25:00 INFO - Downloaded 1327 bytes. 11:25:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:25:00 INFO - Using the following test package requirements: 11:25:00 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:25:00 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:25:00 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 11:25:00 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'jsshell-linux-x86_64.zip'], 11:25:00 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:25:00 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:25:00 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 11:25:00 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 11:25:00 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:25:00 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:25:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:25:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:25:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:25:00 INFO - Fetch https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:25:00 INFO - Http code: 200 11:25:00 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 11:25:00 INFO - x-amz-cf-id: Q19zNIHqUKETI7wmlg-jC61YE6xd5jqTrarB6x8D9RnVa-3rsTcoPg== 11:25:00 INFO - x-amz-version-id: C9KUfoCXlGVe_TL3oEuZwTmWeohtiEai 11:25:00 INFO - Expected file size: 21956231 11:25:00 INFO - Obtained file size: 21956231 11:25:04 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 11:25:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:25:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:25:04 INFO - Fetch https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:25:05 INFO - Http code: 200 11:25:05 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 11:25:05 INFO - x-amz-cf-id: 5JGqupzzIocifuKZU0UpULio_VBzj_ODUHv0b2YkpPvxhGY7fFKm_w== 11:25:05 INFO - x-amz-version-id: C9KUfoCXlGVe_TL3oEuZwTmWeohtiEai 11:25:05 INFO - Expected file size: 21956231 11:25:05 INFO - Obtained file size: 21956231 11:25:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 11:25:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:25:09 INFO - Fetch https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 11:25:10 INFO - Http code: 200 11:25:10 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:25:10 INFO - x-amz-cf-id: Jr8VmKRMYCVGoYw6Qc1bu7pKtvpyfDE86sUjqmvlwopc2orFbWcPUg== 11:25:10 INFO - x-amz-version-id: lGJp6Xaf3MLt8QFjG21F1I4FzLEEUBqQ 11:25:10 INFO - Expected file size: 14403005 11:25:10 INFO - Obtained file size: 14403005 11:25: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')]} 11:25:10 INFO - trying https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:25:10 INFO - Downloading https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/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 11:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/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 11:25:12 INFO - Downloaded 57703834 bytes. 11:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:25:12 INFO - mkdir: /builds/slave/test/properties 11:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:12 INFO - Contents: 11:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:25:12 INFO - Running post-action listener: _resource_record_post_action 11:25:12 INFO - Running post-action listener: set_extra_try_arguments 11:25:12 INFO - [mozharness: 2017-02-06 19:25:12.765200Z] Finished download-and-extract step (success) 11:25:12 INFO - [mozharness: 2017-02-06 19:25:12.765427Z] Running populate-webroot step. 11:25:12 INFO - Running pre-action listener: _resource_record_pre_action 11:25:12 INFO - Running main action method: populate_webroot 11:25:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:12 INFO - '--tppagecycles', 11:25:12 INFO - '7'], 11:25:12 INFO - 'tests': ['tsvgm']}}, 11:25:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['damp', 'tps']}, 11:25:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'tests': ['damp', 'tps']}, 11:25:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['dromaeo_dom']}, 11:25:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['basic_compositor_video']}, 11:25:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:25:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['a11yr', 11:25:12 INFO - 'ts_paint', 11:25:12 INFO - 'tpaint', 11:25:12 INFO - 'sessionrestore', 11:25:12 INFO - 'sessionrestore_no_auto_restore', 11:25:12 INFO - 'tabpaint']}, 11:25:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['tsvgx', 11:25:12 INFO - 'tsvgr_opacity', 11:25:12 INFO - 'tart', 11:25:12 INFO - 'tscrollx', 11:25:12 INFO - 'cart']}, 11:25:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:12 INFO - 'tsvgr_opacity', 11:25:12 INFO - 'tart', 11:25:12 INFO - 'tscrollx', 11:25:12 INFO - 'cart']}, 11:25:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'talos_options': ['--disable-e10s'], 11:25:12 INFO - 'tests': ['tp5o']}, 11:25:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'tests': ['tp5o']}, 11:25:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'talos_options': ['--disable-e10s', 11:25:12 INFO - '--xperf_path', 11:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:12 INFO - 'tests': ['tp5n']}, 11:25:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:12 INFO - 'talos_options': ['--xperf_path', 11:25:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:12 INFO - 'tests': ['tp5n']}}, 11:25:12 INFO - 'talos.zip': {'path': '', 11:25:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:12 INFO - Running post-action listener: _resource_record_post_action 11:25:12 INFO - [mozharness: 2017-02-06 19:25:12.784589Z] Finished populate-webroot step (success) 11:25:12 INFO - [mozharness: 2017-02-06 19:25:12.784676Z] Running create-virtualenv step. 11:25:12 INFO - Running pre-action listener: _resource_record_pre_action 11:25:12 INFO - Running main action method: create_virtualenv 11:25:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:12 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 11:25:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:12 INFO - Using real prefix '/usr' 11:25:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:15 INFO - Installing pip.................done. 11:25:15 INFO - Return code: 0 11:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:25:15 INFO - Reading from file tmpfile_stdout 11:25:15 INFO - Output received: 11:25:15 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) 11:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:15 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')]} 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:15 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')]} 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:15 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:15 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 11:25:15 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 11:25:15 INFO - Using env: {'DISPLAY': ':0', 11:25:15 INFO - 'HOME': '/home/cltbld', 11:25:15 INFO - 'LANG': 'en_US.UTF-8', 11:25:15 INFO - 'LANGUAGE': 'en_US:en', 11:25:15 INFO - 'LOGNAME': 'cltbld', 11:25:15 INFO - 'MAIL': '/var/mail/cltbld', 11:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:15 INFO - 'MOZ_NO_REMOTE': '1', 11:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:15 INFO - 'NO_EM_RESTART': '1', 11:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:15 INFO - 'PWD': '/builds/slave/test', 11:25:15 INFO - 'SHELL': '/bin/bash', 11:25:15 INFO - 'SHLVL': '1', 11:25:15 INFO - 'TERM': 'linux', 11:25:15 INFO - 'TMOUT': '86400', 11:25:15 INFO - 'USER': 'cltbld', 11:25:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:15 INFO - '_': '/tools/buildbot/bin/python'} 11:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:15 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 11:25:15 INFO - Cleaning up... 11:25:15 INFO - Return code: 0 11:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:15 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')]} 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:15 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')]} 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:15 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:15 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 11:25:15 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 11:25:15 INFO - Using env: {'DISPLAY': ':0', 11:25:15 INFO - 'HOME': '/home/cltbld', 11:25:15 INFO - 'LANG': 'en_US.UTF-8', 11:25:15 INFO - 'LANGUAGE': 'en_US:en', 11:25:15 INFO - 'LOGNAME': 'cltbld', 11:25:15 INFO - 'MAIL': '/var/mail/cltbld', 11:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:15 INFO - 'MOZ_NO_REMOTE': '1', 11:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:15 INFO - 'NO_EM_RESTART': '1', 11:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:15 INFO - 'PWD': '/builds/slave/test', 11:25:15 INFO - 'SHELL': '/bin/bash', 11:25:15 INFO - 'SHLVL': '1', 11:25:15 INFO - 'TERM': 'linux', 11:25:15 INFO - 'TMOUT': '86400', 11:25:15 INFO - 'USER': 'cltbld', 11:25:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:15 INFO - '_': '/tools/buildbot/bin/python'} 11:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:16 INFO - Downloading/unpacking psutil>=3.1.1 11:25:16 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 11:25:16 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 11:25:16 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 11:25:16 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 11:25:16 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 11:25:16 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 11:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:18 INFO - Installing collected packages: psutil 11:25:18 INFO - Running setup.py install for psutil 11:25:18 INFO - building 'psutil._psutil_linux' extension 11:25:18 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 11:25:18 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 11:25:18 INFO - building 'psutil._psutil_posix' extension 11:25:18 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 11:25:18 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 11:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:18 INFO - Successfully installed psutil 11:25:18 INFO - Cleaning up... 11:25:18 INFO - Return code: 0 11:25:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:18 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')]} 11:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:18 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')]} 11:25:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:18 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:18 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 11:25:18 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 11:25:18 INFO - Using env: {'DISPLAY': ':0', 11:25:18 INFO - 'HOME': '/home/cltbld', 11:25:18 INFO - 'LANG': 'en_US.UTF-8', 11:25:18 INFO - 'LANGUAGE': 'en_US:en', 11:25:18 INFO - 'LOGNAME': 'cltbld', 11:25:18 INFO - 'MAIL': '/var/mail/cltbld', 11:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:18 INFO - 'MOZ_NO_REMOTE': '1', 11:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:18 INFO - 'NO_EM_RESTART': '1', 11:25:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:18 INFO - 'PWD': '/builds/slave/test', 11:25:18 INFO - 'SHELL': '/bin/bash', 11:25:18 INFO - 'SHLVL': '1', 11:25:18 INFO - 'TERM': 'linux', 11:25:18 INFO - 'TMOUT': '86400', 11:25:18 INFO - 'USER': 'cltbld', 11:25:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:18 INFO - '_': '/tools/buildbot/bin/python'} 11:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:18 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 11:25:18 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 11:25:18 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 11:25:18 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 11:25:18 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 11:25:18 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 11:25:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:20 INFO - Installing collected packages: mozsystemmonitor 11:25:20 INFO - Running setup.py install for mozsystemmonitor 11:25:21 INFO - Successfully installed mozsystemmonitor 11:25:21 INFO - Cleaning up... 11:25:21 INFO - Return code: 0 11:25:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:21 INFO - Using env: {'DISPLAY': ':0', 11:25:21 INFO - 'HOME': '/home/cltbld', 11:25:21 INFO - 'LANG': 'en_US.UTF-8', 11:25:21 INFO - 'LANGUAGE': 'en_US:en', 11:25:21 INFO - 'LOGNAME': 'cltbld', 11:25:21 INFO - 'MAIL': '/var/mail/cltbld', 11:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:21 INFO - 'MOZ_NO_REMOTE': '1', 11:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:21 INFO - 'NO_EM_RESTART': '1', 11:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:21 INFO - 'PWD': '/builds/slave/test', 11:25:21 INFO - 'SHELL': '/bin/bash', 11:25:21 INFO - 'SHLVL': '1', 11:25:21 INFO - 'TERM': 'linux', 11:25:21 INFO - 'TMOUT': '86400', 11:25:21 INFO - 'USER': 'cltbld', 11:25:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:21 INFO - '_': '/tools/buildbot/bin/python'} 11:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:21 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:21 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 11:25:21 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 11:25:21 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 11:25:21 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 11:25:21 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 11:25:21 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 11:25:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:23 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 11:25:23 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 11:25:23 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 11:25:23 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 11:25:23 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 11:25:23 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 11:25:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:23 INFO - warning: no files found matching '*.txt' 11:25:23 INFO - no previously-included directories found matching 'build' 11:25:23 INFO - no previously-included directories found matching 'dist' 11:25:23 INFO - no previously-included directories found matching '.git*' 11:25:23 INFO - Installing collected packages: jsonschema, functools32 11:25:23 INFO - Running setup.py install for functools32 11:25:23 INFO - warning: no files found matching '*.txt' 11:25:23 INFO - no previously-included directories found matching 'build' 11:25:23 INFO - no previously-included directories found matching 'dist' 11:25:23 INFO - no previously-included directories found matching '.git*' 11:25:23 INFO - Successfully installed jsonschema functools32 11:25:23 INFO - Cleaning up... 11:25:23 INFO - Return code: 0 11:25:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:23 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:23 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 11:25:23 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 11:25:23 INFO - Using env: {'DISPLAY': ':0', 11:25:23 INFO - 'HOME': '/home/cltbld', 11:25:23 INFO - 'LANG': 'en_US.UTF-8', 11:25:23 INFO - 'LANGUAGE': 'en_US:en', 11:25:23 INFO - 'LOGNAME': 'cltbld', 11:25:23 INFO - 'MAIL': '/var/mail/cltbld', 11:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:23 INFO - 'MOZ_NO_REMOTE': '1', 11:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:23 INFO - 'NO_EM_RESTART': '1', 11:25:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:23 INFO - 'PWD': '/builds/slave/test', 11:25:23 INFO - 'SHELL': '/bin/bash', 11:25:23 INFO - 'SHLVL': '1', 11:25:23 INFO - 'TERM': 'linux', 11:25:23 INFO - 'TMOUT': '86400', 11:25:23 INFO - 'USER': 'cltbld', 11:25:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:23 INFO - '_': '/tools/buildbot/bin/python'} 11:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:24 INFO - Cleaning up... 11:25:24 INFO - Return code: 0 11:25:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:24 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')]} 11:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:24 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')]} 11:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:24 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:24 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 11:25:24 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 11:25:24 INFO - Using env: {'DISPLAY': ':0', 11:25:24 INFO - 'HOME': '/home/cltbld', 11:25:24 INFO - 'LANG': 'en_US.UTF-8', 11:25:24 INFO - 'LANGUAGE': 'en_US:en', 11:25:24 INFO - 'LOGNAME': 'cltbld', 11:25:24 INFO - 'MAIL': '/var/mail/cltbld', 11:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:24 INFO - 'MOZ_NO_REMOTE': '1', 11:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:24 INFO - 'NO_EM_RESTART': '1', 11:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:24 INFO - 'PWD': '/builds/slave/test', 11:25:24 INFO - 'SHELL': '/bin/bash', 11:25:24 INFO - 'SHLVL': '1', 11:25:24 INFO - 'TERM': 'linux', 11:25:24 INFO - 'TMOUT': '86400', 11:25:24 INFO - 'USER': 'cltbld', 11:25:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:24 INFO - '_': '/tools/buildbot/bin/python'} 11:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:24 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 11:25:24 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 11:25:24 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 11:25:24 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 11:25:24 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 11:25:24 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 11:25:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:26 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 11:25:27 INFO - Downloading docopt-0.6.1.tar.gz 11:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:27 INFO - Running setup.py install for blobuploader 11:25:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:27 INFO - Running setup.py install for requests 11:25:27 INFO - Running setup.py install for docopt 11:25:27 INFO - Successfully installed blobuploader requests docopt 11:25:27 INFO - Cleaning up... 11:25:27 INFO - Return code: 0 11:25:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:27 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:27 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 11:25:27 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 11:25:27 INFO - Using env: {'DISPLAY': ':0', 11:25:27 INFO - 'HOME': '/home/cltbld', 11:25:27 INFO - 'LANG': 'en_US.UTF-8', 11:25:27 INFO - 'LANGUAGE': 'en_US:en', 11:25:27 INFO - 'LOGNAME': 'cltbld', 11:25:27 INFO - 'MAIL': '/var/mail/cltbld', 11:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:27 INFO - 'MOZ_NO_REMOTE': '1', 11:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:27 INFO - 'NO_EM_RESTART': '1', 11:25:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:27 INFO - 'PWD': '/builds/slave/test', 11:25:27 INFO - 'SHELL': '/bin/bash', 11:25:27 INFO - 'SHLVL': '1', 11:25:27 INFO - 'TERM': 'linux', 11:25:27 INFO - 'TMOUT': '86400', 11:25:27 INFO - 'USER': 'cltbld', 11:25:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:27 INFO - '_': '/tools/buildbot/bin/python'} 11:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:27 INFO - Running setup.py (path:/tmp/pip-GEy9NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:27 INFO - Running setup.py (path:/tmp/pip-nATEsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:28 INFO - Running setup.py (path:/tmp/pip-n4_s44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:28 INFO - Running setup.py (path:/tmp/pip-JZOTYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:28 INFO - Running setup.py (path:/tmp/pip-bv8RB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:28 INFO - Running setup.py (path:/tmp/pip-o7Ed9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:28 INFO - Running setup.py (path:/tmp/pip-2_jjdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:28 INFO - Running setup.py (path:/tmp/pip-tedll7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:28 INFO - Running setup.py (path:/tmp/pip-sZM054-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:28 INFO - Running setup.py (path:/tmp/pip-uwYWEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:28 INFO - Running setup.py (path:/tmp/pip-pa5Jdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:28 INFO - Running setup.py (path:/tmp/pip-RNbCCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:28 INFO - Running setup.py (path:/tmp/pip-P9W7IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:28 INFO - Running setup.py (path:/tmp/pip-3cVwFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:28 INFO - Running setup.py (path:/tmp/pip-7TBKm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:29 INFO - Running setup.py (path:/tmp/pip-IgaOG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:29 INFO - Running setup.py (path:/tmp/pip-42hyKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:29 INFO - Running setup.py install for manifestparser 11:25:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Running setup.py install for mozcrash 11:25:29 INFO - Running setup.py install for mozdebug 11:25:29 INFO - Running setup.py install for mozdevice 11:25:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Running setup.py install for mozfile 11:25:29 INFO - Running setup.py install for mozhttpd 11:25:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Running setup.py install for mozinfo 11:25:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Running setup.py install for mozInstall 11:25:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:29 INFO - Running setup.py install for mozleak 11:25:30 INFO - Running setup.py install for mozlog 11:25:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Running setup.py install for moznetwork 11:25:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Running setup.py install for mozprocess 11:25:30 INFO - Running setup.py install for mozprofile 11:25:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Running setup.py install for mozrunner 11:25:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Running setup.py install for mozscreenshot 11:25:30 INFO - Running setup.py install for moztest 11:25:30 INFO - Running setup.py install for mozversion 11:25:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:30 INFO - Cleaning up... 11:25:30 INFO - Return code: 0 11:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:30 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:30 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 11:25:30 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 11:25:30 INFO - Using env: {'DISPLAY': ':0', 11:25:30 INFO - 'HOME': '/home/cltbld', 11:25:30 INFO - 'LANG': 'en_US.UTF-8', 11:25:30 INFO - 'LANGUAGE': 'en_US:en', 11:25:30 INFO - 'LOGNAME': 'cltbld', 11:25:30 INFO - 'MAIL': '/var/mail/cltbld', 11:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:30 INFO - 'MOZ_NO_REMOTE': '1', 11:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:30 INFO - 'NO_EM_RESTART': '1', 11:25:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:30 INFO - 'PWD': '/builds/slave/test', 11:25:30 INFO - 'SHELL': '/bin/bash', 11:25:30 INFO - 'SHLVL': '1', 11:25:30 INFO - 'TERM': 'linux', 11:25:30 INFO - 'TMOUT': '86400', 11:25:30 INFO - 'USER': 'cltbld', 11:25:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:30 INFO - '_': '/tools/buildbot/bin/python'} 11:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:31 INFO - Running setup.py (path:/tmp/pip-shLsSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:31 INFO - Running setup.py (path:/tmp/pip-LYjMaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:31 INFO - Running setup.py (path:/tmp/pip-Kh0iTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:31 INFO - Running setup.py (path:/tmp/pip-rOeSNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:31 INFO - Running setup.py (path:/tmp/pip-bENjry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:31 INFO - Running setup.py (path:/tmp/pip-ch7i9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:31 INFO - Running setup.py (path:/tmp/pip-bnGYai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:31 INFO - Running setup.py (path:/tmp/pip-M_ez2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:31 INFO - Running setup.py (path:/tmp/pip-8pW90u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:31 INFO - Running setup.py (path:/tmp/pip-iZGdjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:31 INFO - Running setup.py (path:/tmp/pip-GqlUVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:31 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)) 11:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:31 INFO - Running setup.py (path:/tmp/pip-NN37p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:32 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)) 11:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:32 INFO - Running setup.py (path:/tmp/pip-r85tyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:32 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)) 11:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:32 INFO - Running setup.py (path:/tmp/pip-5S_cQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:32 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)) 11:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:32 INFO - Running setup.py (path:/tmp/pip-FEetBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:32 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)) 11:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:32 INFO - Running setup.py (path:/tmp/pip-xDltYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:32 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)) 11:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:32 INFO - Running setup.py (path:/tmp/pip-uWzU3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:34 INFO - Downloading blessings-1.6.tar.gz 11:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:34 INFO - Installing collected packages: blessings 11:25:34 INFO - Running setup.py install for blessings 11:25:34 INFO - Successfully installed blessings 11:25:34 INFO - Cleaning up... 11:25:34 INFO - Return code: 0 11:25:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:34 INFO - Reading from file tmpfile_stdout 11:25:34 INFO - Current package versions: 11:25:34 INFO - argparse == 1.2.1 11:25:34 INFO - blessings == 1.6 11:25:34 INFO - blobuploader == 1.2.4 11:25:34 INFO - docopt == 0.6.1 11:25:34 INFO - functools32 == 3.2.3-2 11:25:34 INFO - jsonschema == 2.5.1 11:25:34 INFO - manifestparser == 1.1 11:25:34 INFO - mozInstall == 1.12 11:25:34 INFO - mozcrash == 1.0 11:25:34 INFO - mozdebug == 0.1 11:25:34 INFO - mozdevice == 0.48 11:25:34 INFO - mozfile == 1.2 11:25:34 INFO - mozhttpd == 0.7 11:25:34 INFO - mozinfo == 0.9 11:25:34 INFO - mozleak == 0.1 11:25:34 INFO - mozlog == 3.4 11:25:34 INFO - moznetwork == 0.27 11:25:34 INFO - mozprocess == 0.23 11:25:34 INFO - mozprofile == 0.28 11:25:34 INFO - mozrunner == 6.13 11:25:34 INFO - mozscreenshot == 0.1 11:25:34 INFO - mozsystemmonitor == 0.3 11:25:34 INFO - moztest == 0.8 11:25:34 INFO - mozversion == 1.4 11:25:34 INFO - psutil == 3.1.1 11:25:34 INFO - requests == 1.2.3 11:25:34 INFO - wsgiref == 0.1.2 11:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:34 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:34 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 11:25:34 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 11:25:34 INFO - Using env: {'DISPLAY': ':0', 11:25:34 INFO - 'HOME': '/home/cltbld', 11:25:34 INFO - 'LANG': 'en_US.UTF-8', 11:25:34 INFO - 'LANGUAGE': 'en_US:en', 11:25:34 INFO - 'LOGNAME': 'cltbld', 11:25:34 INFO - 'MAIL': '/var/mail/cltbld', 11:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:34 INFO - 'MOZ_NO_REMOTE': '1', 11:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:34 INFO - 'NO_EM_RESTART': '1', 11:25:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:34 INFO - 'PWD': '/builds/slave/test', 11:25:34 INFO - 'SHELL': '/bin/bash', 11:25:34 INFO - 'SHLVL': '1', 11:25:34 INFO - 'TERM': 'linux', 11:25:34 INFO - 'TMOUT': '86400', 11:25:34 INFO - 'USER': 'cltbld', 11:25:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:34 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 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)) 11:25:35 INFO - Cleaning up... 11:25:35 INFO - Return code: 0 11:25:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:35 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')]} 11:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:35 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')]} 11:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:35 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 0x7f4ff40dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', '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 11:25:35 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 11:25:35 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 11:25:35 INFO - Using env: {'DISPLAY': ':0', 11:25:35 INFO - 'HOME': '/home/cltbld', 11:25:35 INFO - 'LANG': 'en_US.UTF-8', 11:25:35 INFO - 'LANGUAGE': 'en_US:en', 11:25:35 INFO - 'LOGNAME': 'cltbld', 11:25:35 INFO - 'MAIL': '/var/mail/cltbld', 11:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:35 INFO - 'MOZ_NO_REMOTE': '1', 11:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:35 INFO - 'NO_EM_RESTART': '1', 11:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:35 INFO - 'PWD': '/builds/slave/test', 11:25:35 INFO - 'SHELL': '/bin/bash', 11:25:35 INFO - 'SHLVL': '1', 11:25:35 INFO - 'TERM': 'linux', 11:25:35 INFO - 'TMOUT': '86400', 11:25:35 INFO - 'USER': 'cltbld', 11:25:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:35 INFO - '_': '/tools/buildbot/bin/python'} 11:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:35 INFO - Cleaning up... 11:25:35 INFO - Return code: 0 11:25:35 INFO - Running post-action listener: _resource_record_post_action 11:25:35 INFO - Running post-action listener: _start_resource_monitoring 11:25:35 INFO - Starting resource monitoring. 11:25:35 INFO - [mozharness: 2017-02-06 19:25:35.398153Z] Finished create-virtualenv step (success) 11:25:35 INFO - [mozharness: 2017-02-06 19:25:35.398611Z] Running install step. 11:25:35 INFO - Running pre-action listener: _resource_record_pre_action 11:25:35 INFO - Running main action method: install 11:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:35 INFO - Reading from file tmpfile_stdout 11:25:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:35 INFO - Reading from file tmpfile_stdout 11:25:35 INFO - Output received: 11:25:35 INFO - Usage: mozinstall [options] installer 11:25:35 INFO - Options: 11:25:35 INFO - -h, --help show this help message and exit 11:25:35 INFO - -d DEST, --destination=DEST 11:25:35 INFO - Directory to install application into. [default: 11:25:35 INFO - "/builds/slave/test"] 11:25:35 INFO - --app=APP Application being installed. [default: firefox] 11:25:35 INFO - mkdir: /builds/slave/test/build/application 11:25:35 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'] 11:25:35 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 11:25:49 INFO - Reading from file tmpfile_stdout 11:25:49 INFO - Output received: 11:25:49 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:49 INFO - Running post-action listener: _resource_record_post_action 11:25:49 INFO - [mozharness: 2017-02-06 19:25:49.342428Z] Finished install step (success) 11:25:49 INFO - [mozharness: 2017-02-06 19:25:49.342670Z] Running run-tests step. 11:25:49 INFO - Running pre-action listener: _resource_record_pre_action 11:25:49 INFO - Running main action method: run_tests 11:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:49 INFO - Python 2.7.3 11:25:49 INFO - Return code: 0 11:25:49 INFO - grabbing minidump binary from tooltool 11:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:49 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 0x11f2f60>, '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 0x11f3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:49 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 11:25:49 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 11:25:49 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 11:25:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:49 INFO - Return code: 0 11:25:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:49 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/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:25:49 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/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 11:25:49 INFO - Using env: {'DISPLAY': ':0', 11:25:49 INFO - 'HOME': '/home/cltbld', 11:25:49 INFO - 'LANG': 'en_US.UTF-8', 11:25:49 INFO - 'LANGUAGE': 'en_US:en', 11:25:49 INFO - 'LOGNAME': 'cltbld', 11:25:49 INFO - 'MAIL': '/var/mail/cltbld', 11:25:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:49 INFO - 'MOZ_NO_REMOTE': '1', 11:25:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:49 INFO - 'NO_EM_RESTART': '1', 11:25:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:49 INFO - 'PWD': '/builds/slave/test', 11:25:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:49 INFO - 'SHELL': '/bin/bash', 11:25:49 INFO - 'SHLVL': '1', 11:25:49 INFO - 'TERM': 'linux', 11:25:49 INFO - 'TMOUT': '86400', 11:25:49 INFO - 'USER': 'cltbld', 11:25:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006', 11:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:49 INFO - '_': '/tools/buildbot/bin/python'} 11:25:49 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/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:25:49 INFO - mozversion application_buildid: 20170206093855 11:25:49 INFO - mozversion application_changeset: c48c37867d35fb2ffc8457834e12192a799d020c 11:25:49 INFO - mozversion application_display_name: Firefox 11:25:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:49 INFO - mozversion application_name: Firefox 11:25:49 INFO - mozversion application_remotingname: firefox 11:25:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:49 INFO - mozversion application_vendor: Mozilla 11:25:49 INFO - mozversion application_version: 52.0 11:25:49 INFO - mozversion platform_buildid: 20170206093855 11:25:49 INFO - mozversion platform_changeset: c48c37867d35fb2ffc8457834e12192a799d020c 11:25:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:49 INFO - mozversion platform_version: 52.0 11:25:49 INFO - using testdate: 1486409149 11:25:49 INFO - actual date: 1486409149 11:25:49 INFO - starting webserver on 'localhost:52438' 11:25:49 INFO - SUITE-START | Running 2 tests 11:25:49 INFO - TEST-START | dromaeo_css 11:25:49 INFO - operating with platform_type : linux_ 11:25:49 INFO - Initialising browser for dromaeo_css test... 11:25:49 INFO - TEST-INFO | started process 23716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbNeD8C/profile http://localhost:52438/getInfo.html) 11:25:53 INFO - PROCESS | 23716 | __metrics Screen width/height:1600/1200 11:25:53 INFO - PROCESS | 23716 | colorDepth:24 11:25:53 INFO - PROCESS | 23716 | Browser inner width/height: 1024/697 11:25:53 INFO - PROCESS | 23716 | __metrics 11:25:54 INFO - PROCESS | 23716 | 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" 11:25:54 INFO - PROCESS | 23716 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:55 INFO - PROCESS | 23716 | console.error: PushService: 11:25:55 INFO - PROCESS | 23716 | stateChangeProcessEnqueue: Error transitioning state 11:25:55 INFO - PROCESS | 23716 | UnknownError 11:25:55 INFO - TEST-INFO | 23716: exit 0 11:25:55 INFO - Browser initialized. 11:25:55 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:55 INFO - TEST-INFO | started process 23808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbNeD8C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:07 INFO - PROCESS | 23808 | RSS: Main: 145039360 11:26:07 INFO - PROCESS | 23808 | 11:29:08 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52438/tests/dromaeo/cssquery-ext.html) 11:29:09 INFO - PROCESS | 23808 | RSS: Main: 246218752 11:29:09 INFO - PROCESS | 23808 | 11:32:12 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-ext.html (next: http://localhost:52438/tests/dromaeo/cssquery-jquery.html) 11:32:12 INFO - PROCESS | 23808 | RSS: Main: 230780928 11:32:12 INFO - PROCESS | 23808 | 11:35:14 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52438/tests/dromaeo/cssquery-mootools.html) 11:35:15 INFO - PROCESS | 23808 | RSS: Main: 230051840 11:35:15 INFO - PROCESS | 23808 | 11:38:17 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52438/tests/dromaeo/cssquery-prototype.html) 11:38:17 INFO - PROCESS | 23808 | RSS: Main: 224329728 11:38:17 INFO - PROCESS | 23808 | 11:41:20 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52438/tests/dromaeo/cssquery-yui.html) 11:41:20 INFO - PROCESS | 23808 | RSS: Main: 177266688 11:41:20 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | Cycle 1(1): loaded http://localhost:52438/tests/dromaeo/cssquery-yui.html (next: http://localhost:52438/tests/dromaeo/cssquery-dojo.html) 11:44:23 INFO - PROCESS | 23808 | RSS: Main: 266129408 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | __start_tp_report 11:44:23 INFO - PROCESS | 23808 | _x_x_mozilla_page_load 11:44:23 INFO - PROCESS | 23808 | _x_x_mozilla_page_load_details 11:44:23 INFO - PROCESS | 23808 | |i|pagename|runs| 11:44:23 INFO - PROCESS | 23808 | |0;dojo.html;3216.839158042098;3271.918202044947;3286.0798976286646;3287.5233091201767;3316.237265428951;5590.776368945242;5628.099504079348;5645.943540564593;5662.462066103719;5676;5658.745356458959;5733.856653583663;5741.598088133832;5742.109972954188;5769.798057068004;5144.0740666679985;5161.793528258865;5189.974050129744;5197.246399272103;5229.86925326868;5026.623003274769;5057.848264552069;5074.061298659742;5252.107141785887;5278.762455689484;5043.117454445457;5138.691678499284;5161.200013997836;5170.017696637627;5175.197844334134;5109.591232701394;5111;5116.897662046738;5162.74186290684;5166.147585648364;4974.955259395531;4993.001399720034;5059.418166910816;5084.084864724348;5136.948630513684;5508.14623733322;5511.696856672881;5527.309086364205;5554.416786237427;5599.076152434844;5927.911081333784;5948.078047902582;5972.343042265347;6011;6024.759009639609;5921;6076.118962750376;6080;6087.391260873921;6100.572959892809;5555;5570.777168913239;5608.971955140239;5643.153526970905;5667.631603945731;6184.226971628546;6184.288806787277;6184.5052395808225;6197.318294987548;6201.6899155042065;5743.569232307594;5937.673427961504;5938.8218353449465;5955.731992060368;5956.285245770535;5869.06095024794;5882.117682347682;5886.205362276123;5902.586818922634;5988;5882.029465138205;5927.081302398135;5935.40645935403;5937.643741375531;5944.167816505693;5951.583389162717;5965.940340596539;5966.761329546856;5967.224260846149;6000.33996260411;4496.235639941217;4507.053518761031;4529.501754806968;4536.274196128604;4586.6789324747615;4059.837606495766;4075.89810254746;4079.1637714268504;4080.571539988318;4105.404716316177;5554.416786237468;5651.180578816049;5656.490915817596;5665.518430933417;5686.57350698691;5833.679147646835;5875.177475153482;5988.580799344004;6005.6997150142315;6024.728887199999;5769.509591684669;5778.306603207558;5778.566607504454;5782.306123265235;5796.507296879812;5099.898002039939;5108.591312694975;5113.846584602468;5118.820841270538;5131.076406246912;6125.2659746757545;6190.659513726699;6200.99999999991;6272.153259310026;6272.2159730033745;6119.938800611937;6128.411459112198;6176.227971503562;6181.103739957771;6182.258129024366;6290.968545157245;6297.559170857996;6312.4634406076;6328.367163283635;6336.112944187726;5786.450287222707;5844.94155058444;5845.707714614337;5974.4324289192455;5975.9103613446705;5998.7300571473515;6116.33577150815;6129.939558357133;6138.6336396323695;6139.3553676863285;5909.8227053188475;5931.911021334769;5935.0503919372695;5936.22829032223;5948.434898684618;5735.311762588349;5851.034579294369;5870.765169393348;5903.144044113494;5906.616069955439;5774.162746401664;5777.39337369587;5780.364159942319;5788.450097240755;5901.7639294427745;5908.793192238251;5912.970435147797;5913.970430147821;5918.73365698536;5926.140709596998;5569.805056822992;5611.5230205433;5697.259356283656;5734.483896449339;5761.884762304814 11:44:23 INFO - PROCESS | 23808 | |1;ext.html;548.9958066651953;563.4450066684316;592.4963780786333;598.1237487081424;606.0424529243794;34457.48313775292;37234.255314893686;45230.547694523004;46146.307805382945;46173;47657.52342476574;47982;48129.518704812945;48142.6300158989;48198.27702584464;8965.596548155349;9118.13377729118;9128.406653567497;9135.95432022839;9136.588853501575;8503.404761666687;8767.167119123706;10688.305260158066;10972.945135274313;10977.06694930932;11034.503447344889;11099.44502774858;11099.445027748621;11101.278416902875;11116.333020018785;10938.124950003981;10962.232643714942;11006.284591501526;11019.173561982843;11019.283746556448;10838.783224335548;10894.782104357948;10902.836457453144;10906.291091079134;10910.563577456893;44618;44878.775606122086;45063.77468112671;45065;45072.54927450749;3496.2657841853243;3586.1751797086554;3675.8713445029293;3695.6858667013335;4128.566500517462;32444.35111297761;32627.52935298526;32632.6736732632;32988.835055824806;33394.49908251378;4371.688398595721;4397.538258482878;4425.070735145623;4426.822927082912;4521.841735539273;330572;332672.3366383177;333274;334818;335166;60922;61446.69276653588;61470;61503;61563.07655385173;40256.396154057715;40986;41259.58740412618;43202.351964720554;43241.91895202582;18294.817051829312;18516.351927682466;18523.629527409375;18537.351192708462;18543.165557549673;12040.39798010096;12373.62879113628;13719.794203086962;13869.167849928835;13917.512887048904;19752.60494790096;20561.69157462639;20679.17283308681;21475.78524214738;21518.569628607653;7249.782506524813;7463.477556570988;7464.85070298591;7582.582957937367;7631.275028872248;927.7936650327839;1020.7499162705185;1046.49768111307;1046.9581216751244;1073.2326386633595;33465.66534334674;33492.49761253583;33766.831165844014;33936.83031584826;34003.00929281617;1116.6650004998469;1137.6302701622005;1139.7606502634374;1215.471269997554;1219.1405059433077;17378.826211737975;17712.114394280492;17859.196336164903;17892.731609025876;18026.729599056023;516470;517815;519799;523593;524302;62797;63246;63296.367036329044;63352;63361;1286.903482238817;1337.806018127366;1343.147101590497;1424.6295963049474;1461.3789139615621;29805.403891922473;35299;35432.82283588566;36270.27459450849;36332;58740;59219.70390148194;59382.70308648429;59391.406085938586;59398;415689;421598;421602;422486;423588;30453.543196852508;31443.528347074356;31449.056528304187;31455;31492.37015259728;48818;49577.25634115563;49660.76526556241;49797.51417400747;50215.24677129919;40691.59308406878;41242.58757412388;42048.579514204466;43505.34741978809;44158.77920610376;42112.3683144747;42390.36414453724;43376.78311608548;44305.33541996937;44932.326015110455;42351.788241058595;42575.3613695801;42681.146377071665;42825.357619635106;43687.344689830315;35726.46410303796;37940;38002;38438.807805960794;38803;28724;28952.131436056952;29072.27319317034;29092.27269318284;29223.269418264714 11:44:23 INFO - PROCESS | 23808 | |2;jquery.html;395.47401955399323;401.33378591538053;404.4136002795945;405.76465649923045;425.6722323810666;14424.855751442508;18564.90717546412;19715.211391544355;20377.28679496218;20377.59244815105;15674.843251567481;16988;18753;19138.521536961583;19722.21111155552;5641.492265696097;5758.568107391941;5876.9118463223085;5919.55603329752;5923.733431995571;5641.12562552805;5769.82690519283;5770.942290577103;5841.415858414167;5847.41525847414;5815.127730840387;5819.127130930373;5826.388229235933;5827.242458480391;5842.737076831553;5594.8601284968;5789.334226563936;5792.102224155242;5801.767929282823;5835;5242.1088414969545;5244.580433565306;5253.133233016548;5253.894922101575;5258.290130832365;19456.513587160294;23905.88047059771;24007.399815004588;24069;24239.151629692875;2654.296611397981;2795.5247607906704;2974.1672331747145;3221.371832492665;3275.082976766509;13880;14942;15175.317110730044;15460.845391546052;15461.536153915287;1967.1836187981971;1982.9603407931904;2042.8876411797346;2079.2930403662826;2115.7672656007826;88977.55511222467;89294.5535272326;89915;90574.5471272646;91688;10909.236353455182;10931.836022459669;10987.670369888916;11187.105031597453;11237.60668376603;15314.923425382802;15335.079895206323;15384.30770615325;15519.301631426613;15560.98853574514;7360.595167265852;7813.453058285865;7965.960170199112;8024.879626805603;8041.3164880984605;8053.919460805434;8074.434789564674;8535.146485351415;8697.260732837653;8756.080611535697;4507.954920450819;4554.453465584151;4912.263160525878;5090;5155.896882062338;1804.2991688665265;1824.717168838832;1887.8017808130223;2044.294718322206;2059.773424923257;838.8322335532796;872.2062922740403;886.4548302793736;889.6708217959397;913.6573784830689;17135.314587416615;17855.73216401755;18001.909990449964;18039.54901127456;18117.09414529268;935.4854829843558;960.2318145483586;964.8263312603799;965.1217392173089;966.1449617088927;10010.249231307682;10016.164760821333;10073.899261007442;10166.745831354126;10167.644132455329;372515;373126;375211;452505;491451;98741;102275.4886225579;103018.48490757648;104155.4792226034;106775.46612267045;1060.8620879285643;1091.2415870969758;1096.3038470571244;1134.8070827959266;1141.6289705845634;17561.209745561737;17693.203805829027;17873.463796086136;17907.194176261837;18329.725054123934;41790;41925.371119432624;42875;43413.565864342214;43899;57190.42809571851;57379.71310143422;60034.39965600288;60455.69772151111;65596;8116.918830811616;8327.666893324442;8412.411131220755;8436.704715334934;8441.029281632691;11811.468483918072;12757.617271481871;13148.145370550883;13373.598792036255;13451.798223026466;11178.664640060812;11330.320180789178;11463.598774042868;11592.47833847462;11793.764124717629;8091.797705057421;11021.393823339793;11056.281341712764;11221;11576.189666723249;10777.838332424863;11250.718732031437;11346.60286889988;11579.189456737948;11739.23694959825;8083.959580202061;8116.75649730509;8261.297789687944;8546.017208021158;8591.183837535424;10860.837087443537;11464.31214127155;11613.245139065933;11665.35840528779;11814.94092529532 11:44:23 INFO - PROCESS | 23808 | |3;mootools.html;1425.1591560979023;1503.008014710291;1623.8376162383763;1724.1120822776265;1805.9277628894854;8240.134785847482;8771.561421928895;8773.956130219356;8777.166169213922;8777.648894044247;7473.290037446447;7695.846083078335;8284.710035148772;8495.065542790288;8509.489430634167;2428.6114221724483;2452.852828830267;2457.0785955266774;2457.2751038443703;2459.6802415685934;2445.2664200739796;2467.444824914398;2468.9753102469017;2471.0733474946896;2475.220305603738;2412.6501657259773;2415.2271273192587;2443.1082654831034;2455.7789798918093;2467.0501856785177;2373.8338316317863;2375.5130198309307;2395.0659242895285;2403.098837935774;2404.1104791227185;2414.806815454777;2422.3338581889943;2442.548128596198;2443;2443.4624382635793;8337.291330236938;8494.660213591449;8495.36284778644;8498.447600905922;8504.532250726208;5290.1800220965815;5444.047291723932;5451.2640793492765;5452.972735136299;5455.645383050129;3533.9293214135832;3563.198280386918;3573.6605022523077;3603.79262456414;3647.288778688157;1104.7735214281054;1112.2992514715759;1116.5924437580225;1179.55177032727;2141.967870481944;11438.370889601068;11880.049596032297;11914.106442016884;11919.046476281963;11922.523099076026;4594.104149690845;4621.861344159681;4658;4693.671442999025;4716.528347165256;9660.37207581519;9663.082007209305;9664.420134791935;9665;9670.56482458291;5299.5230429261555;5349.973250133725;5354.651947623392;5364.007658583175;5364.651297665718;4337.436133302714;4537.3647689323525;4696.201645720235;4768.570828625371;5017.57350625201;3851.5185601799776;3928.64642182205;3929.44987701722;4030.8109107813266;4038.030872590557;1182.6984119049587;1202.5250026239587;1209.879012098783;1211.7273613436905;1216.3735676126803;842.6334544473051;1009.5810238750836;1017;1017.862588550551;1021.5147804792813;5681.801136960186;5716.79991200306;5798.275215598051;5822.7088645567555;5891.322497912709;429.1053154173583;448.72627697105395;468.4753076554213;468.80778880658767;484.9030193961222;3968.1865217630316;3968.404739289072;4023.7384570002855;4026.275270451288;4028.5165780106577;10072.949635251924;10536.894631053592;10590.417527036087;10602.893971060344;10604.89395106039;10357.067863892285;10389.896101039045;10482.213833962483;10482.266241363031;10487.475626218658;7770.650320735581;8056.0332760067995;8194.50832950025;8208.056073551617;8212.589370531568;5897.3807750185615;5999.730012149376;6045;6063.636181829104;6065.029595264737;9425;9631.614735410505;9664.516774161404;9751.268654851056;9760.853587196056;9404.623815047322;9552.331336806357;9621.9037809621;9899.109080182818;10025.5488503019;7431.591262480615;7598.848023039619;7654.2345765423015;7737.264959828807;7899.921000789918;8363.163683631588;8424.578771061544;8433.831323373375;8435.367347448842;8443.071262161035;7235.421166306577;7292.0520332356455;7304.5252058616015;7325.523840950321;7509.51188172767;7353.374963128194;7431.554106753612;7436.367908727819;7470.252974702486;7501.437392195717;6968.338007889242;7095.929040709527;7102.822429439306;7109.075820143556;7128.358447739728;5197.948020519746;5283.524482796567;5290.391604965478;5291.788328466818;5454.372747134131;5341.599380046589;5377.462253774747;5429.267048948342;5456.91814622773;5467.6719396836315 11:44:23 INFO - PROCESS | 23808 | |4;prototype.html;319.5574129830185;329.9307145499446;346.29528908670846;353.60043151239097;365.27492926540793;5297.152455607104;5460.153676180198;5497.972510137449;5502.504774570288;5510.91733623996;5249.711265880375;5365.839024829252;5370.3287089113865;5398.190271459283;5430.864228394292;4243.08773613673;4264.55222201669;4274.658027357819;4282.015136518595;4304.440422745039;4117.649999750025;4198.8320467181275;4201.243776120297;4205.747655140686;4219.725717828347;4169.874903752892;4176.498820141587;4184.623383895449;4185.142045880587;4196.097838964622;4190.916181676364;4203.642690371322;4208.242516347056;4210.305299625588;4213.662906967435;3687.4100143977103;3759.755615884959;3767.2842159989787;3768.2275133597823;3771.5474143103;5237.8428647140645;5258.76419041525;5262.105442074818;5273.578113750891;5295.4704529547125;4842.927356089662;4863.8784030399165;4868;4873.634477414173;4883.755812209411;5525.171224316345;5654.9151762723595;5666.320041595035;5683.630564013326;5714.771409143629;4132.504099508048;4134.028503301722;4137.731047481904;4139.530466684344;4160.126373461547;5878.735456904449;5914.935311643945;5924.496417804492;5935.910961335583;5949.851253718692;4160.335865653763;4199.496060472763;4232.090100628318;4238.21593005295;4251.936220956688;4280.422143010654;4283.635890949305;4293.205756934977;4297.742135471882;4308.827646894152;4875.756212189376;4892;4899.240617704261;4902.607791376753;4903.485134060944;5533.889322213614;5662.546996240373;5683.971580142155;5713.257276554022;5719.3136823581435;1322.1604281281454;1339.8124262603244;1343.2209318595192;1354.6951935814363;1369.4111532041318;981.5435822342645;988.1008282462924;1010.2776514791959;1013.3160116921049;1017.2574020964737;5368.403169876192;5374.731263436813;5395.190721391744;5396.163594642837;5437.803683189692;5511.988124334589;5529.751161197756;5583.832485025456;5601.6556026553335;5653.604247702621;5267.762950667229;5273;5288.788448462018;5294.364676238876;5307.840764777063;2914.7993265085147;2964.9407011859644;2991;2999.6850330715397;3011.7590592752526;5801.6519008859605;5810.94189058104;5850.707464626752;5850.707464626837;5855.736491857877;5721.598208438959;5722.7424765885635;5735.426457354231;5743.885122297531;5787.681677507693;5431.945680543144;5742.454466825645;5774.220480235199;5807.303123625192;5844.824655260349;5568.9443105568425;5610.85972850682;5619.971900140473;5638.182463542846;5645.080672571181;5534.944650553443;5543.501084902378;5563.193336966036;5575.7490912909825;5602.747876345493;5502.972485137549;5756.884862302814;5768.365479797135;5785.27684039495;5795.217645617788;4079.4288799568676;4080.7347522410946;4105.774182419996;4153.501579810442;4157.293260145843;5423.83728488146;5711.8857622848145;5715.342735585461;5715.657060576379;5717.42825717425;5437.265969094122;5449;5456.508914197741;5474.507294343528;5522.447755224445;5398.595105367034;5417.458254174551;5435.103207970798;5444.346678398618;5446.863828404322;5546.722663866871;5578.944210557843;5592;5646.153077038477;5660.943390566042;5665.773369065356;5678.290213723285;5683.868549294015;5699.572532060195;5702.7718891243885;5468.95627525116;5578.386377498553;5592.496675299242;5597.608167428404;5609.382967873449 11:44:23 INFO - PROCESS | 23808 | |5;yui.html;714.3999040805726;749.1796482851278;752.1200195770947;809.5264270401815;867.8611422172454;15820.683586328281;16571.91714041428;16600.169991500406;16601.41895033674;16631.50105496834;14895.10629362239;15094.320755566;15170.84829151708;15201.771973420407;15212.315445804938;722.801229661842;748.5471289869632;835.4945258118811;836.8828364029041;861.6122744764881;862.874883141944;864.8745931839879;865.2169786343338;866.0819531296845;867.6616119713317;922.575615217001;923.8244733500647;924.0436148586181;925.0887875442717;925.7500474871781;922.2069020642242;923.4920793563581;923.7967647117623;924.7503174143011;924.8936372317169;677.4546490075487;677.7526202935942;678.281022116558;678.2979616097365;679.4190966723479;14143.080699754586;14359.569212923629;14447.422103115863;14558.4904528341;15671.138087405188;14065.5077072303;14712.852871471256;14718.632034199123;14751.409943602242;14772.409103635842;11565.53737850485;11609.535618575246;11758.059355251646;11768;11783.941080294544;3785.3943369061094;3841.9807900960595;3873;3876.089119057019;3906.8046597670286;61830.381696182914;62622;62912.37087629111;62973.68513157451;63736;11155.219134660496;11222.831657525143;11300.94349528247;11388.430578471043;11466.885331146748;21713;21715.891420542797;21727.13091476323;21737.23919662804;21871.234506792185;8426.368022398345;8426.662933482592;8482.660693572312;8596.312295016383;8652.956735216283;4608.331791890158;4630.9536904631195;4637.930431043537;4660.414890593948;4710.9764451177525;3519.665631764978;3637.5453068366455;3638.0541059324764;3647.8176091195332;3652.5251717277115;603.5744799916049;613.929398119213;614.241411856357;619.2321521313539;623.1649589550025;662.5428454366472;697.9511434199558;709.9680514376865;748.4386709967524;751.8496300739874;9389.436633801994;9524.476153811469;9774.804503910023;10254.128399086012;10414.843777343194;632.3170975346615;665.6937808608094;741.1439787045971;741.7663436017638;742.2429122295229;4584.266517357207;4629.259318509023;4668.486466488684;4684.906301873943;4709.105269998689;66925.66537167283;90740.5462972681;94547;94657.59980855917;96627;78736.21263787289;80108.59945700351;81112.91653126039;82003.58998204971;82850.58574707087;65505.672471637336;71535.6423217891;72297;72822.63588682128;74747.25252747403;8991.460512369278;9101.362904596615;9118.908810911806;9185.540722963691;9280.72157835266;49661.25508117453;50030.49969500258;51229.694663740964;52182.95634087221;52363.47636523586;40174.79912600418;62340.68829656004;64236.50344475842;65545.34454655583;66493.66753166204;11442.427878606202;11449.656510304705;11559.595414160463;11726.706832328919;11839.82240266414;12061;12379.133460657667;12837.743245135232;12882.806757898827;13262.602121936357;11590.246633968765;11893.226940248856;11934.343611101473;12546.12177147591;12940.611781646565;12129.393530323625;12429.44067516982;12445;12495.625131246077;12703.745925081632;12372.876271237532;12388.752224955631;12474.938739140192;12508.186967847061;12624.368781561068;10134.543945522617;10497.580096796348;10603.173969856276;10656.786864262827;10905.345679258953;10185.541650625592;10259.333143345659;10322.638707645196;10327.948360258151;10583.5237414315 11:44:23 INFO - PROCESS | 23808 | __end_tp_report 11:44:23 INFO - PROCESS | 23808 | __start_cc_report 11:44:23 INFO - PROCESS | 23808 | _x_x_mozilla_cycle_collect,960 11:44:23 INFO - PROCESS | 23808 | __end_cc_report 11:44:23 INFO - PROCESS | 23808 | __startTimestamp1486410263324__endTimestamp 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | ------- Summary: start ------- 11:44:23 INFO - PROCESS | 23808 | Number of tests: 6 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#0] dojo.html Cycles:165 Average:5585.31 Median:5780.36 stddev:639.94 (11.1%) stddev-sans-first:614.33 11:44:23 INFO - PROCESS | 23808 | Values: 3216.8 3271.9 3286.1 3287.5 3316.2 5590.8 5628.1 5645.9 5662.5 5676.0 5658.7 5733.9 5741.6 5742.1 5769.8 5144.1 5161.8 5190.0 5197.2 5229.9 5026.6 5057.8 5074.1 5252.1 5278.8 5043.1 5138.7 5161.2 5170.0 5175.2 5109.6 5111.0 5116.9 5162.7 5166.1 4975.0 4993.0 5059.4 5084.1 5136.9 5508.1 5511.7 5527.3 5554.4 5599.1 5927.9 5948.1 5972.3 6011.0 6024.8 5921.0 6076.1 6080.0 6087.4 6100.6 5555.0 5570.8 5609.0 5643.2 5667.6 6184.2 6184.3 6184.5 6197.3 6201.7 5743.6 5937.7 5938.8 5955.7 5956.3 5869.1 5882.1 5886.2 5902.6 5988.0 5882.0 5927.1 5935.4 5937.6 5944.2 5951.6 5965.9 5966.8 5967.2 6000.3 4496.2 4507.1 4529.5 4536.3 4586.7 4059.8 4075.9 4079.2 4080.6 4105.4 5554.4 5651.2 5656.5 5665.5 5686.6 5833.7 5875.2 5988.6 6005.7 6024.7 5769.5 5778.3 5778.6 5782.3 5796.5 5099.9 5108.6 5113.8 5118.8 5131.1 6125.3 6190.7 6201.0 6272.2 6272.2 6119.9 6128.4 6176.2 6181.1 6182.3 6291.0 6297.6 6312.5 6328.4 6336.1 5786.5 5844.9 5845.7 5974.4 5975.9 5998.7 6116.3 6129.9 6138.6 6139.4 5909.8 5931.9 5935.1 5936.2 5948.4 5735.3 5851.0 5870.8 5903.1 5906.6 5774.2 5777.4 5780.4 5788.5 5901.8 5908.8 5913.0 5914.0 5918.7 5926.1 5569.8 5611.5 5697.3 5734.5 5761.9 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#1] ext.html Cycles:180 Average:59849.46 Median:38220.40 stddev:114075.71 (298.5%) stddev-sans-first:114308.84 11:44:23 INFO - PROCESS | 23808 | Values: 549.0 563.4 592.5 598.1 606.0 34457.5 37234.3 45230.5 46146.3 46173.0 47657.5 47982.0 48129.5 48142.6 48198.3 8965.6 9118.1 9128.4 9136.0 9136.6 8503.4 8767.2 10688.3 10972.9 10977.1 11034.5 11099.4 11099.4 11101.3 11116.3 10938.1 10962.2 11006.3 11019.2 11019.3 10838.8 10894.8 10902.8 10906.3 10910.6 44618.0 44878.8 45063.8 45065.0 45072.5 3496.3 3586.2 3675.9 3695.7 4128.6 32444.4 32627.5 32632.7 32988.8 33394.5 4371.7 4397.5 4425.1 4426.8 4521.8 330572.0 332672.3 333274.0 334818.0 335166.0 60922.0 61446.7 61470.0 61503.0 61563.1 40256.4 40986.0 41259.6 43202.4 43241.9 18294.8 18516.4 18523.6 18537.4 18543.2 12040.4 12373.6 13719.8 13869.2 13917.5 19752.6 20561.7 20679.2 21475.8 21518.6 7249.8 7463.5 7464.9 7582.6 7631.3 927.8 1020.7 1046.5 1047.0 1073.2 33465.7 33492.5 33766.8 33936.8 34003.0 1116.7 1137.6 1139.8 1215.5 1219.1 17378.8 17712.1 17859.2 17892.7 18026.7 516470.0 517815.0 519799.0 523593.0 524302.0 62797.0 63246.0 63296.4 63352.0 63361.0 1286.9 1337.8 1343.1 1424.6 1461.4 29805.4 35299.0 35432.8 36270.3 36332.0 58740.0 59219.7 59382.7 59391.4 59398.0 415689.0 421598.0 421602.0 422486.0 423588.0 30453.5 31443.5 31449.1 31455.0 31492.4 48818.0 49577.3 49660.8 49797.5 50215.2 40691.6 41242.6 42048.6 43505.3 44158.8 42112.4 42390.4 43376.8 44305.3 44932.3 42351.8 42575.4 42681.1 42825.4 43687.3 35726.5 37940.0 38002.0 38438.8 38803.0 28724.0 28952.1 29072.3 29092.3 29223.3 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#2] jquery.html Cycles:180 Average:27510.88 Median:3097.77 stddev:69645.59 (2248.2%) stddev-sans-first:69811.20 11:44:23 INFO - PROCESS | 23808 | Values: 395.5 401.3 404.4 405.8 425.7 14424.9 18564.9 19715.2 20377.3 20377.6 15674.8 16988.0 18753.0 19138.5 19722.2 5641.5 5758.6 5876.9 5919.6 5923.7 5641.1 5769.8 5770.9 5841.4 5847.4 5815.1 5819.1 5826.4 5827.2 5842.7 5594.9 5789.3 5792.1 5801.8 5835.0 5242.1 5244.6 5253.1 5253.9 5258.3 19456.5 23905.9 24007.4 24069.0 24239.2 2654.3 2795.5 2974.2 3221.4 3275.1 13880.0 14942.0 15175.3 15460.8 15461.5 1967.2 1983.0 2042.9 2079.3 2115.8 88977.6 89294.6 89915.0 90574.5 91688.0 10909.2 10931.8 10987.7 11187.1 11237.6 15314.9 15335.1 15384.3 15519.3 15561.0 7360.6 7813.5 7966.0 8024.9 8041.3 8053.9 8074.4 8535.1 8697.3 8756.1 4508.0 4554.5 4912.3 5090.0 5155.9 1804.3 1824.7 1887.8 2044.3 2059.8 838.8 872.2 886.5 889.7 913.7 17135.3 17855.7 18001.9 18039.5 18117.1 935.5 960.2 964.8 965.1 966.1 10010.2 10016.2 10073.9 10166.7 10167.6 372515.0 373126.0 375211.0 452505.0 491451.0 98741.0 102275.5 103018.5 104155.5 106775.5 1060.9 1091.2 1096.3 1134.8 1141.6 17561.2 17693.2 17873.5 17907.2 18329.7 41790.0 41925.4 42875.0 43413.6 43899.0 57190.4 57379.7 60034.4 60455.7 65596.0 8116.9 8327.7 8412.4 8436.7 8441.0 11811.5 12757.6 13148.1 13373.6 13451.8 11178.7 11330.3 11463.6 11592.5 11793.8 8091.8 11021.4 11056.3 11221.0 11576.2 10777.8 11250.7 11346.6 11579.2 11739.2 8084.0 8116.8 8261.3 8546.0 8591.2 10860.8 11464.3 11613.2 11665.4 11814.9 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#3] mootools.html Cycles:180 Average:5692.33 Median:5240.74 stddev:3124.71 (59.6%) stddev-sans-first:3117.02 11:44:23 INFO - PROCESS | 23808 | Values: 1425.2 1503.0 1623.8 1724.1 1805.9 8240.1 8771.6 8774.0 8777.2 8777.6 7473.3 7695.8 8284.7 8495.1 8509.5 2428.6 2452.9 2457.1 2457.3 2459.7 2445.3 2467.4 2469.0 2471.1 2475.2 2412.7 2415.2 2443.1 2455.8 2467.1 2373.8 2375.5 2395.1 2403.1 2404.1 2414.8 2422.3 2442.5 2443.0 2443.5 8337.3 8494.7 8495.4 8498.4 8504.5 5290.2 5444.0 5451.3 5453.0 5455.6 3533.9 3563.2 3573.7 3603.8 3647.3 1104.8 1112.3 1116.6 1179.6 2142.0 11438.4 11880.0 11914.1 11919.0 11922.5 4594.1 4621.9 4658.0 4693.7 4716.5 9660.4 9663.1 9664.4 9665.0 9670.6 5299.5 5350.0 5354.7 5364.0 5364.7 4337.4 4537.4 4696.2 4768.6 5017.6 3851.5 3928.6 3929.4 4030.8 4038.0 1182.7 1202.5 1209.9 1211.7 1216.4 842.6 1009.6 1017.0 1017.9 1021.5 5681.8 5716.8 5798.3 5822.7 5891.3 429.1 448.7 468.5 468.8 484.9 3968.2 3968.4 4023.7 4026.3 4028.5 10072.9 10536.9 10590.4 10602.9 10604.9 10357.1 10389.9 10482.2 10482.3 10487.5 7770.7 8056.0 8194.5 8208.1 8212.6 5897.4 5999.7 6045.0 6063.6 6065.0 9425.0 9631.6 9664.5 9751.3 9760.9 9404.6 9552.3 9621.9 9899.1 10025.5 7431.6 7598.8 7654.2 7737.3 7899.9 8363.2 8424.6 8433.8 8435.4 8443.1 7235.4 7292.1 7304.5 7325.5 7509.5 7353.4 7431.6 7436.4 7470.3 7501.4 6968.3 7095.9 7102.8 7109.1 7128.4 5197.9 5283.5 5290.4 5291.8 5454.4 5341.6 5377.5 5429.3 5456.9 5467.7 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#4] prototype.html Cycles:180 Average:4721.63 Median:5397.18 stddev:1365.90 (25.3%) stddev-sans-first:1329.16 11:44:23 INFO - PROCESS | 23808 | Values: 319.6 329.9 346.3 353.6 365.3 5297.2 5460.2 5498.0 5502.5 5510.9 5249.7 5365.8 5370.3 5398.2 5430.9 4243.1 4264.6 4274.7 4282.0 4304.4 4117.6 4198.8 4201.2 4205.7 4219.7 4169.9 4176.5 4184.6 4185.1 4196.1 4190.9 4203.6 4208.2 4210.3 4213.7 3687.4 3759.8 3767.3 3768.2 3771.5 5237.8 5258.8 5262.1 5273.6 5295.5 4842.9 4863.9 4868.0 4873.6 4883.8 5525.2 5654.9 5666.3 5683.6 5714.8 4132.5 4134.0 4137.7 4139.5 4160.1 5878.7 5914.9 5924.5 5935.9 5949.9 4160.3 4199.5 4232.1 4238.2 4251.9 4280.4 4283.6 4293.2 4297.7 4308.8 4875.8 4892.0 4899.2 4902.6 4903.5 5533.9 5662.5 5684.0 5713.3 5719.3 1322.2 1339.8 1343.2 1354.7 1369.4 981.5 988.1 1010.3 1013.3 1017.3 5368.4 5374.7 5395.2 5396.2 5437.8 5512.0 5529.8 5583.8 5601.7 5653.6 5267.8 5273.0 5288.8 5294.4 5307.8 2914.8 2964.9 2991.0 2999.7 3011.8 5801.7 5810.9 5850.7 5850.7 5855.7 5721.6 5722.7 5735.4 5743.9 5787.7 5431.9 5742.5 5774.2 5807.3 5844.8 5568.9 5610.9 5620.0 5638.2 5645.1 5534.9 5543.5 5563.2 5575.7 5602.7 5503.0 5756.9 5768.4 5785.3 5795.2 4079.4 4080.7 4105.8 4153.5 4157.3 5423.8 5711.9 5715.3 5715.7 5717.4 5437.3 5449.0 5456.5 5474.5 5522.4 5398.6 5417.5 5435.1 5444.3 5446.9 5546.7 5578.9 5592.0 5646.2 5660.9 5665.8 5678.3 5683.9 5699.6 5702.8 5469.0 5578.4 5592.5 5597.6 5609.4 11:44:23 INFO - PROCESS | 23808 | 11:44:23 INFO - PROCESS | 23808 | [#5] yui.html Cycles:180 Average:18162.66 Median:4697.01 stddev:24203.03 (515.3%) stddev-sans-first:24235.46 11:44:23 INFO - PROCESS | 23808 | Values: 714.4 749.2 752.1 809.5 867.9 15820.7 16571.9 16600.2 16601.4 16631.5 14895.1 15094.3 15170.8 15201.8 15212.3 722.8 748.5 835.5 836.9 861.6 862.9 864.9 865.2 866.1 867.7 922.6 923.8 924.0 925.1 925.8 922.2 923.5 923.8 924.8 924.9 677.5 677.8 678.3 678.3 679.4 14143.1 14359.6 14447.4 14558.5 15671.1 14065.5 14712.9 14718.6 14751.4 14772.4 11565.5 11609.5 11758.1 11768.0 11783.9 3785.4 3842.0 3873.0 3876.1 3906.8 61830.4 62622.0 62912.4 62973.7 63736.0 11155.2 11222.8 11300.9 11388.4 11466.9 21713.0 21715.9 21727.1 21737.2 21871.2 8426.4 8426.7 8482.7 8596.3 8653.0 4608.3 4631.0 4637.9 4660.4 4711.0 3519.7 3637.5 3638.1 3647.8 3652.5 603.6 613.9 614.2 619.2 623.2 662.5 698.0 710.0 748.4 751.8 9389.4 9524.5 9774.8 10254.1 10414.8 632.3 665.7 741.1 741.8 742.2 4584.3 4629.3 4668.5 4684.9 4709.1 66925.7 90740.5 94547.0 94657.6 96627.0 78736.2 80108.6 81112.9 82003.6 82850.6 65505.7 71535.6 72297.0 72822.6 74747.3 8991.5 9101.4 9118.9 9185.5 9280.7 49661.3 50030.5 51229.7 52183.0 52363.5 40174.8 62340.7 64236.5 65545.3 66493.7 11442.4 11449.7 11559.6 11726.7 11839.8 12061.0 12379.1 12837.7 12882.8 13262.6 11590.2 11893.2 11934.3 12546.1 12940.6 12129.4 12429.4 12445.0 12495.6 12703.7 12372.9 12388.8 12474.9 12508.2 12624.4 10134.5 10497.6 10603.2 10656.8 10905.3 10185.5 10259.3 10322.6 10327.9 10583.5 11:44:23 INFO - PROCESS | 23808 | -------- Summary: end -------- 11:44:23 INFO - PROCESS | 23808 | 11:44:24 INFO - TEST-INFO | 23808: exit 0 11:44:24 INFO - TEST-OK | dromaeo_css | took 1114466ms 11:44:24 INFO - TEST-START | kraken 11:44:24 INFO - operating with platform_type : linux_ 11:44:24 INFO - Initialising browser for kraken test... 11:44:24 INFO - TEST-INFO | started process 24109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx6z_xn/profile http://localhost:52438/getInfo.html) 11:44:28 INFO - PROCESS | 24109 | __metrics Screen width/height:1600/1200 11:44:28 INFO - PROCESS | 24109 | colorDepth:24 11:44:28 INFO - PROCESS | 24109 | Browser inner width/height: 1024/697 11:44:28 INFO - PROCESS | 24109 | __metrics 11:44:28 INFO - PROCESS | 24109 | 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" 11:44:28 INFO - PROCESS | 24109 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:44:29 INFO - PROCESS | 24109 | console.error: PushService: 11:44:29 INFO - PROCESS | 24109 | stateChangeProcessEnqueue: Error transitioning state 11:44:29 INFO - PROCESS | 24109 | UnknownError 11:44:29 INFO - TEST-INFO | 24109: exit 0 11:44:29 INFO - Browser initialized. 11:44:29 INFO - Running cycle 1/1 for kraken test... 11:44:29 INFO - TEST-INFO | started process 24202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx6z_xn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:41 INFO - PROCESS | 24202 | RSS: Main: 145346560 11:44:41 INFO - PROCESS | 24202 | 11:44:44 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:44 INFO - PROCESS | 24202 | RSS: Main: 187002880 11:44:44 INFO - PROCESS | 24202 | 11:44:47 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-dft) 11:44:48 INFO - PROCESS | 24202 | RSS: Main: 177594368 11:44:48 INFO - PROCESS | 24202 | 11:44:50 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-fft) 11:44:51 INFO - PROCESS | 24202 | RSS: Main: 268615680 11:44:51 INFO - PROCESS | 24202 | 11:44:53 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52438/tests/kraken/driver.html?testName=audio-oscillator) 11:44:54 INFO - PROCESS | 24202 | RSS: Main: 175071232 11:44:54 INFO - PROCESS | 24202 | 11:44:56 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:56 INFO - PROCESS | 24202 | RSS: Main: 177569792 11:44:56 INFO - PROCESS | 24202 | 11:44:59 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:00 INFO - PROCESS | 24202 | RSS: Main: 215781376 11:45:00 INFO - PROCESS | 24202 | 11:45:03 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52438/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:04 INFO - PROCESS | 24202 | RSS: Main: 214786048 11:45:04 INFO - PROCESS | 24202 | 11:45:06 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52438/tests/kraken/driver.html?testName=json-parse-financial) 11:45:07 INFO - PROCESS | 24202 | RSS: Main: 213405696 11:45:07 INFO - PROCESS | 24202 | 11:45:09 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:09 INFO - PROCESS | 24202 | RSS: Main: 175906816 11:45:09 INFO - PROCESS | 24202 | 11:45:11 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:11 INFO - PROCESS | 24202 | RSS: Main: 182857728 11:45:11 INFO - PROCESS | 24202 | 11:45:13 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:14 INFO - PROCESS | 24202 | RSS: Main: 189386752 11:45:14 INFO - PROCESS | 24202 | 11:45:17 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:17 INFO - PROCESS | 24202 | RSS: Main: 197435392 11:45:17 INFO - PROCESS | 24202 | 11:45:20 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:21 INFO - PROCESS | 24202 | RSS: Main: 194334720 11:45:21 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | Cycle 1(1): loaded http://localhost:52438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52438/tests/kraken/driver.html?testName=ai-astar) 11:45:22 INFO - PROCESS | 24202 | RSS: Main: 245534720 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | __start_tp_report 11:45:22 INFO - PROCESS | 24202 | _x_x_mozilla_page_load 11:45:22 INFO - PROCESS | 24202 | _x_x_mozilla_page_load_details 11:45:22 INFO - PROCESS | 24202 | |i|pagename|runs| 11:45:22 INFO - PROCESS | 24202 | |0;ai-astar;102;111;112;111;113;113;113;111;109;110 11:45:22 INFO - PROCESS | 24202 | |1;audio-beat-detection;146;117;116;158;119;120;120;122;148;120 11:45:22 INFO - PROCESS | 24202 | |2;audio-dft;161;160;161;161;162;161;161;161;161;160 11:45:22 INFO - PROCESS | 24202 | |3;audio-fft;74;74;74;102;76;75;75;75;103;74 11:45:22 INFO - PROCESS | 24202 | |4;audio-oscillator;82;82;120;81;82;82;97;82;82;105 11:45:22 INFO - PROCESS | 24202 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;116;117;117 11:45:22 INFO - PROCESS | 24202 | |6;imaging-darkroom;147;146;146;148;147;147;146;146;146;147 11:45:22 INFO - PROCESS | 24202 | |7;imaging-desaturate;85;84;84;86;85;85;84;85;85;85 11:45:22 INFO - PROCESS | 24202 | |8;json-parse-financial;50;50;51;50;49;50;49;50;50;50 11:45:22 INFO - PROCESS | 24202 | |9;json-stringify-tinderbox;59;60;60;59;59;59;59;59;60;60 11:45:22 INFO - PROCESS | 24202 | |10;stanford-crypto-aes;75;75;75;75;74;74;75;73;74;76 11:45:22 INFO - PROCESS | 24202 | |11;stanford-crypto-ccm;135;121;131;121;120;121;120;122;167;124 11:45:22 INFO - PROCESS | 24202 | |12;stanford-crypto-pbkdf2;159;157;159;155;154;160;155;154;156;154 11:45:22 INFO - PROCESS | 24202 | |13;stanford-crypto-sha256-iterative;65;64;62;64;64;64;63;63;62;62 11:45:22 INFO - PROCESS | 24202 | __end_tp_report 11:45:22 INFO - PROCESS | 24202 | __start_cc_report 11:45:22 INFO - PROCESS | 24202 | _x_x_mozilla_cycle_collect,1588 11:45:22 INFO - PROCESS | 24202 | __end_cc_report 11:45:22 INFO - PROCESS | 24202 | __startTimestamp1486410322911__endTimestamp 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | ------- Summary: start ------- 11:45:22 INFO - PROCESS | 24202 | Number of tests: 14 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.27 (2.9%) stddev-sans-first:1.42 11:45:22 INFO - PROCESS | 24202 | Values: 102.0 111.0 112.0 111.0 113.0 113.0 113.0 111.0 109.0 110.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:121.00 stddev:15.61 (12.9%) stddev-sans-first:15.24 11:45:22 INFO - PROCESS | 24202 | Values: 146.0 117.0 116.0 158.0 119.0 120.0 120.0 122.0 148.0 120.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:45:22 INFO - PROCESS | 24202 | Values: 161.0 160.0 161.0 161.0 162.0 161.0 161.0 161.0 161.0 160.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.50 stddev:11.77 (15.8%) stddev-sans-first:12.27 11:45:22 INFO - PROCESS | 24202 | Values: 74.0 74.0 74.0 102.0 76.0 75.0 75.0 75.0 103.0 74.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:82.00 stddev:13.48 (16.4%) stddev-sans-first:14.03 11:45:22 INFO - PROCESS | 24202 | Values: 82.0 82.0 120.0 81.0 82.0 82.0 97.0 82.0 82.0 105.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:45:22 INFO - PROCESS | 24202 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:45:22 INFO - PROCESS | 24202 | Values: 147.0 146.0 146.0 148.0 147.0 147.0 146.0 146.0 146.0 147.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:45:22 INFO - PROCESS | 24202 | Values: 85.0 84.0 84.0 86.0 85.0 85.0 84.0 85.0 85.0 85.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 11:45:22 INFO - PROCESS | 24202 | Values: 50.0 50.0 51.0 50.0 49.0 50.0 49.0 50.0 50.0 50.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 11:45:22 INFO - PROCESS | 24202 | Values: 59.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:0.84 (1.1%) stddev-sans-first:0.88 11:45:22 INFO - PROCESS | 24202 | Values: 75.0 75.0 75.0 75.0 74.0 74.0 75.0 73.0 74.0 76.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:123.00 stddev:14.55 (11.8%) stddev-sans-first:15.22 11:45:22 INFO - PROCESS | 24202 | Values: 135.0 121.0 131.0 121.0 120.0 121.0 120.0 122.0 167.0 124.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.50 stddev:2.31 (1.5%) stddev-sans-first:2.24 11:45:22 INFO - PROCESS | 24202 | Values: 159.0 157.0 159.0 155.0 154.0 160.0 155.0 154.0 156.0 154.0 11:45:22 INFO - PROCESS | 24202 | 11:45:22 INFO - PROCESS | 24202 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 11:45:22 INFO - PROCESS | 24202 | Values: 65.0 64.0 62.0 64.0 64.0 64.0 63.0 63.0 62.0 62.0 11:45:22 INFO - PROCESS | 24202 | -------- Summary: end -------- 11:45:22 INFO - PROCESS | 24202 | 11:45:23 INFO - TEST-INFO | 24202: exit 0 11:45:24 INFO - TEST-OK | kraken | took 59952ms 11:45:24 INFO - SUITE-END | took 1174s 11:45:24 INFO - Completed test suite (00:19:34) 11:45:24 INFO - javascript benchmark 11:45:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.839158042098, 3271.918202044947, 3286.0798976286646, 3287.5233091201767, 3316.237265428951, 5590.776368945242, 5628.099504079348, 5645.943540564593, 5662.462066103719, 5676.0, 5658.745356458959, 5733.856653583663, 5741.598088133832, 5742.109972954188, 5769.798057068004, 5144.0740666679985, 5161.793528258865, 5189.974050129744, 5197.246399272103, 5229.86925326868, 5026.623003274769, 5057.848264552069, 5074.061298659742, 5252.107141785887, 5278.762455689484, 5043.117454445457, 5138.691678499284, 5161.200013997836, 5170.017696637627, 5175.197844334134, 5109.591232701394, 5111.0, 5116.897662046738, 5162.74186290684, 5166.147585648364, 4974.955259395531, 4993.001399720034, 5059.418166910816, 5084.084864724348, 5136.948630513684, 5508.14623733322, 5511.696856672881, 5527.309086364205, 5554.416786237427, 5599.076152434844, 5927.911081333784, 5948.078047902582, 5972.343042265347, 6011.0, 6024.759009639609, 5921.0, 6076.118962750376, 6080.0, 6087.391260873921, 6100.572959892809, 5555.0, 5570.777168913239, 5608.971955140239, 5643.153526970905, 5667.631603945731, 6184.226971628546, 6184.288806787277, 6184.5052395808225, 6197.318294987548, 6201.6899155042065, 5743.569232307594, 5937.673427961504, 5938.8218353449465, 5955.731992060368, 5956.285245770535, 5869.06095024794, 5882.117682347682, 5886.205362276123, 5902.586818922634, 5988.0, 5882.029465138205, 5927.081302398135, 5935.40645935403, 5937.643741375531, 5944.167816505693, 5951.583389162717, 5965.940340596539, 5966.761329546856, 5967.224260846149, 6000.33996260411, 4496.235639941217, 4507.053518761031, 4529.501754806968, 4536.274196128604, 4586.6789324747615, 4059.837606495766, 4075.89810254746, 4079.1637714268504, 4080.571539988318, 4105.404716316177, 5554.416786237468, 5651.180578816049, 5656.490915817596, 5665.518430933417, 5686.57350698691, 5833.679147646835, 5875.177475153482, 5988.580799344004, 6005.6997150142315, 6024.728887199999, 5769.509591684669, 5778.306603207558, 5778.566607504454, 5782.306123265235, 5796.507296879812, 5099.898002039939, 5108.591312694975, 5113.846584602468, 5118.820841270538, 5131.076406246912, 6125.2659746757545, 6190.659513726699, 6200.99999999991, 6272.153259310026, 6272.2159730033745, 6119.938800611937, 6128.411459112198, 6176.227971503562, 6181.103739957771, 6182.258129024366, 6290.968545157245, 6297.559170857996, 6312.4634406076, 6328.367163283635, 6336.112944187726, 5786.450287222707, 5844.94155058444, 5845.707714614337, 5974.4324289192455, 5975.9103613446705, 5998.7300571473515, 6116.33577150815, 6129.939558357133, 6138.6336396323695, 6139.3553676863285, 5909.8227053188475, 5931.911021334769, 5935.0503919372695, 5936.22829032223, 5948.434898684618, 5735.311762588349, 5851.034579294369, 5870.765169393348, 5903.144044113494, 5906.616069955439, 5774.162746401664, 5777.39337369587, 5780.364159942319, 5788.450097240755, 5901.7639294427745, 5908.793192238251, 5912.970435147797, 5913.970430147821, 5918.73365698536, 5926.140709596998, 5569.805056822992, 5611.5230205433, 5697.259356283656, 5734.483896449339, 5761.884762304814], "value": 5541.872173362513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9958066651953, 563.4450066684316, 592.4963780786333, 598.1237487081424, 606.0424529243794, 34457.48313775292, 37234.255314893686, 45230.547694523004, 46146.307805382945, 46173.0, 47657.52342476574, 47982.0, 48129.518704812945, 48142.6300158989, 48198.27702584464, 8965.596548155349, 9118.13377729118, 9128.406653567497, 9135.95432022839, 9136.588853501575, 8503.404761666687, 8767.167119123706, 10688.305260158066, 10972.945135274313, 10977.06694930932, 11034.503447344889, 11099.44502774858, 11099.445027748621, 11101.278416902875, 11116.333020018785, 10938.124950003981, 10962.232643714942, 11006.284591501526, 11019.173561982843, 11019.283746556448, 10838.783224335548, 10894.782104357948, 10902.836457453144, 10906.291091079134, 10910.563577456893, 44618.0, 44878.775606122086, 45063.77468112671, 45065.0, 45072.54927450749, 3496.2657841853243, 3586.1751797086554, 3675.8713445029293, 3695.6858667013335, 4128.566500517462, 32444.35111297761, 32627.52935298526, 32632.6736732632, 32988.835055824806, 33394.49908251378, 4371.688398595721, 4397.538258482878, 4425.070735145623, 4426.822927082912, 4521.841735539273, 330572.0, 332672.3366383177, 333274.0, 334818.0, 335166.0, 60922.0, 61446.69276653588, 61470.0, 61503.0, 61563.07655385173, 40256.396154057715, 40986.0, 41259.58740412618, 43202.351964720554, 43241.91895202582, 18294.817051829312, 18516.351927682466, 18523.629527409375, 18537.351192708462, 18543.165557549673, 12040.39798010096, 12373.62879113628, 13719.794203086962, 13869.167849928835, 13917.512887048904, 19752.60494790096, 20561.69157462639, 20679.17283308681, 21475.78524214738, 21518.569628607653, 7249.782506524813, 7463.477556570988, 7464.85070298591, 7582.582957937367, 7631.275028872248, 927.7936650327839, 1020.7499162705185, 1046.49768111307, 1046.9581216751244, 1073.2326386633595, 33465.66534334674, 33492.49761253583, 33766.831165844014, 33936.83031584826, 34003.00929281617, 1116.6650004998469, 1137.6302701622005, 1139.7606502634374, 1215.471269997554, 1219.1405059433077, 17378.826211737975, 17712.114394280492, 17859.196336164903, 17892.731609025876, 18026.729599056023, 516470.0, 517815.0, 519799.0, 523593.0, 524302.0, 62797.0, 63246.0, 63296.367036329044, 63352.0, 63361.0, 1286.903482238817, 1337.806018127366, 1343.147101590497, 1424.6295963049474, 1461.3789139615621, 29805.403891922473, 35299.0, 35432.82283588566, 36270.27459450849, 36332.0, 58740.0, 59219.70390148194, 59382.70308648429, 59391.406085938586, 59398.0, 415689.0, 421598.0, 421602.0, 422486.0, 423588.0, 30453.543196852508, 31443.528347074356, 31449.056528304187, 31455.0, 31492.37015259728, 48818.0, 49577.25634115563, 49660.76526556241, 49797.51417400747, 50215.24677129919, 40691.59308406878, 41242.58757412388, 42048.579514204466, 43505.34741978809, 44158.77920610376, 42112.3683144747, 42390.36414453724, 43376.78311608548, 44305.33541996937, 44932.326015110455, 42351.788241058595, 42575.3613695801, 42681.146377071665, 42825.357619635106, 43687.344689830315, 35726.46410303796, 37940.0, 38002.0, 38438.807805960794, 38803.0, 28724.0, 28952.131436056952, 29072.27319317034, 29092.27269318284, 29223.269418264714], "value": 21023.931050084553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.47401955399323, 401.33378591538053, 404.4136002795945, 405.76465649923045, 425.6722323810666, 14424.855751442508, 18564.90717546412, 19715.211391544355, 20377.28679496218, 20377.59244815105, 15674.843251567481, 16988.0, 18753.0, 19138.521536961583, 19722.21111155552, 5641.492265696097, 5758.568107391941, 5876.9118463223085, 5919.55603329752, 5923.733431995571, 5641.12562552805, 5769.82690519283, 5770.942290577103, 5841.415858414167, 5847.41525847414, 5815.127730840387, 5819.127130930373, 5826.388229235933, 5827.242458480391, 5842.737076831553, 5594.8601284968, 5789.334226563936, 5792.102224155242, 5801.767929282823, 5835.0, 5242.1088414969545, 5244.580433565306, 5253.133233016548, 5253.894922101575, 5258.290130832365, 19456.513587160294, 23905.88047059771, 24007.399815004588, 24069.0, 24239.151629692875, 2654.296611397981, 2795.5247607906704, 2974.1672331747145, 3221.371832492665, 3275.082976766509, 13880.0, 14942.0, 15175.317110730044, 15460.845391546052, 15461.536153915287, 1967.1836187981971, 1982.9603407931904, 2042.8876411797346, 2079.2930403662826, 2115.7672656007826, 88977.55511222467, 89294.5535272326, 89915.0, 90574.5471272646, 91688.0, 10909.236353455182, 10931.836022459669, 10987.670369888916, 11187.105031597453, 11237.60668376603, 15314.923425382802, 15335.079895206323, 15384.30770615325, 15519.301631426613, 15560.98853574514, 7360.595167265852, 7813.453058285865, 7965.960170199112, 8024.879626805603, 8041.3164880984605, 8053.919460805434, 8074.434789564674, 8535.146485351415, 8697.260732837653, 8756.080611535697, 4507.954920450819, 4554.453465584151, 4912.263160525878, 5090.0, 5155.896882062338, 1804.2991688665265, 1824.717168838832, 1887.8017808130223, 2044.294718322206, 2059.773424923257, 838.8322335532796, 872.2062922740403, 886.4548302793736, 889.6708217959397, 913.6573784830689, 17135.314587416615, 17855.73216401755, 18001.909990449964, 18039.54901127456, 18117.09414529268, 935.4854829843558, 960.2318145483586, 964.8263312603799, 965.1217392173089, 966.1449617088927, 10010.249231307682, 10016.164760821333, 10073.899261007442, 10166.745831354126, 10167.644132455329, 372515.0, 373126.0, 375211.0, 452505.0, 491451.0, 98741.0, 102275.4886225579, 103018.48490757648, 104155.4792226034, 106775.46612267045, 1060.8620879285643, 1091.2415870969758, 1096.3038470571244, 1134.8070827959266, 1141.6289705845634, 17561.209745561737, 17693.203805829027, 17873.463796086136, 17907.194176261837, 18329.725054123934, 41790.0, 41925.371119432624, 42875.0, 43413.565864342214, 43899.0, 57190.42809571851, 57379.71310143422, 60034.39965600288, 60455.69772151111, 65596.0, 8116.918830811616, 8327.666893324442, 8412.411131220755, 8436.704715334934, 8441.029281632691, 11811.468483918072, 12757.617271481871, 13148.145370550883, 13373.598792036255, 13451.798223026466, 11178.664640060812, 11330.320180789178, 11463.598774042868, 11592.47833847462, 11793.764124717629, 8091.797705057421, 11021.393823339793, 11056.281341712764, 11221.0, 11576.189666723249, 10777.838332424863, 11250.718732031437, 11346.60286889988, 11579.189456737948, 11739.23694959825, 8083.959580202061, 8116.75649730509, 8261.297789687944, 8546.017208021158, 8591.183837535424, 10860.837087443537, 11464.31214127155, 11613.245139065933, 11665.35840528779, 11814.94092529532], "value": 9308.440889847037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.1591560979023, 1503.008014710291, 1623.8376162383763, 1724.1120822776265, 1805.9277628894854, 8240.134785847482, 8771.561421928895, 8773.956130219356, 8777.166169213922, 8777.648894044247, 7473.290037446447, 7695.846083078335, 8284.710035148772, 8495.065542790288, 8509.489430634167, 2428.6114221724483, 2452.852828830267, 2457.0785955266774, 2457.2751038443703, 2459.6802415685934, 2445.2664200739796, 2467.444824914398, 2468.9753102469017, 2471.0733474946896, 2475.220305603738, 2412.6501657259773, 2415.2271273192587, 2443.1082654831034, 2455.7789798918093, 2467.0501856785177, 2373.8338316317863, 2375.5130198309307, 2395.0659242895285, 2403.098837935774, 2404.1104791227185, 2414.806815454777, 2422.3338581889943, 2442.548128596198, 2443.0, 2443.4624382635793, 8337.291330236938, 8494.660213591449, 8495.36284778644, 8498.447600905922, 8504.532250726208, 5290.1800220965815, 5444.047291723932, 5451.2640793492765, 5452.972735136299, 5455.645383050129, 3533.9293214135832, 3563.198280386918, 3573.6605022523077, 3603.79262456414, 3647.288778688157, 1104.7735214281054, 1112.2992514715759, 1116.5924437580225, 1179.55177032727, 2141.967870481944, 11438.370889601068, 11880.049596032297, 11914.106442016884, 11919.046476281963, 11922.523099076026, 4594.104149690845, 4621.861344159681, 4658.0, 4693.671442999025, 4716.528347165256, 9660.37207581519, 9663.082007209305, 9664.420134791935, 9665.0, 9670.56482458291, 5299.5230429261555, 5349.973250133725, 5354.651947623392, 5364.007658583175, 5364.651297665718, 4337.436133302714, 4537.3647689323525, 4696.201645720235, 4768.570828625371, 5017.57350625201, 3851.5185601799776, 3928.64642182205, 3929.44987701722, 4030.8109107813266, 4038.030872590557, 1182.6984119049587, 1202.5250026239587, 1209.879012098783, 1211.7273613436905, 1216.3735676126803, 842.6334544473051, 1009.5810238750836, 1017.0, 1017.862588550551, 1021.5147804792813, 5681.801136960186, 5716.79991200306, 5798.275215598051, 5822.7088645567555, 5891.322497912709, 429.1053154173583, 448.72627697105395, 468.4753076554213, 468.80778880658767, 484.9030193961222, 3968.1865217630316, 3968.404739289072, 4023.7384570002855, 4026.275270451288, 4028.5165780106577, 10072.949635251924, 10536.894631053592, 10590.417527036087, 10602.893971060344, 10604.89395106039, 10357.067863892285, 10389.896101039045, 10482.213833962483, 10482.266241363031, 10487.475626218658, 7770.650320735581, 8056.0332760067995, 8194.50832950025, 8208.056073551617, 8212.589370531568, 5897.3807750185615, 5999.730012149376, 6045.0, 6063.636181829104, 6065.029595264737, 9425.0, 9631.614735410505, 9664.516774161404, 9751.268654851056, 9760.853587196056, 9404.623815047322, 9552.331336806357, 9621.9037809621, 9899.109080182818, 10025.5488503019, 7431.591262480615, 7598.848023039619, 7654.2345765423015, 7737.264959828807, 7899.921000789918, 8363.163683631588, 8424.578771061544, 8433.831323373375, 8435.367347448842, 8443.071262161035, 7235.421166306577, 7292.0520332356455, 7304.5252058616015, 7325.523840950321, 7509.51188172767, 7353.374963128194, 7431.554106753612, 7436.367908727819, 7470.252974702486, 7501.437392195717, 6968.338007889242, 7095.929040709527, 7102.822429439306, 7109.075820143556, 7128.358447739728, 5197.948020519746, 5283.524482796567, 5290.391604965478, 5291.788328466818, 5454.372747134131, 5341.599380046589, 5377.462253774747, 5429.267048948342, 5456.91814622773, 5467.6719396836315], "value": 4553.963813183702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.5574129830185, 329.9307145499446, 346.29528908670846, 353.60043151239097, 365.27492926540793, 5297.152455607104, 5460.153676180198, 5497.972510137449, 5502.504774570288, 5510.91733623996, 5249.711265880375, 5365.839024829252, 5370.3287089113865, 5398.190271459283, 5430.864228394292, 4243.08773613673, 4264.55222201669, 4274.658027357819, 4282.015136518595, 4304.440422745039, 4117.649999750025, 4198.8320467181275, 4201.243776120297, 4205.747655140686, 4219.725717828347, 4169.874903752892, 4176.498820141587, 4184.623383895449, 4185.142045880587, 4196.097838964622, 4190.916181676364, 4203.642690371322, 4208.242516347056, 4210.305299625588, 4213.662906967435, 3687.4100143977103, 3759.755615884959, 3767.2842159989787, 3768.2275133597823, 3771.5474143103, 5237.8428647140645, 5258.76419041525, 5262.105442074818, 5273.578113750891, 5295.4704529547125, 4842.927356089662, 4863.8784030399165, 4868.0, 4873.634477414173, 4883.755812209411, 5525.171224316345, 5654.9151762723595, 5666.320041595035, 5683.630564013326, 5714.771409143629, 4132.504099508048, 4134.028503301722, 4137.731047481904, 4139.530466684344, 4160.126373461547, 5878.735456904449, 5914.935311643945, 5924.496417804492, 5935.910961335583, 5949.851253718692, 4160.335865653763, 4199.496060472763, 4232.090100628318, 4238.21593005295, 4251.936220956688, 4280.422143010654, 4283.635890949305, 4293.205756934977, 4297.742135471882, 4308.827646894152, 4875.756212189376, 4892.0, 4899.240617704261, 4902.607791376753, 4903.485134060944, 5533.889322213614, 5662.546996240373, 5683.971580142155, 5713.257276554022, 5719.3136823581435, 1322.1604281281454, 1339.8124262603244, 1343.2209318595192, 1354.6951935814363, 1369.4111532041318, 981.5435822342645, 988.1008282462924, 1010.2776514791959, 1013.3160116921049, 1017.2574020964737, 5368.403169876192, 5374.731263436813, 5395.190721391744, 5396.163594642837, 5437.803683189692, 5511.988124334589, 5529.751161197756, 5583.832485025456, 5601.6556026553335, 5653.604247702621, 5267.762950667229, 5273.0, 5288.788448462018, 5294.364676238876, 5307.840764777063, 2914.7993265085147, 2964.9407011859644, 2991.0, 2999.6850330715397, 3011.7590592752526, 5801.6519008859605, 5810.94189058104, 5850.707464626752, 5850.707464626837, 5855.736491857877, 5721.598208438959, 5722.7424765885635, 5735.426457354231, 5743.885122297531, 5787.681677507693, 5431.945680543144, 5742.454466825645, 5774.220480235199, 5807.303123625192, 5844.824655260349, 5568.9443105568425, 5610.85972850682, 5619.971900140473, 5638.182463542846, 5645.080672571181, 5534.944650553443, 5543.501084902378, 5563.193336966036, 5575.7490912909825, 5602.747876345493, 5502.972485137549, 5756.884862302814, 5768.365479797135, 5785.27684039495, 5795.217645617788, 4079.4288799568676, 4080.7347522410946, 4105.774182419996, 4153.501579810442, 4157.293260145843, 5423.83728488146, 5711.8857622848145, 5715.342735585461, 5715.657060576379, 5717.42825717425, 5437.265969094122, 5449.0, 5456.508914197741, 5474.507294343528, 5522.447755224445, 5398.595105367034, 5417.458254174551, 5435.103207970798, 5444.346678398618, 5446.863828404322, 5546.722663866871, 5578.944210557843, 5592.0, 5646.153077038477, 5660.943390566042, 5665.773369065356, 5678.290213723285, 5683.868549294015, 5699.572532060195, 5702.7718891243885, 5468.95627525116, 5578.386377498553, 5592.496675299242, 5597.608167428404, 5609.382967873449], "value": 4286.003668998472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.3999040805726, 749.1796482851278, 752.1200195770947, 809.5264270401815, 867.8611422172454, 15820.683586328281, 16571.91714041428, 16600.169991500406, 16601.41895033674, 16631.50105496834, 14895.10629362239, 15094.320755566, 15170.84829151708, 15201.771973420407, 15212.315445804938, 722.801229661842, 748.5471289869632, 835.4945258118811, 836.8828364029041, 861.6122744764881, 862.874883141944, 864.8745931839879, 865.2169786343338, 866.0819531296845, 867.6616119713317, 922.575615217001, 923.8244733500647, 924.0436148586181, 925.0887875442717, 925.7500474871781, 922.2069020642242, 923.4920793563581, 923.7967647117623, 924.7503174143011, 924.8936372317169, 677.4546490075487, 677.7526202935942, 678.281022116558, 678.2979616097365, 679.4190966723479, 14143.080699754586, 14359.569212923629, 14447.422103115863, 14558.4904528341, 15671.138087405188, 14065.5077072303, 14712.852871471256, 14718.632034199123, 14751.409943602242, 14772.409103635842, 11565.53737850485, 11609.535618575246, 11758.059355251646, 11768.0, 11783.941080294544, 3785.3943369061094, 3841.9807900960595, 3873.0, 3876.089119057019, 3906.8046597670286, 61830.381696182914, 62622.0, 62912.37087629111, 62973.68513157451, 63736.0, 11155.219134660496, 11222.831657525143, 11300.94349528247, 11388.430578471043, 11466.885331146748, 21713.0, 21715.891420542797, 21727.13091476323, 21737.23919662804, 21871.234506792185, 8426.368022398345, 8426.662933482592, 8482.660693572312, 8596.312295016383, 8652.956735216283, 4608.331791890158, 4630.9536904631195, 4637.930431043537, 4660.414890593948, 4710.9764451177525, 3519.665631764978, 3637.5453068366455, 3638.0541059324764, 3647.8176091195332, 3652.5251717277115, 603.5744799916049, 613.929398119213, 614.241411856357, 619.2321521313539, 623.1649589550025, 662.5428454366472, 697.9511434199558, 709.9680514376865, 748.4386709967524, 751.8496300739874, 9389.436633801994, 9524.476153811469, 9774.804503910023, 10254.128399086012, 10414.843777343194, 632.3170975346615, 665.6937808608094, 741.1439787045971, 741.7663436017638, 742.2429122295229, 4584.266517357207, 4629.259318509023, 4668.486466488684, 4684.906301873943, 4709.105269998689, 66925.66537167283, 90740.5462972681, 94547.0, 94657.59980855917, 96627.0, 78736.21263787289, 80108.59945700351, 81112.91653126039, 82003.58998204971, 82850.58574707087, 65505.672471637336, 71535.6423217891, 72297.0, 72822.63588682128, 74747.25252747403, 8991.460512369278, 9101.362904596615, 9118.908810911806, 9185.540722963691, 9280.72157835266, 49661.25508117453, 50030.49969500258, 51229.694663740964, 52182.95634087221, 52363.47636523586, 40174.79912600418, 62340.68829656004, 64236.50344475842, 65545.34454655583, 66493.66753166204, 11442.427878606202, 11449.656510304705, 11559.595414160463, 11726.706832328919, 11839.82240266414, 12061.0, 12379.133460657667, 12837.743245135232, 12882.806757898827, 13262.602121936357, 11590.246633968765, 11893.226940248856, 11934.343611101473, 12546.12177147591, 12940.611781646565, 12129.393530323625, 12429.44067516982, 12445.0, 12495.625131246077, 12703.745925081632, 12372.876271237532, 12388.752224955631, 12474.938739140192, 12508.186967847061, 12624.368781561068, 10134.543945522617, 10497.580096796348, 10603.173969856276, 10656.786864262827, 10905.345679258953, 10185.541650625592, 10259.333143345659, 10322.638707645196, 10327.948360258151, 10583.5237414315], "value": 7269.584841617024, "unit": "score"}], "name": "dromaeo_css", "value": 7320.502177194631, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 113.0, 113.0, 113.0, 111.0, 109.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 116.0, 158.0, 119.0, 120.0, 120.0, 122.0, 148.0, 120.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 102.0, 76.0, 75.0, 75.0, 75.0, 103.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 120.0, 81.0, 82.0, 82.0, 97.0, 82.0, 82.0, 105.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 50.0, 49.0, 50.0, 49.0, 50.0, 50.0, 50.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 74.0, 74.0, 75.0, 73.0, 74.0, 76.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 121.0, 131.0, 121.0, 120.0, 121.0, 120.0, 122.0, 167.0, 124.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 155.0, 154.0, 160.0, 155.0, 154.0, 156.0, 154.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 64.0, 64.0, 64.0, 63.0, 63.0, 62.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1449.5, "alertThreshold": 2.0}]} 11:45:24 INFO - Return code: 0 11:45:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:24 INFO - # TBPL SUCCESS # 11:45:24 INFO - Running post-action listener: _resource_record_post_action 11:45:24 INFO - [mozharness: 2017-02-06 19:45:24.237446Z] Finished run-tests step (success) 11:45:24 INFO - Running post-run listener: _resource_record_post_run 11:45:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320876544; Read time: 4; Write time: 149580 11:45:24 INFO - TinderboxPrint: CPU usage
13.0% 11:45:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 11:45:24 INFO - TinderboxPrint: I/O write bytes / time
320,876,544 / 149,580 11:45:24 INFO - TinderboxPrint: CPU idle
8,251.4 (87.0%) 11:45:24 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 11:45:24 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:24 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101249024; Read time: 0; Write time: 47788 11:45:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219627520; Read time: 4; Write time: 101792 11:45:24 INFO - Running post-run listener: _upload_blobber_files 11:45:24 INFO - Blob upload gear active. 11:45:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:24 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 11:45:24 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'] 11:45:24 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 11:45:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:27 INFO - (blobuploader) - INFO - Done attempting. 11:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:30 INFO - (blobuploader) - INFO - Done attempting. 11:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:31 INFO - (blobuploader) - INFO - Done attempting. 11:45:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:31 INFO - Return code: 0 11:45:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8680818da015f62d98abc7333ee8edb5c766cf95113c8406018c82f54e996598ceb96710e56b6879457d30238253e576ac33ca1ebb5c481bbacc476df23addcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95362959f4e9f360f2b0e57e7e1efc6ade164f1db744244fe2141f0117d18907045b22af30e335f95f8ef3b55855e30cb9f907aec158036f770ee3476631b75a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d17a84641f6348713b8f89aa58ed23797f37bec4a6d4fd950eb868be743e9e77124017f1488cdb90406c9b9f9e759aec66da5fe0dbe6542a2a8d78e724cb8b98"} 11:45:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:31 INFO - Contents: 11:45:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8680818da015f62d98abc7333ee8edb5c766cf95113c8406018c82f54e996598ceb96710e56b6879457d30238253e576ac33ca1ebb5c481bbacc476df23addcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95362959f4e9f360f2b0e57e7e1efc6ade164f1db744244fe2141f0117d18907045b22af30e335f95f8ef3b55855e30cb9f907aec158036f770ee3476631b75a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d17a84641f6348713b8f89aa58ed23797f37bec4a6d4fd950eb868be743e9e77124017f1488cdb90406c9b9f9e759aec66da5fe0dbe6542a2a8d78e724cb8b98"} 11:45:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:31 INFO - Copying logs to upload dir... 11:45:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.395581 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 11:45:30.256965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:30.260055) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 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/8680818da015f62d98abc7333ee8edb5c766cf95113c8406018c82f54e996598ceb96710e56b6879457d30238253e576ac33ca1ebb5c481bbacc476df23addcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95362959f4e9f360f2b0e57e7e1efc6ade164f1db744244fe2141f0117d18907045b22af30e335f95f8ef3b55855e30cb9f907aec158036f770ee3476631b75a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d17a84641f6348713b8f89aa58ed23797f37bec4a6d4fd950eb868be743e9e77124017f1488cdb90406c9b9f9e759aec66da5fe0dbe6542a2a8d78e724cb8b98"} build_url:https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/e_SC2ZqLTv2LqHeDrozCTw/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/8680818da015f62d98abc7333ee8edb5c766cf95113c8406018c82f54e996598ceb96710e56b6879457d30238253e576ac33ca1ebb5c481bbacc476df23addcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/95362959f4e9f360f2b0e57e7e1efc6ade164f1db744244fe2141f0117d18907045b22af30e335f95f8ef3b55855e30cb9f907aec158036f770ee3476631b75a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d17a84641f6348713b8f89aa58ed23797f37bec4a6d4fd950eb868be743e9e77124017f1488cdb90406c9b9f9e759aec66da5fe0dbe6542a2a8d78e724cb8b98"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:30.284771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:30.285087) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1486409096.861431-1868326006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 11:45:30.368519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 11:45:30.368863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 11:45:30.369159) ========= ========= Total master_lag: 0.16 =========