builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1487032508.73 results: success (0) buildid: 20170213142824 builduid: 7b6857ead8fa4fc0a490f813bd308f9d revision: 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.727055) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.727515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.727787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.740958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.741237) ========= 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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-13 16:35:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2017-02-13 16:35:09 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.872001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.872307) ========= 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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020709 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:08.921679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 16:35:08.922036) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c --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 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c --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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-13 16:35:09,300 truncating revision to first 12 chars 2017-02-13 16:35:09,300 Setting DEBUG logging. 2017-02-13 16:35:09,300 attempt 1/10 2017-02-13 16:35:09,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3ea27580c85d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 16:35:10,650 unpacking tar archive at: mozilla-beta-3ea27580c85d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724618 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 16:35:10.659739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:10.660175) ========= script_repo_revision: 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:10.660555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:10.660820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 16:35:10.668562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-13 16:35:10.668921) ========= /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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:35:11 INFO - MultiFileLogger online at 20170213 16:35:11 in /builds/slave/test 16:35:11 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 16:35:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:11 INFO - {'append_to_log': False, 16:35:11 INFO - 'base_work_dir': '/builds/slave/test', 16:35:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:35:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:11 INFO - 'branch': 'Mozilla-Beta', 16:35:11 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:11 INFO - 'config_files': ('talos/linux_config.py',), 16:35:11 INFO - 'default_actions': ('clobber', 16:35:11 INFO - 'read-buildbot-config', 16:35:11 INFO - 'download-and-extract', 16:35:11 INFO - 'populate-webroot', 16:35:11 INFO - 'create-virtualenv', 16:35:11 INFO - 'install', 16:35:11 INFO - 'run-tests'), 16:35:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:11 INFO - 'download_minidump_stackwalk': True, 16:35:11 INFO - 'download_symbols': 'ondemand', 16:35:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:11 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:11 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:11 INFO - 'installer_path': 'installer.exe', 16:35:11 INFO - 'log_level': 'info', 16:35:11 INFO - 'log_name': 'talos', 16:35:11 INFO - 'log_to_console': True, 16:35:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:35:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:35:11 INFO - 'opt_config_files': (), 16:35:11 INFO - 'pip_index': False, 16:35:11 INFO - 'sps_profile': False, 16:35:11 INFO - 'sps_profile_interval': 0, 16:35:11 INFO - 'suite': 'dromaeojs', 16:35:11 INFO - 'system_bits': '32', 16:35:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:11 INFO - 'title': 'talos-linux64-ix-018', 16:35:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:11 INFO - 'use_talos_json': True, 16:35:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:11 INFO - 'work_dir': 'build'} 16:35:11 INFO - [mozharness: 2017-02-14 00:35:11.134604Z] Running clobber step. 16:35:11 INFO - Running pre-action listener: _resource_record_pre_action 16:35:11 INFO - Running main action method: clobber 16:35:11 INFO - rmtree: /builds/slave/test/build 16:35:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:12 INFO - Running post-action listener: _resource_record_post_action 16:35:12 INFO - [mozharness: 2017-02-14 00:35:12.056510Z] Finished clobber step (success) 16:35:12 INFO - [mozharness: 2017-02-14 00:35:12.056610Z] Running read-buildbot-config step. 16:35:12 INFO - Running pre-action listener: _resource_record_pre_action 16:35:12 INFO - Running main action method: read_buildbot_config 16:35:12 INFO - Using buildbot properties: 16:35:12 INFO - { 16:35:12 INFO - "project": "", 16:35:12 INFO - "product": "firefox", 16:35:12 INFO - "script_repo_revision": "production", 16:35:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:35:12 INFO - "repository": "", 16:35:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:35:12 INFO - "buildid": "20170213142824", 16:35:12 INFO - "pgo_build": "True", 16:35:12 INFO - "basedir": "/builds/slave/test", 16:35:12 INFO - "buildnumber": 137, 16:35:12 INFO - "slavename": "talos-linux64-ix-018", 16:35:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:35:12 INFO - "platform": "ubuntu64_hw", 16:35:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:35:12 INFO - "branch": "mozilla-beta", 16:35:12 INFO - "repo_path": "releases/mozilla-beta", 16:35:12 INFO - "revision": "3ea27580c85dad05759fbd7ab6aac3ea9a355c2c", 16:35:12 INFO - "stage_platform": "linux64-pgo", 16:35:12 INFO - "builduid": "7b6857ead8fa4fc0a490f813bd308f9d", 16:35:12 INFO - "slavebuilddir": "test" 16:35:12 INFO - } 16:35:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 16:35:12 INFO - Running post-action listener: _resource_record_post_action 16:35:12 INFO - [mozharness: 2017-02-14 00:35:12.059111Z] Finished read-buildbot-config step (success) 16:35:12 INFO - [mozharness: 2017-02-14 00:35:12.059200Z] Running download-and-extract step. 16:35:12 INFO - Running pre-action listener: _resource_record_pre_action 16:35:12 INFO - Running main action method: download_and_extract 16:35:12 INFO - mkdir: /builds/slave/test/build/tests 16:35:12 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')]} 16:35:12 INFO - trying https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:35:12 INFO - Downloading https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/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 16:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/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 16:35:12 INFO - Downloaded 1327 bytes. 16:35:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:35:12 INFO - Using the following test package requirements: 16:35:12 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:35:12 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:35:12 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 16:35:12 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'jsshell-linux-x86_64.zip'], 16:35:12 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:35:12 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:35:12 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 16:35:12 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 16:35:12 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:35:12 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:35:12 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:35:12 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:35:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:35:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:35:12 INFO - Fetch https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:35:13 INFO - Http code: 200 16:35:13 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 16:35:13 INFO - x-amz-cf-id: 5cNKX5cqnS2Sxjg3T9kC-KMbSujoBndjCAKhkYvYec-t5FILS8hfSw== 16:35:13 INFO - x-amz-version-id: 1_JEISUeLTj8cnWyRwnt6dEFw93y5cMb 16:35:15 INFO - Expected file size: 21958758 16:35:15 INFO - Obtained file size: 21958758 16:35:19 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 16:35:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:35:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:35:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:35:20 INFO - Http code: 200 16:35:20 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 16:35:20 INFO - x-amz-cf-id: E8yx0jPqD0f7IVi4iTOYtV1-DjlRn7TB_2kHD2UXE_k_-fci_LS5NQ== 16:35:20 INFO - x-amz-version-id: 1_JEISUeLTj8cnWyRwnt6dEFw93y5cMb 16:35:21 INFO - Expected file size: 21958758 16:35:21 INFO - Obtained file size: 21958758 16:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 16:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 16:35:26 INFO - Http code: 200 16:35:26 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 16:35:26 INFO - x-amz-cf-id: Xnfq4AvMeqBlisPCKnkFA4A0ay6G7rer8pDDi5-98wGeO_XOO7vzTw== 16:35:26 INFO - x-amz-version-id: sZpJmNbNL3cIQ1eSW8hYAZv0FJMaL0jT 16:35:27 INFO - Expected file size: 14403005 16:35:27 INFO - Obtained file size: 14403005 16:35: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')]} 16:35:27 INFO - trying https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/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 16:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/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 16:35:29 INFO - Downloaded 57742950 bytes. 16:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:35:29 INFO - mkdir: /builds/slave/test/properties 16:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:29 INFO - Contents: 16:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:35:30 INFO - Running post-action listener: _resource_record_post_action 16:35:30 INFO - Running post-action listener: set_extra_try_arguments 16:35:30 INFO - [mozharness: 2017-02-14 00:35:30.496616Z] Finished download-and-extract step (success) 16:35:30 INFO - [mozharness: 2017-02-14 00:35:30.496842Z] Running populate-webroot step. 16:35:30 INFO - Running pre-action listener: _resource_record_pre_action 16:35:30 INFO - Running main action method: populate_webroot 16:35:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:30 INFO - '--tppagecycles', 16:35:30 INFO - '7'], 16:35:30 INFO - 'tests': ['tsvgm']}}, 16:35:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:35:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:35:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['damp', 'tps']}, 16:35:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'tests': ['damp', 'tps']}, 16:35:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['dromaeo_dom']}, 16:35:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['basic_compositor_video']}, 16:35:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:35:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'other-e10s': {'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['a11yr', 16:35:30 INFO - 'ts_paint', 16:35:30 INFO - 'tpaint', 16:35:30 INFO - 'sessionrestore', 16:35:30 INFO - 'sessionrestore_no_auto_restore', 16:35:30 INFO - 'tabpaint']}, 16:35:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['tsvgx', 16:35:30 INFO - 'tsvgr_opacity', 16:35:30 INFO - 'tart', 16:35:30 INFO - 'tscrollx', 16:35:30 INFO - 'cart']}, 16:35:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:35:30 INFO - 'tsvgr_opacity', 16:35:30 INFO - 'tart', 16:35:30 INFO - 'tscrollx', 16:35:30 INFO - 'cart']}, 16:35:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'talos_options': ['--disable-e10s'], 16:35:30 INFO - 'tests': ['tp5o']}, 16:35:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'tests': ['tp5o']}, 16:35:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'talos_options': ['--disable-e10s', 16:35:30 INFO - '--xperf_path', 16:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:30 INFO - 'tests': ['tp5n']}, 16:35:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:30 INFO - 'talos_options': ['--xperf_path', 16:35:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:30 INFO - 'tests': ['tp5n']}}, 16:35:30 INFO - 'talos.zip': {'path': '', 16:35:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:30 INFO - Running post-action listener: _resource_record_post_action 16:35:30 INFO - [mozharness: 2017-02-14 00:35:30.518555Z] Finished populate-webroot step (success) 16:35:30 INFO - [mozharness: 2017-02-14 00:35:30.518643Z] Running create-virtualenv step. 16:35:30 INFO - Running pre-action listener: _resource_record_pre_action 16:35:30 INFO - Running main action method: create_virtualenv 16:35:30 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:30 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 16:35:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:30 INFO - Using real prefix '/usr' 16:35:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:33 INFO - Installing pip.................done. 16:35:33 INFO - Return code: 0 16:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:35:33 INFO - Reading from file tmpfile_stdout 16:35:33 INFO - Output received: 16:35:33 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) 16:35:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:33 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:33 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 16:35:33 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 16:35:33 INFO - Using env: {'DISPLAY': ':0', 16:35:33 INFO - 'HOME': '/home/cltbld', 16:35:33 INFO - 'LANG': 'en_US.UTF-8', 16:35:33 INFO - 'LANGUAGE': 'en_US:en', 16:35:33 INFO - 'LOGNAME': 'cltbld', 16:35:33 INFO - 'MAIL': '/var/mail/cltbld', 16:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:33 INFO - 'MOZ_NO_REMOTE': '1', 16:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:33 INFO - 'NO_EM_RESTART': '1', 16:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:33 INFO - 'PWD': '/builds/slave/test', 16:35:33 INFO - 'SHELL': '/bin/bash', 16:35:33 INFO - 'SHLVL': '1', 16:35:33 INFO - 'TERM': 'linux', 16:35:33 INFO - 'TMOUT': '86400', 16:35:33 INFO - 'USER': 'cltbld', 16:35:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:33 INFO - '_': '/tools/buildbot/bin/python'} 16:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:33 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 16:35:33 INFO - Cleaning up... 16:35:33 INFO - Return code: 0 16:35:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:33 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:33 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 16:35:33 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 16:35:33 INFO - Using env: {'DISPLAY': ':0', 16:35:33 INFO - 'HOME': '/home/cltbld', 16:35:33 INFO - 'LANG': 'en_US.UTF-8', 16:35:33 INFO - 'LANGUAGE': 'en_US:en', 16:35:33 INFO - 'LOGNAME': 'cltbld', 16:35:33 INFO - 'MAIL': '/var/mail/cltbld', 16:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:33 INFO - 'MOZ_NO_REMOTE': '1', 16:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:33 INFO - 'NO_EM_RESTART': '1', 16:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:33 INFO - 'PWD': '/builds/slave/test', 16:35:33 INFO - 'SHELL': '/bin/bash', 16:35:33 INFO - 'SHLVL': '1', 16:35:33 INFO - 'TERM': 'linux', 16:35:33 INFO - 'TMOUT': '86400', 16:35:33 INFO - 'USER': 'cltbld', 16:35:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:33 INFO - '_': '/tools/buildbot/bin/python'} 16:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:33 INFO - Downloading/unpacking psutil>=3.1.1 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:35 INFO - Installing collected packages: psutil 16:35:35 INFO - Running setup.py install for psutil 16:35:35 INFO - building 'psutil._psutil_linux' extension 16:35:35 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 16:35:36 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 16:35:36 INFO - building 'psutil._psutil_posix' extension 16:35:36 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 16:35:36 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 16:35:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:36 INFO - Successfully installed psutil 16:35:36 INFO - Cleaning up... 16:35:36 INFO - Return code: 0 16:35:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:35:36 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')]} 16:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:36 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')]} 16:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:36 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:36 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 16:35:36 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 16:35:36 INFO - Using env: {'DISPLAY': ':0', 16:35:36 INFO - 'HOME': '/home/cltbld', 16:35:36 INFO - 'LANG': 'en_US.UTF-8', 16:35:36 INFO - 'LANGUAGE': 'en_US:en', 16:35:36 INFO - 'LOGNAME': 'cltbld', 16:35:36 INFO - 'MAIL': '/var/mail/cltbld', 16:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:36 INFO - 'MOZ_NO_REMOTE': '1', 16:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:36 INFO - 'NO_EM_RESTART': '1', 16:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:36 INFO - 'PWD': '/builds/slave/test', 16:35:36 INFO - 'SHELL': '/bin/bash', 16:35:36 INFO - 'SHLVL': '1', 16:35:36 INFO - 'TERM': 'linux', 16:35:36 INFO - 'TMOUT': '86400', 16:35:36 INFO - 'USER': 'cltbld', 16:35:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:36 INFO - '_': '/tools/buildbot/bin/python'} 16:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:35:36 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 16:35:36 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 16:35:36 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 16:35:36 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 16:35:36 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 16:35:36 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 16:35:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:35:38 INFO - Installing collected packages: mozsystemmonitor 16:35:38 INFO - Running setup.py install for mozsystemmonitor 16:35:38 INFO - Successfully installed mozsystemmonitor 16:35:38 INFO - Cleaning up... 16:35:38 INFO - Return code: 0 16:35:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:38 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:38 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 16:35:38 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 16:35:38 INFO - Using env: {'DISPLAY': ':0', 16:35:38 INFO - 'HOME': '/home/cltbld', 16:35:38 INFO - 'LANG': 'en_US.UTF-8', 16:35:38 INFO - 'LANGUAGE': 'en_US:en', 16:35:38 INFO - 'LOGNAME': 'cltbld', 16:35:38 INFO - 'MAIL': '/var/mail/cltbld', 16:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:38 INFO - 'MOZ_NO_REMOTE': '1', 16:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:38 INFO - 'NO_EM_RESTART': '1', 16:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:38 INFO - 'PWD': '/builds/slave/test', 16:35:38 INFO - 'SHELL': '/bin/bash', 16:35:38 INFO - 'SHLVL': '1', 16:35:38 INFO - 'TERM': 'linux', 16:35:38 INFO - 'TMOUT': '86400', 16:35:38 INFO - 'USER': 'cltbld', 16:35:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:38 INFO - '_': '/tools/buildbot/bin/python'} 16:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:39 INFO - Downloading/unpacking jsonschema==2.5.1 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:39 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 16:35:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:35:41 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 16:35:41 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 16:35:41 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 16:35:41 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 16:35:41 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 16:35:41 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 16:35:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:41 INFO - warning: no files found matching '*.txt' 16:35:41 INFO - no previously-included directories found matching 'build' 16:35:41 INFO - no previously-included directories found matching 'dist' 16:35:41 INFO - no previously-included directories found matching '.git*' 16:35:41 INFO - Installing collected packages: jsonschema, functools32 16:35:41 INFO - Running setup.py install for functools32 16:35:41 INFO - warning: no files found matching '*.txt' 16:35:41 INFO - no previously-included directories found matching 'build' 16:35:41 INFO - no previously-included directories found matching 'dist' 16:35:41 INFO - no previously-included directories found matching '.git*' 16:35:41 INFO - Successfully installed jsonschema functools32 16:35:41 INFO - Cleaning up... 16:35:41 INFO - Return code: 0 16:35:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:35:41 INFO - Using env: {'DISPLAY': ':0', 16:35:41 INFO - 'HOME': '/home/cltbld', 16:35:41 INFO - 'LANG': 'en_US.UTF-8', 16:35:41 INFO - 'LANGUAGE': 'en_US:en', 16:35:41 INFO - 'LOGNAME': 'cltbld', 16:35:41 INFO - 'MAIL': '/var/mail/cltbld', 16:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:41 INFO - 'MOZ_NO_REMOTE': '1', 16:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:41 INFO - 'NO_EM_RESTART': '1', 16:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:41 INFO - 'PWD': '/builds/slave/test', 16:35:41 INFO - 'SHELL': '/bin/bash', 16:35:41 INFO - 'SHLVL': '1', 16:35:41 INFO - 'TERM': 'linux', 16:35:41 INFO - 'TMOUT': '86400', 16:35:41 INFO - 'USER': 'cltbld', 16:35:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:41 INFO - '_': '/tools/buildbot/bin/python'} 16:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:35:41 INFO - Cleaning up... 16:35:41 INFO - Return code: 0 16:35:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:35:41 INFO - Using env: {'DISPLAY': ':0', 16:35:41 INFO - 'HOME': '/home/cltbld', 16:35:41 INFO - 'LANG': 'en_US.UTF-8', 16:35:41 INFO - 'LANGUAGE': 'en_US:en', 16:35:41 INFO - 'LOGNAME': 'cltbld', 16:35:41 INFO - 'MAIL': '/var/mail/cltbld', 16:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:41 INFO - 'MOZ_NO_REMOTE': '1', 16:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:41 INFO - 'NO_EM_RESTART': '1', 16:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:41 INFO - 'PWD': '/builds/slave/test', 16:35:41 INFO - 'SHELL': '/bin/bash', 16:35:41 INFO - 'SHLVL': '1', 16:35:41 INFO - 'TERM': 'linux', 16:35:41 INFO - 'TMOUT': '86400', 16:35:41 INFO - 'USER': 'cltbld', 16:35:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:41 INFO - '_': '/tools/buildbot/bin/python'} 16:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:35:42 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 16:35:42 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 16:35:42 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 16:35:42 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 16:35:42 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 16:35:42 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 16:35:44 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:44 INFO - Downloading docopt-0.6.1.tar.gz 16:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:44 INFO - Running setup.py install for blobuploader 16:35:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:44 INFO - Running setup.py install for requests 16:35:45 INFO - Running setup.py install for docopt 16:35:45 INFO - Successfully installed blobuploader requests docopt 16:35:45 INFO - Cleaning up... 16:35:45 INFO - Return code: 0 16:35:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:45 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:45 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 16:35:45 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 16:35:45 INFO - Using env: {'DISPLAY': ':0', 16:35:45 INFO - 'HOME': '/home/cltbld', 16:35:45 INFO - 'LANG': 'en_US.UTF-8', 16:35:45 INFO - 'LANGUAGE': 'en_US:en', 16:35:45 INFO - 'LOGNAME': 'cltbld', 16:35:45 INFO - 'MAIL': '/var/mail/cltbld', 16:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:45 INFO - 'MOZ_NO_REMOTE': '1', 16:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:45 INFO - 'NO_EM_RESTART': '1', 16:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:45 INFO - 'PWD': '/builds/slave/test', 16:35:45 INFO - 'SHELL': '/bin/bash', 16:35:45 INFO - 'SHLVL': '1', 16:35:45 INFO - 'TERM': 'linux', 16:35:45 INFO - 'TMOUT': '86400', 16:35:45 INFO - 'USER': 'cltbld', 16:35:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:45 INFO - '_': '/tools/buildbot/bin/python'} 16:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:45 INFO - Running setup.py (path:/tmp/pip-x6YZvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:45 INFO - Running setup.py (path:/tmp/pip-dUZhZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:45 INFO - Running setup.py (path:/tmp/pip-jSjVj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:45 INFO - Running setup.py (path:/tmp/pip-3T0M4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:45 INFO - Running setup.py (path:/tmp/pip-nRAbFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:46 INFO - Running setup.py (path:/tmp/pip-p7B_pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:46 INFO - Running setup.py (path:/tmp/pip-NCxrZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:46 INFO - Running setup.py (path:/tmp/pip-60JXSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:46 INFO - Running setup.py (path:/tmp/pip-qCC15K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:46 INFO - Running setup.py (path:/tmp/pip-wSTGsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:46 INFO - Running setup.py (path:/tmp/pip-P9jeZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:46 INFO - Running setup.py (path:/tmp/pip-6eDxqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:46 INFO - Running setup.py (path:/tmp/pip-fKq3pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:46 INFO - Running setup.py (path:/tmp/pip-wmw2kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:46 INFO - Running setup.py (path:/tmp/pip-11k8_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:46 INFO - Running setup.py (path:/tmp/pip-OATR0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:46 INFO - Running setup.py (path:/tmp/pip-19MkQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:46 INFO - Running setup.py install for manifestparser 16:35:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:46 INFO - Running setup.py install for mozcrash 16:35:47 INFO - Running setup.py install for mozdebug 16:35:47 INFO - Running setup.py install for mozdevice 16:35:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Running setup.py install for mozfile 16:35:47 INFO - Running setup.py install for mozhttpd 16:35:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Running setup.py install for mozinfo 16:35:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Running setup.py install for mozInstall 16:35:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Running setup.py install for mozleak 16:35:47 INFO - Running setup.py install for mozlog 16:35:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:47 INFO - Running setup.py install for moznetwork 16:35:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Running setup.py install for mozprocess 16:35:48 INFO - Running setup.py install for mozprofile 16:35:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Running setup.py install for mozrunner 16:35:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Running setup.py install for mozscreenshot 16:35:48 INFO - Running setup.py install for moztest 16:35:48 INFO - Running setup.py install for mozversion 16:35:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:48 INFO - Cleaning up... 16:35:48 INFO - Return code: 0 16:35:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:48 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')]} 16:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:48 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')]} 16:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:48 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:48 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 16:35:48 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 16:35:48 INFO - Using env: {'DISPLAY': ':0', 16:35:48 INFO - 'HOME': '/home/cltbld', 16:35:48 INFO - 'LANG': 'en_US.UTF-8', 16:35:48 INFO - 'LANGUAGE': 'en_US:en', 16:35:48 INFO - 'LOGNAME': 'cltbld', 16:35:48 INFO - 'MAIL': '/var/mail/cltbld', 16:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:48 INFO - 'MOZ_NO_REMOTE': '1', 16:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:48 INFO - 'NO_EM_RESTART': '1', 16:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:48 INFO - 'PWD': '/builds/slave/test', 16:35:48 INFO - 'SHELL': '/bin/bash', 16:35:48 INFO - 'SHLVL': '1', 16:35:48 INFO - 'TERM': 'linux', 16:35:48 INFO - 'TMOUT': '86400', 16:35:48 INFO - 'USER': 'cltbld', 16:35:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:48 INFO - '_': '/tools/buildbot/bin/python'} 16:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:48 INFO - Running setup.py (path:/tmp/pip-ucTqNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:48 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)) 16:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:48 INFO - Running setup.py (path:/tmp/pip-T_DU0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:49 INFO - Running setup.py (path:/tmp/pip-eeeuWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:49 INFO - Running setup.py (path:/tmp/pip-dfH48W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:49 INFO - Running setup.py (path:/tmp/pip-p1iJ7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:49 INFO - Running setup.py (path:/tmp/pip-ia6Cd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:49 INFO - Running setup.py (path:/tmp/pip-pofUoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:49 INFO - Running setup.py (path:/tmp/pip-ph8bBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:49 INFO - Running setup.py (path:/tmp/pip-Fq1bhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:49 INFO - Running setup.py (path:/tmp/pip-xud2a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:49 INFO - Running setup.py (path:/tmp/pip-8azNRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:49 INFO - Running setup.py (path:/tmp/pip-LJD9_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:49 INFO - Running setup.py (path:/tmp/pip-WXdZFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:49 INFO - Running setup.py (path:/tmp/pip-U76mlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:49 INFO - Running setup.py (path:/tmp/pip-iyK6VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:49 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)) 16:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:49 INFO - Running setup.py (path:/tmp/pip-92c_ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:50 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)) 16:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:50 INFO - Running setup.py (path:/tmp/pip-wv2AaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:50 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)) 16:35:50 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)) 16:35:50 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)) 16:35:50 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)) 16:35:50 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)) 16:35:50 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)) 16:35:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:52 INFO - Downloading blessings-1.6.tar.gz 16:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:52 INFO - Installing collected packages: blessings 16:35:52 INFO - Running setup.py install for blessings 16:35:52 INFO - Successfully installed blessings 16:35:52 INFO - Cleaning up... 16:35:52 INFO - Return code: 0 16:35:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:52 INFO - Reading from file tmpfile_stdout 16:35:52 INFO - Current package versions: 16:35:52 INFO - argparse == 1.2.1 16:35:52 INFO - blessings == 1.6 16:35:52 INFO - blobuploader == 1.2.4 16:35:52 INFO - docopt == 0.6.1 16:35:52 INFO - functools32 == 3.2.3-2 16:35:52 INFO - jsonschema == 2.5.1 16:35:52 INFO - manifestparser == 1.1 16:35:52 INFO - mozInstall == 1.12 16:35:52 INFO - mozcrash == 1.0 16:35:52 INFO - mozdebug == 0.1 16:35:52 INFO - mozdevice == 0.48 16:35:52 INFO - mozfile == 1.2 16:35:52 INFO - mozhttpd == 0.7 16:35:52 INFO - mozinfo == 0.9 16:35:52 INFO - mozleak == 0.1 16:35:52 INFO - mozlog == 3.4 16:35:52 INFO - moznetwork == 0.27 16:35:52 INFO - mozprocess == 0.23 16:35:52 INFO - mozprofile == 0.28 16:35:52 INFO - mozrunner == 6.13 16:35:52 INFO - mozscreenshot == 0.1 16:35:52 INFO - mozsystemmonitor == 0.3 16:35:52 INFO - moztest == 0.8 16:35:52 INFO - mozversion == 1.4 16:35:52 INFO - psutil == 3.1.1 16:35:52 INFO - requests == 1.2.3 16:35:52 INFO - wsgiref == 0.1.2 16:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 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 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:52 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 16:35:52 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 16:35:52 INFO - Using env: {'DISPLAY': ':0', 16:35:52 INFO - 'HOME': '/home/cltbld', 16:35:52 INFO - 'LANG': 'en_US.UTF-8', 16:35:52 INFO - 'LANGUAGE': 'en_US:en', 16:35:52 INFO - 'LOGNAME': 'cltbld', 16:35:52 INFO - 'MAIL': '/var/mail/cltbld', 16:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:52 INFO - 'MOZ_NO_REMOTE': '1', 16:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:52 INFO - 'NO_EM_RESTART': '1', 16:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:52 INFO - 'PWD': '/builds/slave/test', 16:35:52 INFO - 'SHELL': '/bin/bash', 16:35:52 INFO - 'SHLVL': '1', 16:35:52 INFO - 'TERM': 'linux', 16:35:52 INFO - 'TMOUT': '86400', 16:35:52 INFO - 'USER': 'cltbld', 16:35:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:52 INFO - '_': '/tools/buildbot/bin/python'} 16:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 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)) 16:35:52 INFO - Cleaning up... 16:35:52 INFO - Return code: 0 16:35:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ab421ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1558ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, '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': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', '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 16:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:35:52 INFO - Using env: {'DISPLAY': ':0', 16:35:52 INFO - 'HOME': '/home/cltbld', 16:35:52 INFO - 'LANG': 'en_US.UTF-8', 16:35:52 INFO - 'LANGUAGE': 'en_US:en', 16:35:52 INFO - 'LOGNAME': 'cltbld', 16:35:52 INFO - 'MAIL': '/var/mail/cltbld', 16:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:52 INFO - 'MOZ_NO_REMOTE': '1', 16:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:52 INFO - 'NO_EM_RESTART': '1', 16:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:52 INFO - 'PWD': '/builds/slave/test', 16:35:52 INFO - 'SHELL': '/bin/bash', 16:35:52 INFO - 'SHLVL': '1', 16:35:52 INFO - 'TERM': 'linux', 16:35:52 INFO - 'TMOUT': '86400', 16:35:52 INFO - 'USER': 'cltbld', 16:35:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:52 INFO - '_': '/tools/buildbot/bin/python'} 16:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:35:53 INFO - Cleaning up... 16:35:53 INFO - Return code: 0 16:35:53 INFO - Running post-action listener: _resource_record_post_action 16:35:53 INFO - Running post-action listener: _start_resource_monitoring 16:35:53 INFO - Starting resource monitoring. 16:35:53 INFO - [mozharness: 2017-02-14 00:35:53.111537Z] Finished create-virtualenv step (success) 16:35:53 INFO - [mozharness: 2017-02-14 00:35:53.111990Z] Running install step. 16:35:53 INFO - Running pre-action listener: _resource_record_pre_action 16:35:53 INFO - Running main action method: install 16:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:53 INFO - Reading from file tmpfile_stdout 16:35:53 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:53 INFO - Reading from file tmpfile_stdout 16:35:53 INFO - Output received: 16:35:53 INFO - Usage: mozinstall [options] installer 16:35:53 INFO - Options: 16:35:53 INFO - -h, --help show this help message and exit 16:35:53 INFO - -d DEST, --destination=DEST 16:35:53 INFO - Directory to install application into. [default: 16:35:53 INFO - "/builds/slave/test"] 16:35:53 INFO - --app=APP Application being installed. [default: firefox] 16:35:53 INFO - mkdir: /builds/slave/test/build/application 16:35:53 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'] 16:35:53 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 16:36:07 INFO - Reading from file tmpfile_stdout 16:36:07 INFO - Output received: 16:36:07 INFO - /builds/slave/test/build/application/firefox/firefox 16:36:07 INFO - Running post-action listener: _resource_record_post_action 16:36:07 INFO - [mozharness: 2017-02-14 00:36:07.053624Z] Finished install step (success) 16:36:07 INFO - [mozharness: 2017-02-14 00:36:07.053867Z] Running run-tests step. 16:36:07 INFO - Running pre-action listener: _resource_record_pre_action 16:36:07 INFO - Running main action method: run_tests 16:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:07 INFO - Python 2.7.3 16:36:07 INFO - Return code: 0 16:36:07 INFO - grabbing minidump binary from tooltool 16:36:07 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')]} 16:36:07 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 0x1555f60>, '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 0x1556d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15571d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:07 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 16:36:07 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 16:36:07 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 16:36:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:07 INFO - Return code: 0 16:36:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:36:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:36:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:07 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/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 16:36:07 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/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 16:36:07 INFO - Using env: {'DISPLAY': ':0', 16:36:07 INFO - 'HOME': '/home/cltbld', 16:36:07 INFO - 'LANG': 'en_US.UTF-8', 16:36:07 INFO - 'LANGUAGE': 'en_US:en', 16:36:07 INFO - 'LOGNAME': 'cltbld', 16:36:07 INFO - 'MAIL': '/var/mail/cltbld', 16:36:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:07 INFO - 'MOZ_NO_REMOTE': '1', 16:36:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:07 INFO - 'NO_EM_RESTART': '1', 16:36:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:07 INFO - 'PWD': '/builds/slave/test', 16:36:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:07 INFO - 'SHELL': '/bin/bash', 16:36:07 INFO - 'SHLVL': '1', 16:36:07 INFO - 'TERM': 'linux', 16:36:07 INFO - 'TMOUT': '86400', 16:36:07 INFO - 'USER': 'cltbld', 16:36:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177', 16:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:07 INFO - '_': '/tools/buildbot/bin/python'} 16:36:07 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/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 16:36:07 INFO - mozversion application_buildid: 20170213142824 16:36:07 INFO - mozversion application_changeset: 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c 16:36:07 INFO - mozversion application_display_name: Firefox 16:36:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:07 INFO - mozversion application_name: Firefox 16:36:07 INFO - mozversion application_remotingname: firefox 16:36:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:36:07 INFO - mozversion application_vendor: Mozilla 16:36:07 INFO - mozversion application_version: 52.0 16:36:07 INFO - mozversion platform_buildid: 20170213142824 16:36:07 INFO - mozversion platform_changeset: 3ea27580c85dad05759fbd7ab6aac3ea9a355c2c 16:36:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:36:07 INFO - mozversion platform_version: 52.0 16:36:07 INFO - using testdate: 1487032567 16:36:07 INFO - actual date: 1487032567 16:36:07 INFO - starting webserver on 'localhost:55036' 16:36:07 INFO - SUITE-START | Running 2 tests 16:36:07 INFO - TEST-START | dromaeo_css 16:36:07 INFO - operating with platform_type : linux_ 16:36:07 INFO - Initialising browser for dromaeo_css test... 16:36:07 INFO - TEST-INFO | started process 30969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSzWvml/profile http://localhost:55036/getInfo.html) 16:36:11 INFO - PROCESS | 30969 | __metrics Screen width/height:1600/1200 16:36:11 INFO - PROCESS | 30969 | colorDepth:24 16:36:11 INFO - PROCESS | 30969 | Browser inner width/height: 1024/697 16:36:11 INFO - PROCESS | 30969 | __metrics 16:36:11 INFO - PROCESS | 30969 | 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" 16:36:11 INFO - PROCESS | 30969 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:12 INFO - PROCESS | 30969 | console.error: PushService: 16:36:12 INFO - PROCESS | 30969 | stateChangeProcessEnqueue: Error transitioning state 16:36:12 INFO - PROCESS | 30969 | UnknownError 16:36:12 INFO - TEST-INFO | 30969: exit 0 16:36:12 INFO - Browser initialized. 16:36:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:12 INFO - TEST-INFO | started process 31059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSzWvml/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:24 INFO - PROCESS | 31059 | RSS: Main: 142110720 16:36:24 INFO - PROCESS | 31059 | 16:39:25 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55036/tests/dromaeo/cssquery-ext.html) 16:39:26 INFO - PROCESS | 31059 | RSS: Main: 231641088 16:39:26 INFO - PROCESS | 31059 | 16:42:29 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-ext.html (next: http://localhost:55036/tests/dromaeo/cssquery-jquery.html) 16:42:29 INFO - PROCESS | 31059 | RSS: Main: 230649856 16:42:29 INFO - PROCESS | 31059 | 16:45:31 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55036/tests/dromaeo/cssquery-mootools.html) 16:45:32 INFO - PROCESS | 31059 | RSS: Main: 174821376 16:45:32 INFO - PROCESS | 31059 | 16:48:33 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55036/tests/dromaeo/cssquery-prototype.html) 16:48:34 INFO - PROCESS | 31059 | RSS: Main: 230809600 16:48:34 INFO - PROCESS | 31059 | 16:51:37 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55036/tests/dromaeo/cssquery-yui.html) 16:51:37 INFO - PROCESS | 31059 | RSS: Main: 175050752 16:51:37 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | Cycle 1(1): loaded http://localhost:55036/tests/dromaeo/cssquery-yui.html (next: http://localhost:55036/tests/dromaeo/cssquery-dojo.html) 16:54:40 INFO - PROCESS | 31059 | RSS: Main: 263507968 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | __start_tp_report 16:54:40 INFO - PROCESS | 31059 | _x_x_mozilla_page_load 16:54:40 INFO - PROCESS | 31059 | _x_x_mozilla_page_load_details 16:54:40 INFO - PROCESS | 31059 | |i|pagename|runs| 16:54:40 INFO - PROCESS | 31059 | |0;dojo.html;3182.0931034655123;3218.4850423932166;3218.7264082552983;3244.6430892601793;3264.7551433642484;5478.835634930949;5604.243427137335;5610.270664813579;5611.466910643492;5618.522425593825;5533.501984821365;5569.637973531718;5573.219749235101;5592.972035139818;5608.4391560844;4996.67521611095;5035.571976382012;5040.470750571192;5117.33474648297;5126.794928202868;4952.306677065214;4979.526944940225;5088.26220198071;5141.15170996785;5142.66572672777;4973.154563724175;4980.501949805009;4998.500149985009;5018.172001619729;5030.622703297249;5047.747612619372;5054.646174767786;5122.359705036871;5127.1796512558185;5155.7679904404395;4825.179719447702;5038.067957427887;5049.6212784041345;5093.312402825608;5107.540321371057;5382.461753824626;5410.945890541084;5414.07960646691;5467.343918729778;5524.254225679562;5785.62393444429;5794.5943783935145;5923.5853490255695;5926.674032928187;5930.911036334458;5746.626469279484;5964.940350596482;5974.103884417329;5975.611585246945;5992.760289588455;5406.107992181285;5453.481919217668;5499.422560631157;5506.614536982453;5553.694546799884;6058.939410605925;6076.179715738407;6083.66539840313;6086.147939288503;6088.665123418166;5649.096144616924;5817.534597232211;5819.476247137778;5832.475077243069;5837.970810145922;5797.159411885337;5823.475887170175;5874.647521148745;5900.970495147497;5982.222311099529;5914.172015917775;5917.881642367129;5919.437653422918;5926.2295901532525;5952.196453478725;5865.67738774363;5931.555133365015;5939.346671866091;5940.168376427304;5954.106883967353;4521.773911304422;4571.839985600488;4608.262677971576;4646.535346465326;4658.976705116521;4175.99776053751;4196.118815048813;4201.852935147255;4217.388478670576;4231;5787.768489260382;5788.18965344852;5791.942080579224;5793.710314484343;5793.855153621109;5742.253507044057;6048.667323297261;6050.818475445743;6053.576249662569;6063.393660633989;5612.691301978349;5650.152477128464;5676.574256930747;5677.51741102011;5763.625364351304;5181.974090129525;5192.766325515361;5194.506521880416;5194.896102077937;5195.844124676266;6199.814005579839;6305.527085468517;6308.653024083627;6318.368163183645;6325.399087086719;5735.799247026334;5804.24544809189;5813.854653633693;5877.471027607365;5887;6218.315985241529;6228.4705800005695;6232.937670623417;6249.093881387264;6270.7805226816845;5809.738561764646;5817.970910145422;5822.534197264124;5826.854328641818;5840.883182336244;5808.186853840381;5861.208736820475;5918.763249469973;5941.435563621449;5947.6431414115295;5839.240898683314;5840.094785308114;5877.177195192591;5879.823605291848;5882.1470886722045;5864.530837533072;5867.9413205867395;5868.149118377897;5874.735636896265;5884.47039766423;5570.3315602128005;5578.107502799533;5715.742791574306;5809.36097029318;5819.94180058194;5810.564207684525;5897.085951677497;5900;5937.435943585352;5955.731992060454;5765.625234359753;5776;5788.768449261982;5790.710464476675;5793.710314484343 16:54:40 INFO - PROCESS | 31059 | |1;ext.html;588.1148870949221;616.5868867858535;645.4707140145082;645.5061877663585;654.3195077119799;32206;35290.8235458823;35367.64632353679;43391.78304108483;44034.77982610082;44390;44892.77553612235;44924.32613510792;44957.52733599659;44959.32561011588;8832.955835220831;8983.64065437385;8991.820163596723;8993.640254389817;8995.865062024042;8283.544405057719;8480.109588493211;8828.161324674178;10531.36811791291;10830.458477076154;10941.398223097727;11008;11012.614558490455;11024.393658348788;11024.614138505154;10694.893051069468;10746.892531074745;10752.086072683793;10753.83869241958;10762.461876906202;10702.357858528436;10768.569257229701;10769.892301076967;10770.838437423445;10779.299345542515;41664.583354166374;41972.79013604943;42107.7894610528;42228.15543689109;42255.15489690189;3585.2470981094;3621.4386770050683;3625.4743062255825;3736.75711078779;3959.663428608572;31385.52921706176;31827.681723182934;32021.679783202104;32062.679373206436;32210.516842247383;4498.640108791289;4503.347014682852;4507.166174257773;4515.909681806345;4577.153226653047;321591;324289;324838.3758081218;325462;325773;37712.62287377091;58471.4152858466;58703;58783.412165878646;58861;38025.429618555194;40145.1970960585;40236.59763402387;40379.59620403758;40461.39307910384;16240.837591623933;16434.342626294816;16469.34122635105;16496.34014639425;16509.17454127289;12652.430640621194;13662.385192666354;13882.02825802184;13894.722105557832;13926.721465570632;8701.608427620773;9204.539773011456;9434.95282523583;9476.147146756824;9529.571169297398;3559.94660080099;3577.3381924343557;3587.695045921126;3590.1563132663805;3622.9275414491563;1062.4475272858072;1072.051234657334;1083.4257843343041;1104.447776111944;1106.8948449897248;31228.375432491222;32491.51262731061;32677;32727.50908736371;32839.83580082132;1097;1123.393367581497;1174.3130268792681;1181.3974872814754;1193.6598069550137;14879.357903227317;17413;17741.37905173313;18149.818501815076;18833.717494237597;458781;460220;461431;461799;461838;57132.71433642805;57286.42713572811;57345.13982290185;57426.13860792091;57436;1305.4712841299288;1359.9728005439836;1367.5897230830512;1405.0656313551374;1435.2393231587275;27678.308042298297;29433.705662943954;29436.26409339698;30521.542176866922;30605.846970765895;49534.75232623814;50149;50264.49735502598;50364.49635503598;50383.74808125936;311587;312877;312962;312997;313057;25020.249392518253;25734.613980790677;25757.35606609775;26849.597256041565;28970.27574310659;42913.35629965491;43189.13621727611;43190.78404608082;43803.561964381224;44673;37203.441948371335;37354.252914942095;37429.62570374261;37768.244635107694;38425.42361864518;37310.06724831901;37336.43995340018;37752.622473776006;37898.242035159696;38076.61923380731;37123.628763713095;37258.62741372552;37302.8134859324;37734.43398349082;37922.43116353312;31968.840155799073;33914;33941.83029084938;33957.49063763996;34266.65733342734;25746.871265643553;26135.869320653273;26244.868775656;26340.9463621453;26582 16:54:40 INFO - PROCESS | 31059 | |2;jquery.html;408.5365247557231;408.7608748881902;419.81737943994364;420.592025735037;431.9654427645789;18709.906450467744;19994.80005199951;20059.88760011996;20275;20482.078306476207;19671.606567868635;20101.39695809128;20121;20413.387598372035;20427;5050.419201791786;5261.105612045962;5293.6294459387855;5330.466953304658;5340.893182136355;5084.13569693153;5253.973730131344;5257.579393648499;5265.631405801595;5265.842024739264;5257.947420525784;5296.841094767144;5298.23175639532;5303.469653034705;5309.123994540896;5306.230596563496;5308.681479111266;5313.734313284321;5316.680999140045;5608.298962629671;5628.04323265046;5734.942650573483;5735.713214339266;5738.081906894877;5748.080307150877;13223.669408264774;14047.719045619133;23277.952492137723;23364.415889602726;23633.645495317585;2361.8228632852606;2382.797462215714;2529.051605647882;2531.50635626053;2728.304282407993;9736;9777.511124443748;10108.494575271281;10182.541785619665;10229.283950123494;1698.9745153822703;1845.2065611786927;1891.2624076610134;1909.6849019911838;1922.375228050875;76629.61685191594;77974;79379;83258.58370708168;85010.14989850023;10775;10962.506687199095;11103.666889993314;11564;11673.766524669629;16717.749233761504;16734.49796506107;16750.16249187536;16759.329626815033;16759.748603770953;8576.842126312993;8640.567971601395;8684.044755076937;8786.12138786129;8825.602847871862;8303.709370172015;8312.501249925024;8459.280961118375;8489.363297752694;8523.48859068458;5021.59827213822;5092.28707980883;5094.2358646203365;5123.257127716461;5132.538071573576;2038.8378624184072;2047.62119007984;2065.0913598016823;2074.2740040985836;2113.39768166075;848.8005318750089;894.7136916186888;894.7986702991905;992.5434300221834;1047.2669131607904;18689.90655046716;19266.903665481583;19361.903190484238;19465.610687786164;19775.802241977683;988.1205726903062;1018.5365658625308;1043.3687618990552;1050.3216797167192;1078.638656050232;10207.285490015776;10833;10893.673189804318;10936.781264374667;10961.506732197071;424405;449108;464749;465776;469288;88967.55516222506;89683.55158224297;89952;91711;91711.54144229236;993.9403635781877;1010.4543546484963;1029.45953374479;1032.6747074671605;1034.270839058462;16476.340946362012;17009;17121.973413514657;17138.485845424657;17243.22405491781;32933.17667058343;42505;42655;43332.35001474917;43808.78095609502;54920.45079549153;56948.43051569597;61464.38535614587;63144.36855631385;63306;12049.638510844688;12972.481100755864;13189.736205276033;13414.329283535979;13521.18872867631;14592.562223133324;14605.12369257848;14638.780418293522;14870.925645371704;14941.925290373914;8252.83494330122;8371.455855369382;8477.533735644352;8548.700795472128;9015.053419391132;8224.671013159406;8254.83490330202;8433.367497437594;8533.232009119209;8680.78298042554;8421;8605.182507661762;8716.38985271025;8777.517236551796;8870;12929.612111636667;13238.139520931109;13289.335533223493;13325.267110309027;13377.933110334387;12141.514339426323;12578.874211258137;12708;13254.80117798253;13261.668458288234 16:54:40 INFO - PROCESS | 31059 | |3;mootools.html;1490.888183386246;1525.496586126578;1638.8606968407685;1749.247823435922;1783.6165224476736;8520.786980325494;9096.772580685478;9107.134822191898;9119.77200569986;9122.224610908064;7836.882446763303;8079.030516338033;8097.028356597202;8265.876011859827;8907.376483646147;2416.238884751302;2483.925482235536;2494.7006359236825;2503.5493611149986;2514.798816094717;2460.9507809843794;2491.613799861015;2494.3888747256856;2509.372656835791;2513.472170844125;2440.2435245073993;2440.6461063145834;2457.58221102413;2459.2376363327426;2500.8874600643016;2382.0828980842325;2390.390450435128;2404.5190961807534;2409.33743220614;2415.10641062807;2450.534398464286;2472.0606169655593;2473.282748003077;2473.923843128245;2477.492114116602;8883.555822208864;8928.553572321423;9026.368154229207;9041.593128309176;9057.230135438496;5406.053940560386;5502.0371434999115;5534.944650553523;5538.169274608801;5544.889102217973;3206.8717251309918;3294.7364210863075;3429.9142521436916;3430.6054803697643;3435.7594968352223;1170.912181586376;1195.946182421793;1222.480445810527;1247.7067889046066;1281.9166754161042;12490.250584964931;12557.874421255761;12589.622311330675;12592.937035314764;12594.055445841599;4597.08058388317;4687.906241875144;4759.262314341283;4779.450363208206;4887.653926115485;10604.257701960789;10616.575336986589;10625.73435664099;10627;10640.521176547074;5521.723913804293;5527.419620939824;5540.806071787468;5543.168524721244;5547.667139971614;4933.407991041098;5051.974740126276;5107.208382700687;5121.692698438105;5128.1794912813775;4182.707210495297;4216.093539888877;4274.7435153890865;4299.14017196562;4311.913761724811;1358.6807100331414;1361.4554178328747;1376.215557132445;1377.6073818961547;1403.39653948803;724.3480867219545;751.2787723785227;779.0729032451364;850.064928578571;871.7384784564605;6136.140940268366;6139.7080667841365;6159.23009623797;6165.383461653799;6249.843753906098;472.8486136258222;482.96619236653095;507.67508794371633;512.2086376548167;515.8419348562427;4302.225599392077;4309.547497512779;4346.978265108654;4372.191144638252;4411.426514553152;10751.247412681194;11023.724406889893;11162.609308674157;11165.330080195214;11174.497147628375;10333.121684656739;10717.196210284104;10774.299670521392;11057.50241239146;11071.446427678584;8378.748637540884;8552.828943421096;8577.313814894793;8577.656893724306;8581.313494920516;5780.624259423124;5895.587308888508;6000.669963152069;6049.062395328731;6104.084387341934;9882.901170988198;10066.396016239049;10198.541065651914;10216.744581385525;10235.334703244564;9308.581113849757;10047.09576138151;10265.794684106426;10367.429791361548;10471.371717696962;7144.892826607501;7773.766786996399;7894.605269736605;7962.243586859239;8114.513129212266;8461.280791132822;8525.360597955303;8534.74395768128;8548.358873084419;8648.30813534903;7717.2282771722375;7829.6085195741125;7853;7872.252136047066;7998.360131189374;7499.362554182955;7516.022917020971;7534.434917381109;7582.431317651088;7583.9620801895635;6482.805515834532;6513.902291465537;6518.674066296571;6531.640759758259;6548.574342667712;5262.421133675216;5290.867728306823;5341.465853414627;5418.539424148991;5479.013777520085;5045.520675535819;5122.103631864484;5311.5485183758265;5320.760565774627;5483.287172667528 16:54:40 INFO - PROCESS | 31059 | |4;prototype.html;333.11391698083105;345.78906866811246;354.6347262319812;356.8857965451057;359.0843349458879;5232.65987710799;5301.734913254341;5326;5360.08878490657;5396.622236443451;5199.350081239845;5207.323048003764;5233.398159211692;5241.8951620967555;5253.763580638871;3974.1455587048777;4163.7300623309875;4171.541130475645;4199.62203401693;4244.936325955113;3903.2974064668347;4109.301418758818;4117.547069822317;4142.150859073882;4176.45706058212;4110.520212723417;4127.360259159835;4140.358244472111;4150.190712811003;4156.397322388252;4123.587701194805;4135.875923722293;4151.584841515854;4155.127423241123;4160.687948403852;3645.1069487975615;3653.799041052741;3671.6695497405094;3682.6133256008;3685.539307586552;5076.568491678212;5088.720120393377;5088.974555127238;5096.362954630671;5112.284280200774;4699.201135806921;4723.48041715411;4729.243321068612;4734.668573199843;4756.619470442356;5251.212318152269;5426.403095659474;5452.6183167178315;5459.317585301837;5474;4009.578994205596;4018.296798060357;4019.9598004019876;4020.6582440492593;4035.515738111416;5664;5689.212285979881;5701.372848986608;5742.971285143548;5773.913391299134;4003.139325045129;4104.363823607346;4106.755663026235;4141.6065473779945;4150.169966006811;4140.585941405835;4161;4177.310743727312;4177.665786737054;4179.373094035919;4731.219348807477;4738.431388233365;4744.122337367598;4750.596199323097;4765.380500534909;5424.1321388577635;5526.447355264441;5530.695811730394;5532.3637781655625;5546.63946843462;1393.9442422303198;1394.1495687630538;1395.5974245882824;1400.726858262629;1403.0809819568199;934.3319526538422;968.2689569375077;978.3347323819728;982.9361091529028;984.8522721591819;5240.423553409122;5247.291615631841;5284.207368894619;5294.841154765363;5368.248445217672;5490.1764735289225;5646.350669672958;5664.376918538957;5681.937414748475;5685.545156387479;5434.157705555645;5435.586747445693;5468.863278418072;5474.151506516497;5500.532454741392;2767.8892844286406;2842.749190356237;2854.985725071403;2869.483492971285;2869.7991140619956;5742.655440673573;5759.740811663485;5770.596058275964;5771.365149833515;5784.913226301609;5460.6689919149285;5535;5564.582656300794;5590.161475778585;5602.831915042555;5958.880822383528;5969.940300597025;5985.700714964234;5991.940080599225;6002.519798416116;5673.06394444912;5675.943240567542;5676.858078547904;5713.143028545752;5732.484076433141;5464.562834973272;5608.214849921096;5650.943490565041;5673.631213971079;5712.942870571241;6004.459598636144;6019.307779605401;6029.974904266373;6034.426729460694;6041.728122234422;4137.834486620622;4142.482189726285;4147.502299724052;4187.476565429321;4195.244855925963;5475.206095116266;5691.288588926384;5695.943040569541;5706.258186435737;5711.171880077449;5547.916781248204;5560.499555040065;5562.91655625174;5563.666180029211;5578.386377498391;5357.892842143057;5548.55611551083;5564.721763911707;5566.332040155207;5573.247611572386;5478.8904221914545;5499.9175012375645;5512.539177118148;5518.392976772632;5523.8895222094525;5376.8118115865755;5514.505677872521;5586.190002449704;5589.580781441489;5596.300462442195;5299.8410047698635;5460.781568737365;5465.344158700981;5471.72641367922;5480.534154596904 16:54:40 INFO - PROCESS | 31059 | |5;yui.html;772.7411317208735;800.8078061265295;814.4258297899981;849.0880257709154;871.5380848150475;13203.2738199399;13988.790168147474;14477.348519316629;14952.476663316786;15153.696926061471;14406.855931440683;14612.926935365334;14893.702125957474;14900.850991490082;14990.175540345277;702.6662335390699;838.9328853691705;856.6659002988839;857.6869442653449;859.2696208223023;736.3483317264206;744.9031625888626;744.9851002979938;828.5567221536479;854.1757204297851;905.7916679163797;906.2613969614775;907.2696479334134;908.3641450984304;909.5588639509832;911.0343036381424;911.3893691226893;911.9726408207731;912.333996182787;912.5984566790657;663.2803408301999;664.3721683009558;664.7108507799074;664.7473959895257;665.3579295979355;13729.313534323344;14096.365663545062;14108.576742697736;14110.294485275695;14516.782248266285;12258.877411225863;12324.445399957023;12365.62903112899;12420.565280215149;12772.552960646426;10913.563457461692;11008.449577521093;11135.387553684544;11144.219904606682;11226.887731122666;3476.878309259164;3507.789532628025;3512.5609298837644;3570.517980072683;3607.4047782115917;65473.67263163701;65931.34068659348;66189.66905165443;66379.3362066378;67268;9957.502124893726;10145.137663298554;10321.380717156995;10339.689809305582;10356.067953884187;17614.823851761317;18176.00031998253;18621.627567448577;18677.252909883453;18871.622567548846;7554.697812087565;7573.369511002885;7678.654460549289;7718.922810771933;7982.521048737094;4061;4199.286121359315;4215.515215750228;4218.430511880857;4294.484661840599;3377.6960073593496;3432.828358582061;3506.474028895686;3522.788632682047;3530.593981692087;616.2789536242607;630.5365556316104;631.0723236841835;633.9080833279148;637.0666972884653;619.2847261413075;621.9533534984804;643.3502162815496;649.4641920415581;680.1701923653135;8634.956825215833;8741.781455463664;9036;9279.907200928039;9456.952715236517;598.3507893935042;640.6700549217157;682.8054004608663;706.2055187913597;708.5359089796192;4049.210403971197;4194.622483976395;4252.91494170121;4264.168487144977;4335.284678028153;54050;54870;61697.69151154216;90257;90445.54777226203;67985.3201467979;74810;75352;76974;79062;70615.29384706088;71443.6427817868;72166.63916680487;72483.63758181281;72490.27509724941;7017.754378596725;7138.750143744944;7335.926640733524;7369.263073692588;7578;34220.48669270013;42678.35982460328;43761.12477750363;45454.77272613616;45986.08027839357;52072;61553.69223153855;62677.68661156665;63950;64675.35324646693;11257.943710281395;11719.941400292944;12009.699757505783;12113.515459381879;12197.756044878875;13314.267715275753;13771.173729576258;13778.724425511233;13918.234497102756;14052.227127508086;12596.370181491073;12900.935495322463;12929.935350323189;12938.935305323414;13280.070395072253;12908.290044047668;13360.131591446914;13445.394957226752;13745.38145783422;14284.928575357473;10381.9480902595;10473.21450891171;11584.47869845842;11803.645890623295;11905.52377904874;10335.268944108786;10778.946105269424;11328.830067549157;11369.943150284196;11425.085993120696;10656.62701805433;10721.892781072402;10752.623658171926;10862.34825910448;11338.489767960296 16:54:40 INFO - PROCESS | 31059 | __end_tp_report 16:54:40 INFO - PROCESS | 31059 | __start_cc_report 16:54:40 INFO - PROCESS | 31059 | _x_x_mozilla_cycle_collect,952 16:54:40 INFO - PROCESS | 31059 | __end_cc_report 16:54:40 INFO - PROCESS | 31059 | __startTimestamp1487033680427__endTimestamp 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | ------- Summary: start ------- 16:54:40 INFO - PROCESS | 31059 | Number of tests: 6 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#0] dojo.html Cycles:165 Average:5533.57 Median:5788.77 stddev:618.49 (10.7%) stddev-sans-first:592.24 16:54:40 INFO - PROCESS | 31059 | Values: 3182.1 3218.5 3218.7 3244.6 3264.8 5478.8 5604.2 5610.3 5611.5 5618.5 5533.5 5569.6 5573.2 5593.0 5608.4 4996.7 5035.6 5040.5 5117.3 5126.8 4952.3 4979.5 5088.3 5141.2 5142.7 4973.2 4980.5 4998.5 5018.2 5030.6 5047.7 5054.6 5122.4 5127.2 5155.8 4825.2 5038.1 5049.6 5093.3 5107.5 5382.5 5410.9 5414.1 5467.3 5524.3 5785.6 5794.6 5923.6 5926.7 5930.9 5746.6 5964.9 5974.1 5975.6 5992.8 5406.1 5453.5 5499.4 5506.6 5553.7 6058.9 6076.2 6083.7 6086.1 6088.7 5649.1 5817.5 5819.5 5832.5 5838.0 5797.2 5823.5 5874.6 5901.0 5982.2 5914.2 5917.9 5919.4 5926.2 5952.2 5865.7 5931.6 5939.3 5940.2 5954.1 4521.8 4571.8 4608.3 4646.5 4659.0 4176.0 4196.1 4201.9 4217.4 4231.0 5787.8 5788.2 5791.9 5793.7 5793.9 5742.3 6048.7 6050.8 6053.6 6063.4 5612.7 5650.2 5676.6 5677.5 5763.6 5182.0 5192.8 5194.5 5194.9 5195.8 6199.8 6305.5 6308.7 6318.4 6325.4 5735.8 5804.2 5813.9 5877.5 5887.0 6218.3 6228.5 6232.9 6249.1 6270.8 5809.7 5818.0 5822.5 5826.9 5840.9 5808.2 5861.2 5918.8 5941.4 5947.6 5839.2 5840.1 5877.2 5879.8 5882.1 5864.5 5867.9 5868.1 5874.7 5884.5 5570.3 5578.1 5715.7 5809.4 5819.9 5810.6 5897.1 5900.0 5937.4 5955.7 5765.6 5776.0 5788.8 5790.7 5793.7 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#1] ext.html Cycles:180 Average:52353.23 Median:3568.64 stddev:98222.60 (2752.4%) stddev-sans-first:98421.24 16:54:40 INFO - PROCESS | 31059 | Values: 588.1 616.6 645.5 645.5 654.3 32206.0 35290.8 35367.6 43391.8 44034.8 44390.0 44892.8 44924.3 44957.5 44959.3 8833.0 8983.6 8991.8 8993.6 8995.9 8283.5 8480.1 8828.2 10531.4 10830.5 10941.4 11008.0 11012.6 11024.4 11024.6 10694.9 10746.9 10752.1 10753.8 10762.5 10702.4 10768.6 10769.9 10770.8 10779.3 41664.6 41972.8 42107.8 42228.2 42255.2 3585.2 3621.4 3625.5 3736.8 3959.7 31385.5 31827.7 32021.7 32062.7 32210.5 4498.6 4503.3 4507.2 4515.9 4577.2 321591.0 324289.0 324838.4 325462.0 325773.0 37712.6 58471.4 58703.0 58783.4 58861.0 38025.4 40145.2 40236.6 40379.6 40461.4 16240.8 16434.3 16469.3 16496.3 16509.2 12652.4 13662.4 13882.0 13894.7 13926.7 8701.6 9204.5 9435.0 9476.1 9529.6 3559.9 3577.3 3587.7 3590.2 3622.9 1062.4 1072.1 1083.4 1104.4 1106.9 31228.4 32491.5 32677.0 32727.5 32839.8 1097.0 1123.4 1174.3 1181.4 1193.7 14879.4 17413.0 17741.4 18149.8 18833.7 458781.0 460220.0 461431.0 461799.0 461838.0 57132.7 57286.4 57345.1 57426.1 57436.0 1305.5 1360.0 1367.6 1405.1 1435.2 27678.3 29433.7 29436.3 30521.5 30605.8 49534.8 50149.0 50264.5 50364.5 50383.7 311587.0 312877.0 312962.0 312997.0 313057.0 25020.2 25734.6 25757.4 26849.6 28970.3 42913.4 43189.1 43190.8 43803.6 44673.0 37203.4 37354.3 37429.6 37768.2 38425.4 37310.1 37336.4 37752.6 37898.2 38076.6 37123.6 37258.6 37302.8 37734.4 37922.4 31968.8 33914.0 33941.8 33957.5 34266.7 25746.9 26135.9 26244.9 26340.9 26582.0 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#2] jquery.html Cycles:180 Average:28040.47 Median:420.20 stddev:75195.59 (17895.0%) stddev-sans-first:75377.91 16:54:40 INFO - PROCESS | 31059 | Values: 408.5 408.8 419.8 420.6 432.0 18709.9 19994.8 20059.9 20275.0 20482.1 19671.6 20101.4 20121.0 20413.4 20427.0 5050.4 5261.1 5293.6 5330.5 5340.9 5084.1 5254.0 5257.6 5265.6 5265.8 5257.9 5296.8 5298.2 5303.5 5309.1 5306.2 5308.7 5313.7 5316.7 5608.3 5628.0 5734.9 5735.7 5738.1 5748.1 13223.7 14047.7 23278.0 23364.4 23633.6 2361.8 2382.8 2529.1 2531.5 2728.3 9736.0 9777.5 10108.5 10182.5 10229.3 1699.0 1845.2 1891.3 1909.7 1922.4 76629.6 77974.0 79379.0 83258.6 85010.1 10775.0 10962.5 11103.7 11564.0 11673.8 16717.7 16734.5 16750.2 16759.3 16759.7 8576.8 8640.6 8684.0 8786.1 8825.6 8303.7 8312.5 8459.3 8489.4 8523.5 5021.6 5092.3 5094.2 5123.3 5132.5 2038.8 2047.6 2065.1 2074.3 2113.4 848.8 894.7 894.8 992.5 1047.3 18689.9 19266.9 19361.9 19465.6 19775.8 988.1 1018.5 1043.4 1050.3 1078.6 10207.3 10833.0 10893.7 10936.8 10961.5 424405.0 449108.0 464749.0 465776.0 469288.0 88967.6 89683.6 89952.0 91711.0 91711.5 993.9 1010.5 1029.5 1032.7 1034.3 16476.3 17009.0 17122.0 17138.5 17243.2 32933.2 42505.0 42655.0 43332.4 43808.8 54920.5 56948.4 61464.4 63144.4 63306.0 12049.6 12972.5 13189.7 13414.3 13521.2 14592.6 14605.1 14638.8 14870.9 14941.9 8252.8 8371.5 8477.5 8548.7 9015.1 8224.7 8254.8 8433.4 8533.2 8680.8 8421.0 8605.2 8716.4 8777.5 8870.0 12929.6 13238.1 13289.3 13325.3 13377.9 12141.5 12578.9 12708.0 13254.8 13261.7 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#3] mootools.html Cycles:180 Average:5878.90 Median:4989.46 stddev:3308.02 (66.3%) stddev-sans-first:3300.86 16:54:40 INFO - PROCESS | 31059 | Values: 1490.9 1525.5 1638.9 1749.2 1783.6 8520.8 9096.8 9107.1 9119.8 9122.2 7836.9 8079.0 8097.0 8265.9 8907.4 2416.2 2483.9 2494.7 2503.5 2514.8 2461.0 2491.6 2494.4 2509.4 2513.5 2440.2 2440.6 2457.6 2459.2 2500.9 2382.1 2390.4 2404.5 2409.3 2415.1 2450.5 2472.1 2473.3 2473.9 2477.5 8883.6 8928.6 9026.4 9041.6 9057.2 5406.1 5502.0 5534.9 5538.2 5544.9 3206.9 3294.7 3429.9 3430.6 3435.8 1170.9 1195.9 1222.5 1247.7 1281.9 12490.3 12557.9 12589.6 12592.9 12594.1 4597.1 4687.9 4759.3 4779.5 4887.7 10604.3 10616.6 10625.7 10627.0 10640.5 5521.7 5527.4 5540.8 5543.2 5547.7 4933.4 5052.0 5107.2 5121.7 5128.2 4182.7 4216.1 4274.7 4299.1 4311.9 1358.7 1361.5 1376.2 1377.6 1403.4 724.3 751.3 779.1 850.1 871.7 6136.1 6139.7 6159.2 6165.4 6249.8 472.8 483.0 507.7 512.2 515.8 4302.2 4309.5 4347.0 4372.2 4411.4 10751.2 11023.7 11162.6 11165.3 11174.5 10333.1 10717.2 10774.3 11057.5 11071.4 8378.7 8552.8 8577.3 8577.7 8581.3 5780.6 5895.6 6000.7 6049.1 6104.1 9882.9 10066.4 10198.5 10216.7 10235.3 9308.6 10047.1 10265.8 10367.4 10471.4 7144.9 7773.8 7894.6 7962.2 8114.5 8461.3 8525.4 8534.7 8548.4 8648.3 7717.2 7829.6 7853.0 7872.3 7998.4 7499.4 7516.0 7534.4 7582.4 7584.0 6482.8 6513.9 6518.7 6531.6 6548.6 5262.4 5290.9 5341.5 5418.5 5479.0 5045.5 5122.1 5311.5 5320.8 5483.3 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#4] prototype.html Cycles:180 Average:4672.13 Median:5364.17 stddev:1369.58 (25.5%) stddev-sans-first:1334.13 16:54:40 INFO - PROCESS | 31059 | Values: 333.1 345.8 354.6 356.9 359.1 5232.7 5301.7 5326.0 5360.1 5396.6 5199.4 5207.3 5233.4 5241.9 5253.8 3974.1 4163.7 4171.5 4199.6 4244.9 3903.3 4109.3 4117.5 4142.2 4176.5 4110.5 4127.4 4140.4 4150.2 4156.4 4123.6 4135.9 4151.6 4155.1 4160.7 3645.1 3653.8 3671.7 3682.6 3685.5 5076.6 5088.7 5089.0 5096.4 5112.3 4699.2 4723.5 4729.2 4734.7 4756.6 5251.2 5426.4 5452.6 5459.3 5474.0 4009.6 4018.3 4020.0 4020.7 4035.5 5664.0 5689.2 5701.4 5743.0 5773.9 4003.1 4104.4 4106.8 4141.6 4150.2 4140.6 4161.0 4177.3 4177.7 4179.4 4731.2 4738.4 4744.1 4750.6 4765.4 5424.1 5526.4 5530.7 5532.4 5546.6 1393.9 1394.1 1395.6 1400.7 1403.1 934.3 968.3 978.3 982.9 984.9 5240.4 5247.3 5284.2 5294.8 5368.2 5490.2 5646.4 5664.4 5681.9 5685.5 5434.2 5435.6 5468.9 5474.2 5500.5 2767.9 2842.7 2855.0 2869.5 2869.8 5742.7 5759.7 5770.6 5771.4 5784.9 5460.7 5535.0 5564.6 5590.2 5602.8 5958.9 5969.9 5985.7 5991.9 6002.5 5673.1 5675.9 5676.9 5713.1 5732.5 5464.6 5608.2 5650.9 5673.6 5712.9 6004.5 6019.3 6030.0 6034.4 6041.7 4137.8 4142.5 4147.5 4187.5 4195.2 5475.2 5691.3 5695.9 5706.3 5711.2 5547.9 5560.5 5562.9 5563.7 5578.4 5357.9 5548.6 5564.7 5566.3 5573.2 5478.9 5499.9 5512.5 5518.4 5523.9 5376.8 5514.5 5586.2 5589.6 5596.3 5299.8 5460.8 5465.3 5471.7 5480.5 16:54:40 INFO - PROCESS | 31059 | 16:54:40 INFO - PROCESS | 31059 | [#5] yui.html Cycles:180 Average:17041.61 Median:24048.20 stddev:22505.78 (93.6%) stddev-sans-first:22535.76 16:54:40 INFO - PROCESS | 31059 | Values: 772.7 800.8 814.4 849.1 871.5 13203.3 13988.8 14477.3 14952.5 15153.7 14406.9 14612.9 14893.7 14900.9 14990.2 702.7 838.9 856.7 857.7 859.3 736.3 744.9 745.0 828.6 854.2 905.8 906.3 907.3 908.4 909.6 911.0 911.4 912.0 912.3 912.6 663.3 664.4 664.7 664.7 665.4 13729.3 14096.4 14108.6 14110.3 14516.8 12258.9 12324.4 12365.6 12420.6 12772.6 10913.6 11008.4 11135.4 11144.2 11226.9 3476.9 3507.8 3512.6 3570.5 3607.4 65473.7 65931.3 66189.7 66379.3 67268.0 9957.5 10145.1 10321.4 10339.7 10356.1 17614.8 18176.0 18621.6 18677.3 18871.6 7554.7 7573.4 7678.7 7718.9 7982.5 4061.0 4199.3 4215.5 4218.4 4294.5 3377.7 3432.8 3506.5 3522.8 3530.6 616.3 630.5 631.1 633.9 637.1 619.3 622.0 643.4 649.5 680.2 8635.0 8741.8 9036.0 9279.9 9457.0 598.4 640.7 682.8 706.2 708.5 4049.2 4194.6 4252.9 4264.2 4335.3 54050.0 54870.0 61697.7 90257.0 90445.5 67985.3 74810.0 75352.0 76974.0 79062.0 70615.3 71443.6 72166.6 72483.6 72490.3 7017.8 7138.8 7335.9 7369.3 7578.0 34220.5 42678.4 43761.1 45454.8 45986.1 52072.0 61553.7 62677.7 63950.0 64675.4 11257.9 11719.9 12009.7 12113.5 12197.8 13314.3 13771.2 13778.7 13918.2 14052.2 12596.4 12900.9 12929.9 12938.9 13280.1 12908.3 13360.1 13445.4 13745.4 14284.9 10381.9 10473.2 11584.5 11803.6 11905.5 10335.3 10778.9 11328.8 11369.9 11425.1 10656.6 10721.9 10752.6 10862.3 11338.5 16:54:40 INFO - PROCESS | 31059 | -------- Summary: end -------- 16:54:40 INFO - PROCESS | 31059 | 16:54:41 INFO - TEST-INFO | 31059: exit 0 16:54:41 INFO - TEST-OK | dromaeo_css | took 1113860ms 16:54:41 INFO - TEST-START | kraken 16:54:41 INFO - operating with platform_type : linux_ 16:54:41 INFO - Initialising browser for kraken test... 16:54:41 INFO - TEST-INFO | started process 31364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK77l8D/profile http://localhost:55036/getInfo.html) 16:54:44 INFO - PROCESS | 31364 | __metrics Screen width/height:1600/1200 16:54:44 INFO - PROCESS | 31364 | colorDepth:24 16:54:44 INFO - PROCESS | 31364 | Browser inner width/height: 1024/697 16:54:44 INFO - PROCESS | 31364 | __metrics 16:54:45 INFO - PROCESS | 31364 | 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" 16:54:45 INFO - PROCESS | 31364 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:45 INFO - PROCESS | 31364 | console.error: PushService: 16:54:45 INFO - PROCESS | 31364 | stateChangeProcessEnqueue: Error transitioning state 16:54:45 INFO - PROCESS | 31364 | UnknownError 16:54:46 INFO - TEST-INFO | 31364: exit 0 16:54:46 INFO - Browser initialized. 16:54:46 INFO - Running cycle 1/1 for kraken test... 16:54:46 INFO - TEST-INFO | started process 31457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK77l8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:58 INFO - PROCESS | 31457 | RSS: Main: 142221312 16:54:58 INFO - PROCESS | 31457 | 16:55:00 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55036/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:01 INFO - PROCESS | 31457 | RSS: Main: 183222272 16:55:01 INFO - PROCESS | 31457 | 16:55:04 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55036/tests/kraken/driver.html?testName=audio-dft) 16:55:04 INFO - PROCESS | 31457 | RSS: Main: 173355008 16:55:04 INFO - PROCESS | 31457 | 16:55:07 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55036/tests/kraken/driver.html?testName=audio-fft) 16:55:08 INFO - PROCESS | 31457 | RSS: Main: 264417280 16:55:08 INFO - PROCESS | 31457 | 16:55:10 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55036/tests/kraken/driver.html?testName=audio-oscillator) 16:55:10 INFO - PROCESS | 31457 | RSS: Main: 170807296 16:55:10 INFO - PROCESS | 31457 | 16:55:12 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55036/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:13 INFO - PROCESS | 31457 | RSS: Main: 173355008 16:55:13 INFO - PROCESS | 31457 | 16:55:16 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55036/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:17 INFO - PROCESS | 31457 | RSS: Main: 212631552 16:55:17 INFO - PROCESS | 31457 | 16:55:20 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55036/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:20 INFO - PROCESS | 31457 | RSS: Main: 210534400 16:55:20 INFO - PROCESS | 31457 | 16:55:23 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55036/tests/kraken/driver.html?testName=json-parse-financial) 16:55:24 INFO - PROCESS | 31457 | RSS: Main: 209637376 16:55:24 INFO - PROCESS | 31457 | 16:55:25 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55036/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:26 INFO - PROCESS | 31457 | RSS: Main: 171757568 16:55:26 INFO - PROCESS | 31457 | 16:55:27 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:28 INFO - PROCESS | 31457 | RSS: Main: 178380800 16:55:28 INFO - PROCESS | 31457 | 16:55:30 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:31 INFO - PROCESS | 31457 | RSS: Main: 188526592 16:55:31 INFO - PROCESS | 31457 | 16:55:33 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:34 INFO - PROCESS | 31457 | RSS: Main: 196280320 16:55:34 INFO - PROCESS | 31457 | 16:55:36 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:37 INFO - PROCESS | 31457 | RSS: Main: 192897024 16:55:37 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | Cycle 1(1): loaded http://localhost:55036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55036/tests/kraken/driver.html?testName=ai-astar) 16:55:39 INFO - PROCESS | 31457 | RSS: Main: 244740096 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | __start_tp_report 16:55:39 INFO - PROCESS | 31457 | _x_x_mozilla_page_load 16:55:39 INFO - PROCESS | 31457 | _x_x_mozilla_page_load_details 16:55:39 INFO - PROCESS | 31457 | |i|pagename|runs| 16:55:39 INFO - PROCESS | 31457 | |0;ai-astar;103;112;113;111;111;113;110;110;112;112 16:55:39 INFO - PROCESS | 31457 | |1;audio-beat-detection;150;118;119;157;120;119;122;117;151;118 16:55:39 INFO - PROCESS | 31457 | |2;audio-dft;159;160;161;159;160;160;161;160;160;160 16:55:39 INFO - PROCESS | 31457 | |3;audio-fft;74;84;75;111;74;76;75;75;97;75 16:55:39 INFO - PROCESS | 31457 | |4;audio-oscillator;82;82;114;81;83;81;99;81;81;122 16:55:39 INFO - PROCESS | 31457 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;117 16:55:39 INFO - PROCESS | 31457 | |6;imaging-darkroom;146;145;146;146;146;145;146;145;145;146 16:55:39 INFO - PROCESS | 31457 | |7;imaging-desaturate;84;84;85;84;84;85;84;84;84;84 16:55:39 INFO - PROCESS | 31457 | |8;json-parse-financial;51;50;51;51;49;51;50;51;52;49 16:55:39 INFO - PROCESS | 31457 | |9;json-stringify-tinderbox;60;59;59;59;60;59;59;59;59;59 16:55:39 INFO - PROCESS | 31457 | |10;stanford-crypto-aes;75;83;78;75;76;75;83;76;76;80 16:55:39 INFO - PROCESS | 31457 | |11;stanford-crypto-ccm;128;132;123;141;125;129;124;134;160;121 16:55:39 INFO - PROCESS | 31457 | |12;stanford-crypto-pbkdf2;153;153;153;153;154;152;156;154;153;155 16:55:39 INFO - PROCESS | 31457 | |13;stanford-crypto-sha256-iterative;66;62;62;67;64;62;64;63;62;61 16:55:39 INFO - PROCESS | 31457 | __end_tp_report 16:55:39 INFO - PROCESS | 31457 | __start_cc_report 16:55:39 INFO - PROCESS | 31457 | _x_x_mozilla_cycle_collect,1556 16:55:39 INFO - PROCESS | 31457 | __end_cc_report 16:55:39 INFO - PROCESS | 31457 | __startTimestamp1487033739454__endTimestamp 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | ------- Summary: start ------- 16:55:39 INFO - PROCESS | 31457 | Number of tests: 14 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.91 (2.6%) stddev-sans-first:1.13 16:55:39 INFO - PROCESS | 31457 | Values: 103.0 112.0 113.0 111.0 111.0 113.0 110.0 110.0 112.0 112.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:121.00 stddev:16.41 (13.6%) stddev-sans-first:15.57 16:55:39 INFO - PROCESS | 31457 | Values: 150.0 118.0 119.0 157.0 120.0 119.0 122.0 117.0 151.0 118.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 16:55:39 INFO - PROCESS | 31457 | Values: 159.0 160.0 161.0 159.0 160.0 160.0 161.0 160.0 160.0 160.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:12.60 (16.8%) stddev-sans-first:13.06 16:55:39 INFO - PROCESS | 31457 | Values: 74.0 84.0 75.0 111.0 74.0 76.0 75.0 75.0 97.0 75.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.56 (19.1%) stddev-sans-first:16.19 16:55:39 INFO - PROCESS | 31457 | Values: 82.0 82.0 114.0 81.0 83.0 81.0 99.0 81.0 81.0 122.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:55:39 INFO - PROCESS | 31457 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:55:39 INFO - PROCESS | 31457 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 16:55:39 INFO - PROCESS | 31457 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 16:55:39 INFO - PROCESS | 31457 | Values: 51.0 50.0 51.0 51.0 49.0 51.0 50.0 51.0 52.0 49.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 16:55:39 INFO - PROCESS | 31457 | Values: 60.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:3.20 (4.2%) stddev-sans-first:3.24 16:55:39 INFO - PROCESS | 31457 | Values: 75.0 83.0 78.0 75.0 76.0 75.0 83.0 76.0 76.0 80.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:130.50 stddev:11.59 (8.9%) stddev-sans-first:12.21 16:55:39 INFO - PROCESS | 31457 | Values: 128.0 132.0 123.0 141.0 125.0 129.0 124.0 134.0 160.0 121.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:1.17 (0.8%) stddev-sans-first:1.22 16:55:39 INFO - PROCESS | 31457 | Values: 153.0 153.0 153.0 153.0 154.0 152.0 156.0 154.0 153.0 155.0 16:55:39 INFO - PROCESS | 31457 | 16:55:39 INFO - PROCESS | 31457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.95 (3.1%) stddev-sans-first:1.80 16:55:39 INFO - PROCESS | 31457 | Values: 66.0 62.0 62.0 67.0 64.0 62.0 64.0 63.0 62.0 61.0 16:55:39 INFO - PROCESS | 31457 | -------- Summary: end -------- 16:55:39 INFO - PROCESS | 31457 | 16:55:40 INFO - TEST-INFO | 31457: exit 0 16:55:40 INFO - TEST-OK | kraken | took 59289ms 16:55:40 INFO - SUITE-END | took 1173s 16:55:40 INFO - Completed test suite (00:19:33) 16:55:40 INFO - javascript benchmark 16:55:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3182.0931034655123, 3218.4850423932166, 3218.7264082552983, 3244.6430892601793, 3264.7551433642484, 5478.835634930949, 5604.243427137335, 5610.270664813579, 5611.466910643492, 5618.522425593825, 5533.501984821365, 5569.637973531718, 5573.219749235101, 5592.972035139818, 5608.4391560844, 4996.67521611095, 5035.571976382012, 5040.470750571192, 5117.33474648297, 5126.794928202868, 4952.306677065214, 4979.526944940225, 5088.26220198071, 5141.15170996785, 5142.66572672777, 4973.154563724175, 4980.501949805009, 4998.500149985009, 5018.172001619729, 5030.622703297249, 5047.747612619372, 5054.646174767786, 5122.359705036871, 5127.1796512558185, 5155.7679904404395, 4825.179719447702, 5038.067957427887, 5049.6212784041345, 5093.312402825608, 5107.540321371057, 5382.461753824626, 5410.945890541084, 5414.07960646691, 5467.343918729778, 5524.254225679562, 5785.62393444429, 5794.5943783935145, 5923.5853490255695, 5926.674032928187, 5930.911036334458, 5746.626469279484, 5964.940350596482, 5974.103884417329, 5975.611585246945, 5992.760289588455, 5406.107992181285, 5453.481919217668, 5499.422560631157, 5506.614536982453, 5553.694546799884, 6058.939410605925, 6076.179715738407, 6083.66539840313, 6086.147939288503, 6088.665123418166, 5649.096144616924, 5817.534597232211, 5819.476247137778, 5832.475077243069, 5837.970810145922, 5797.159411885337, 5823.475887170175, 5874.647521148745, 5900.970495147497, 5982.222311099529, 5914.172015917775, 5917.881642367129, 5919.437653422918, 5926.2295901532525, 5952.196453478725, 5865.67738774363, 5931.555133365015, 5939.346671866091, 5940.168376427304, 5954.106883967353, 4521.773911304422, 4571.839985600488, 4608.262677971576, 4646.535346465326, 4658.976705116521, 4175.99776053751, 4196.118815048813, 4201.852935147255, 4217.388478670576, 4231.0, 5787.768489260382, 5788.18965344852, 5791.942080579224, 5793.710314484343, 5793.855153621109, 5742.253507044057, 6048.667323297261, 6050.818475445743, 6053.576249662569, 6063.393660633989, 5612.691301978349, 5650.152477128464, 5676.574256930747, 5677.51741102011, 5763.625364351304, 5181.974090129525, 5192.766325515361, 5194.506521880416, 5194.896102077937, 5195.844124676266, 6199.814005579839, 6305.527085468517, 6308.653024083627, 6318.368163183645, 6325.399087086719, 5735.799247026334, 5804.24544809189, 5813.854653633693, 5877.471027607365, 5887.0, 6218.315985241529, 6228.4705800005695, 6232.937670623417, 6249.093881387264, 6270.7805226816845, 5809.738561764646, 5817.970910145422, 5822.534197264124, 5826.854328641818, 5840.883182336244, 5808.186853840381, 5861.208736820475, 5918.763249469973, 5941.435563621449, 5947.6431414115295, 5839.240898683314, 5840.094785308114, 5877.177195192591, 5879.823605291848, 5882.1470886722045, 5864.530837533072, 5867.9413205867395, 5868.149118377897, 5874.735636896265, 5884.47039766423, 5570.3315602128005, 5578.107502799533, 5715.742791574306, 5809.36097029318, 5819.94180058194, 5810.564207684525, 5897.085951677497, 5900.0, 5937.435943585352, 5955.731992060454, 5765.625234359753, 5776.0, 5788.768449261982, 5790.710464476675, 5793.710314484343], "value": 5492.684669008326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.1148870949221, 616.5868867858535, 645.4707140145082, 645.5061877663585, 654.3195077119799, 32206.0, 35290.8235458823, 35367.64632353679, 43391.78304108483, 44034.77982610082, 44390.0, 44892.77553612235, 44924.32613510792, 44957.52733599659, 44959.32561011588, 8832.955835220831, 8983.64065437385, 8991.820163596723, 8993.640254389817, 8995.865062024042, 8283.544405057719, 8480.109588493211, 8828.161324674178, 10531.36811791291, 10830.458477076154, 10941.398223097727, 11008.0, 11012.614558490455, 11024.393658348788, 11024.614138505154, 10694.893051069468, 10746.892531074745, 10752.086072683793, 10753.83869241958, 10762.461876906202, 10702.357858528436, 10768.569257229701, 10769.892301076967, 10770.838437423445, 10779.299345542515, 41664.583354166374, 41972.79013604943, 42107.7894610528, 42228.15543689109, 42255.15489690189, 3585.2470981094, 3621.4386770050683, 3625.4743062255825, 3736.75711078779, 3959.663428608572, 31385.52921706176, 31827.681723182934, 32021.679783202104, 32062.679373206436, 32210.516842247383, 4498.640108791289, 4503.347014682852, 4507.166174257773, 4515.909681806345, 4577.153226653047, 321591.0, 324289.0, 324838.3758081218, 325462.0, 325773.0, 37712.62287377091, 58471.4152858466, 58703.0, 58783.412165878646, 58861.0, 38025.429618555194, 40145.1970960585, 40236.59763402387, 40379.59620403758, 40461.39307910384, 16240.837591623933, 16434.342626294816, 16469.34122635105, 16496.34014639425, 16509.17454127289, 12652.430640621194, 13662.385192666354, 13882.02825802184, 13894.722105557832, 13926.721465570632, 8701.608427620773, 9204.539773011456, 9434.95282523583, 9476.147146756824, 9529.571169297398, 3559.94660080099, 3577.3381924343557, 3587.695045921126, 3590.1563132663805, 3622.9275414491563, 1062.4475272858072, 1072.051234657334, 1083.4257843343041, 1104.447776111944, 1106.8948449897248, 31228.375432491222, 32491.51262731061, 32677.0, 32727.50908736371, 32839.83580082132, 1097.0, 1123.393367581497, 1174.3130268792681, 1181.3974872814754, 1193.6598069550137, 14879.357903227317, 17413.0, 17741.37905173313, 18149.818501815076, 18833.717494237597, 458781.0, 460220.0, 461431.0, 461799.0, 461838.0, 57132.71433642805, 57286.42713572811, 57345.13982290185, 57426.13860792091, 57436.0, 1305.4712841299288, 1359.9728005439836, 1367.5897230830512, 1405.0656313551374, 1435.2393231587275, 27678.308042298297, 29433.705662943954, 29436.26409339698, 30521.542176866922, 30605.846970765895, 49534.75232623814, 50149.0, 50264.49735502598, 50364.49635503598, 50383.74808125936, 311587.0, 312877.0, 312962.0, 312997.0, 313057.0, 25020.249392518253, 25734.613980790677, 25757.35606609775, 26849.597256041565, 28970.27574310659, 42913.35629965491, 43189.13621727611, 43190.78404608082, 43803.561964381224, 44673.0, 37203.441948371335, 37354.252914942095, 37429.62570374261, 37768.244635107694, 38425.42361864518, 37310.06724831901, 37336.43995340018, 37752.622473776006, 37898.242035159696, 38076.61923380731, 37123.628763713095, 37258.62741372552, 37302.8134859324, 37734.43398349082, 37922.43116353312, 31968.840155799073, 33914.0, 33941.83029084938, 33957.49063763996, 34266.65733342734, 25746.871265643553, 26135.869320653273, 26244.868775656, 26340.9463621453, 26582.0], "value": 18884.55298675745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.5365247557231, 408.7608748881902, 419.81737943994364, 420.592025735037, 431.9654427645789, 18709.906450467744, 19994.80005199951, 20059.88760011996, 20275.0, 20482.078306476207, 19671.606567868635, 20101.39695809128, 20121.0, 20413.387598372035, 20427.0, 5050.419201791786, 5261.105612045962, 5293.6294459387855, 5330.466953304658, 5340.893182136355, 5084.13569693153, 5253.973730131344, 5257.579393648499, 5265.631405801595, 5265.842024739264, 5257.947420525784, 5296.841094767144, 5298.23175639532, 5303.469653034705, 5309.123994540896, 5306.230596563496, 5308.681479111266, 5313.734313284321, 5316.680999140045, 5608.298962629671, 5628.04323265046, 5734.942650573483, 5735.713214339266, 5738.081906894877, 5748.080307150877, 13223.669408264774, 14047.719045619133, 23277.952492137723, 23364.415889602726, 23633.645495317585, 2361.8228632852606, 2382.797462215714, 2529.051605647882, 2531.50635626053, 2728.304282407993, 9736.0, 9777.511124443748, 10108.494575271281, 10182.541785619665, 10229.283950123494, 1698.9745153822703, 1845.2065611786927, 1891.2624076610134, 1909.6849019911838, 1922.375228050875, 76629.61685191594, 77974.0, 79379.0, 83258.58370708168, 85010.14989850023, 10775.0, 10962.506687199095, 11103.666889993314, 11564.0, 11673.766524669629, 16717.749233761504, 16734.49796506107, 16750.16249187536, 16759.329626815033, 16759.748603770953, 8576.842126312993, 8640.567971601395, 8684.044755076937, 8786.12138786129, 8825.602847871862, 8303.709370172015, 8312.501249925024, 8459.280961118375, 8489.363297752694, 8523.48859068458, 5021.59827213822, 5092.28707980883, 5094.2358646203365, 5123.257127716461, 5132.538071573576, 2038.8378624184072, 2047.62119007984, 2065.0913598016823, 2074.2740040985836, 2113.39768166075, 848.8005318750089, 894.7136916186888, 894.7986702991905, 992.5434300221834, 1047.2669131607904, 18689.90655046716, 19266.903665481583, 19361.903190484238, 19465.610687786164, 19775.802241977683, 988.1205726903062, 1018.5365658625308, 1043.3687618990552, 1050.3216797167192, 1078.638656050232, 10207.285490015776, 10833.0, 10893.673189804318, 10936.781264374667, 10961.506732197071, 424405.0, 449108.0, 464749.0, 465776.0, 469288.0, 88967.55516222506, 89683.55158224297, 89952.0, 91711.0, 91711.54144229236, 993.9403635781877, 1010.4543546484963, 1029.45953374479, 1032.6747074671605, 1034.270839058462, 16476.340946362012, 17009.0, 17121.973413514657, 17138.485845424657, 17243.22405491781, 32933.17667058343, 42505.0, 42655.0, 43332.35001474917, 43808.78095609502, 54920.45079549153, 56948.43051569597, 61464.38535614587, 63144.36855631385, 63306.0, 12049.638510844688, 12972.481100755864, 13189.736205276033, 13414.329283535979, 13521.18872867631, 14592.562223133324, 14605.12369257848, 14638.780418293522, 14870.925645371704, 14941.925290373914, 8252.83494330122, 8371.455855369382, 8477.533735644352, 8548.700795472128, 9015.053419391132, 8224.671013159406, 8254.83490330202, 8433.367497437594, 8533.232009119209, 8680.78298042554, 8421.0, 8605.182507661762, 8716.38985271025, 8777.517236551796, 8870.0, 12929.612111636667, 13238.139520931109, 13289.335533223493, 13325.267110309027, 13377.933110334387, 12141.514339426323, 12578.874211258137, 12708.0, 13254.80117798253, 13261.668458288234], "value": 9234.894976284177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.888183386246, 1525.496586126578, 1638.8606968407685, 1749.247823435922, 1783.6165224476736, 8520.786980325494, 9096.772580685478, 9107.134822191898, 9119.77200569986, 9122.224610908064, 7836.882446763303, 8079.030516338033, 8097.028356597202, 8265.876011859827, 8907.376483646147, 2416.238884751302, 2483.925482235536, 2494.7006359236825, 2503.5493611149986, 2514.798816094717, 2460.9507809843794, 2491.613799861015, 2494.3888747256856, 2509.372656835791, 2513.472170844125, 2440.2435245073993, 2440.6461063145834, 2457.58221102413, 2459.2376363327426, 2500.8874600643016, 2382.0828980842325, 2390.390450435128, 2404.5190961807534, 2409.33743220614, 2415.10641062807, 2450.534398464286, 2472.0606169655593, 2473.282748003077, 2473.923843128245, 2477.492114116602, 8883.555822208864, 8928.553572321423, 9026.368154229207, 9041.593128309176, 9057.230135438496, 5406.053940560386, 5502.0371434999115, 5534.944650553523, 5538.169274608801, 5544.889102217973, 3206.8717251309918, 3294.7364210863075, 3429.9142521436916, 3430.6054803697643, 3435.7594968352223, 1170.912181586376, 1195.946182421793, 1222.480445810527, 1247.7067889046066, 1281.9166754161042, 12490.250584964931, 12557.874421255761, 12589.622311330675, 12592.937035314764, 12594.055445841599, 4597.08058388317, 4687.906241875144, 4759.262314341283, 4779.450363208206, 4887.653926115485, 10604.257701960789, 10616.575336986589, 10625.73435664099, 10627.0, 10640.521176547074, 5521.723913804293, 5527.419620939824, 5540.806071787468, 5543.168524721244, 5547.667139971614, 4933.407991041098, 5051.974740126276, 5107.208382700687, 5121.692698438105, 5128.1794912813775, 4182.707210495297, 4216.093539888877, 4274.7435153890865, 4299.14017196562, 4311.913761724811, 1358.6807100331414, 1361.4554178328747, 1376.215557132445, 1377.6073818961547, 1403.39653948803, 724.3480867219545, 751.2787723785227, 779.0729032451364, 850.064928578571, 871.7384784564605, 6136.140940268366, 6139.7080667841365, 6159.23009623797, 6165.383461653799, 6249.843753906098, 472.8486136258222, 482.96619236653095, 507.67508794371633, 512.2086376548167, 515.8419348562427, 4302.225599392077, 4309.547497512779, 4346.978265108654, 4372.191144638252, 4411.426514553152, 10751.247412681194, 11023.724406889893, 11162.609308674157, 11165.330080195214, 11174.497147628375, 10333.121684656739, 10717.196210284104, 10774.299670521392, 11057.50241239146, 11071.446427678584, 8378.748637540884, 8552.828943421096, 8577.313814894793, 8577.656893724306, 8581.313494920516, 5780.624259423124, 5895.587308888508, 6000.669963152069, 6049.062395328731, 6104.084387341934, 9882.901170988198, 10066.396016239049, 10198.541065651914, 10216.744581385525, 10235.334703244564, 9308.581113849757, 10047.09576138151, 10265.794684106426, 10367.429791361548, 10471.371717696962, 7144.892826607501, 7773.766786996399, 7894.605269736605, 7962.243586859239, 8114.513129212266, 8461.280791132822, 8525.360597955303, 8534.74395768128, 8548.358873084419, 8648.30813534903, 7717.2282771722375, 7829.6085195741125, 7853.0, 7872.252136047066, 7998.360131189374, 7499.362554182955, 7516.022917020971, 7534.434917381109, 7582.431317651088, 7583.9620801895635, 6482.805515834532, 6513.902291465537, 6518.674066296571, 6531.640759758259, 6548.574342667712, 5262.421133675216, 5290.867728306823, 5341.465853414627, 5418.539424148991, 5479.013777520085, 5045.520675535819, 5122.103631864484, 5311.5485183758265, 5320.760565774627, 5483.287172667528], "value": 4654.916862056598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.11391698083105, 345.78906866811246, 354.6347262319812, 356.8857965451057, 359.0843349458879, 5232.65987710799, 5301.734913254341, 5326.0, 5360.08878490657, 5396.622236443451, 5199.350081239845, 5207.323048003764, 5233.398159211692, 5241.8951620967555, 5253.763580638871, 3974.1455587048777, 4163.7300623309875, 4171.541130475645, 4199.62203401693, 4244.936325955113, 3903.2974064668347, 4109.301418758818, 4117.547069822317, 4142.150859073882, 4176.45706058212, 4110.520212723417, 4127.360259159835, 4140.358244472111, 4150.190712811003, 4156.397322388252, 4123.587701194805, 4135.875923722293, 4151.584841515854, 4155.127423241123, 4160.687948403852, 3645.1069487975615, 3653.799041052741, 3671.6695497405094, 3682.6133256008, 3685.539307586552, 5076.568491678212, 5088.720120393377, 5088.974555127238, 5096.362954630671, 5112.284280200774, 4699.201135806921, 4723.48041715411, 4729.243321068612, 4734.668573199843, 4756.619470442356, 5251.212318152269, 5426.403095659474, 5452.6183167178315, 5459.317585301837, 5474.0, 4009.578994205596, 4018.296798060357, 4019.9598004019876, 4020.6582440492593, 4035.515738111416, 5664.0, 5689.212285979881, 5701.372848986608, 5742.971285143548, 5773.913391299134, 4003.139325045129, 4104.363823607346, 4106.755663026235, 4141.6065473779945, 4150.169966006811, 4140.585941405835, 4161.0, 4177.310743727312, 4177.665786737054, 4179.373094035919, 4731.219348807477, 4738.431388233365, 4744.122337367598, 4750.596199323097, 4765.380500534909, 5424.1321388577635, 5526.447355264441, 5530.695811730394, 5532.3637781655625, 5546.63946843462, 1393.9442422303198, 1394.1495687630538, 1395.5974245882824, 1400.726858262629, 1403.0809819568199, 934.3319526538422, 968.2689569375077, 978.3347323819728, 982.9361091529028, 984.8522721591819, 5240.423553409122, 5247.291615631841, 5284.207368894619, 5294.841154765363, 5368.248445217672, 5490.1764735289225, 5646.350669672958, 5664.376918538957, 5681.937414748475, 5685.545156387479, 5434.157705555645, 5435.586747445693, 5468.863278418072, 5474.151506516497, 5500.532454741392, 2767.8892844286406, 2842.749190356237, 2854.985725071403, 2869.483492971285, 2869.7991140619956, 5742.655440673573, 5759.740811663485, 5770.596058275964, 5771.365149833515, 5784.913226301609, 5460.6689919149285, 5535.0, 5564.582656300794, 5590.161475778585, 5602.831915042555, 5958.880822383528, 5969.940300597025, 5985.700714964234, 5991.940080599225, 6002.519798416116, 5673.06394444912, 5675.943240567542, 5676.858078547904, 5713.143028545752, 5732.484076433141, 5464.562834973272, 5608.214849921096, 5650.943490565041, 5673.631213971079, 5712.942870571241, 6004.459598636144, 6019.307779605401, 6029.974904266373, 6034.426729460694, 6041.728122234422, 4137.834486620622, 4142.482189726285, 4147.502299724052, 4187.476565429321, 4195.244855925963, 5475.206095116266, 5691.288588926384, 5695.943040569541, 5706.258186435737, 5711.171880077449, 5547.916781248204, 5560.499555040065, 5562.91655625174, 5563.666180029211, 5578.386377498391, 5357.892842143057, 5548.55611551083, 5564.721763911707, 5566.332040155207, 5573.247611572386, 5478.8904221914545, 5499.9175012375645, 5512.539177118148, 5518.392976772632, 5523.8895222094525, 5376.8118115865755, 5514.505677872521, 5586.190002449704, 5589.580781441489, 5596.300462442195, 5299.8410047698635, 5460.781568737365, 5465.344158700981, 5471.72641367922, 5480.534154596904], "value": 4240.621713994675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.7411317208735, 800.8078061265295, 814.4258297899981, 849.0880257709154, 871.5380848150475, 13203.2738199399, 13988.790168147474, 14477.348519316629, 14952.476663316786, 15153.696926061471, 14406.855931440683, 14612.926935365334, 14893.702125957474, 14900.850991490082, 14990.175540345277, 702.6662335390699, 838.9328853691705, 856.6659002988839, 857.6869442653449, 859.2696208223023, 736.3483317264206, 744.9031625888626, 744.9851002979938, 828.5567221536479, 854.1757204297851, 905.7916679163797, 906.2613969614775, 907.2696479334134, 908.3641450984304, 909.5588639509832, 911.0343036381424, 911.3893691226893, 911.9726408207731, 912.333996182787, 912.5984566790657, 663.2803408301999, 664.3721683009558, 664.7108507799074, 664.7473959895257, 665.3579295979355, 13729.313534323344, 14096.365663545062, 14108.576742697736, 14110.294485275695, 14516.782248266285, 12258.877411225863, 12324.445399957023, 12365.62903112899, 12420.565280215149, 12772.552960646426, 10913.563457461692, 11008.449577521093, 11135.387553684544, 11144.219904606682, 11226.887731122666, 3476.878309259164, 3507.789532628025, 3512.5609298837644, 3570.517980072683, 3607.4047782115917, 65473.67263163701, 65931.34068659348, 66189.66905165443, 66379.3362066378, 67268.0, 9957.502124893726, 10145.137663298554, 10321.380717156995, 10339.689809305582, 10356.067953884187, 17614.823851761317, 18176.00031998253, 18621.627567448577, 18677.252909883453, 18871.622567548846, 7554.697812087565, 7573.369511002885, 7678.654460549289, 7718.922810771933, 7982.521048737094, 4061.0, 4199.286121359315, 4215.515215750228, 4218.430511880857, 4294.484661840599, 3377.6960073593496, 3432.828358582061, 3506.474028895686, 3522.788632682047, 3530.593981692087, 616.2789536242607, 630.5365556316104, 631.0723236841835, 633.9080833279148, 637.0666972884653, 619.2847261413075, 621.9533534984804, 643.3502162815496, 649.4641920415581, 680.1701923653135, 8634.956825215833, 8741.781455463664, 9036.0, 9279.907200928039, 9456.952715236517, 598.3507893935042, 640.6700549217157, 682.8054004608663, 706.2055187913597, 708.5359089796192, 4049.210403971197, 4194.622483976395, 4252.91494170121, 4264.168487144977, 4335.284678028153, 54050.0, 54870.0, 61697.69151154216, 90257.0, 90445.54777226203, 67985.3201467979, 74810.0, 75352.0, 76974.0, 79062.0, 70615.29384706088, 71443.6427817868, 72166.63916680487, 72483.63758181281, 72490.27509724941, 7017.754378596725, 7138.750143744944, 7335.926640733524, 7369.263073692588, 7578.0, 34220.48669270013, 42678.35982460328, 43761.12477750363, 45454.77272613616, 45986.08027839357, 52072.0, 61553.69223153855, 62677.68661156665, 63950.0, 64675.35324646693, 11257.943710281395, 11719.941400292944, 12009.699757505783, 12113.515459381879, 12197.756044878875, 13314.267715275753, 13771.173729576258, 13778.724425511233, 13918.234497102756, 14052.227127508086, 12596.370181491073, 12900.935495322463, 12929.935350323189, 12938.935305323414, 13280.070395072253, 12908.290044047668, 13360.131591446914, 13445.394957226752, 13745.38145783422, 14284.928575357473, 10381.9480902595, 10473.21450891171, 11584.47869845842, 11803.645890623295, 11905.52377904874, 10335.268944108786, 10778.946105269424, 11328.830067549157, 11369.943150284196, 11425.085993120696, 10656.62701805433, 10721.892781072402, 10752.623658171926, 10862.34825910448, 11338.489767960296], "value": 6913.011738095345, "unit": "score"}], "name": "dromaeo_css", "value": 7124.083316264035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 111.0, 111.0, 113.0, 110.0, 110.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 119.0, 157.0, 120.0, 119.0, 122.0, 117.0, 151.0, 118.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 159.0, 160.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 84.0, 75.0, 111.0, 74.0, 76.0, 75.0, 75.0, 97.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 81.0, 83.0, 81.0, 99.0, 81.0, 81.0, 122.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 49.0, 51.0, 50.0, 51.0, 52.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 78.0, 75.0, 76.0, 75.0, 83.0, 76.0, 76.0, 80.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 123.0, 141.0, 125.0, 129.0, 124.0, 134.0, 160.0, 121.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 153.0, 153.0, 154.0, 152.0, 156.0, 154.0, 153.0, 155.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 62.0, 67.0, 64.0, 62.0, 64.0, 63.0, 62.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1454.6, "alertThreshold": 2.0}]} 16:55:40 INFO - Return code: 0 16:55:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:55:40 INFO - # TBPL SUCCESS # 16:55:40 INFO - Running post-action listener: _resource_record_post_action 16:55:40 INFO - [mozharness: 2017-02-14 00:55:40.739817Z] Finished run-tests step (success) 16:55:40 INFO - Running post-run listener: _resource_record_post_run 16:55:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310845440; Read time: 20; Write time: 213492 16:55:40 INFO - TinderboxPrint: CPU usage
12.9% 16:55:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:55:40 INFO - TinderboxPrint: I/O write bytes / time
310,845,440 / 213,492 16:55:40 INFO - TinderboxPrint: CPU idle
8,251.8 (87.1%) 16:55:40 INFO - TinderboxPrint: CPU user
1,185.3 (12.5%) 16:55:40 INFO - TinderboxPrint: Swap in / out
0 / 0 16:55:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101306368; Read time: 0; Write time: 116936 16:55:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209539072; Read time: 20; Write time: 96556 16:55:41 INFO - Running post-run listener: _upload_blobber_files 16:55:41 INFO - Blob upload gear active. 16:55:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:41 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 16:55:41 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'] 16:55:41 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 16:55:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:55:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:55:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:42 INFO - (blobuploader) - INFO - Done attempting. 16:55:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:55:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:55:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:43 INFO - (blobuploader) - INFO - Done attempting. 16:55:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:55:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:55:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:46 INFO - (blobuploader) - INFO - Done attempting. 16:55:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:46 INFO - Return code: 0 16:55:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9221be945e7b0800e07e5635aba9a264c47df977a2e7db5184771c0dfd3e52cca61bd466fa403fd73dd16395e146f735b1d9f3834d56ecd3e5170bacd61316ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceba558930d2d7ad5d4017aefe9f10522b546f422de30fb56b4f161a79e7848a5b592ec2954f191ef51e7f568881a8912fe10a3d2d658b5e00eaec73414e5d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b96cdc2e6cb6278acde90c7234cad7840e8695a60b14ad2d46881a4b6693c2299d8a805a940b4fdfecc0dcd926d6c2d7c8ecfee957b4c4c841fb238d8db18e33"} 16:55:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:46 INFO - Contents: 16:55:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9221be945e7b0800e07e5635aba9a264c47df977a2e7db5184771c0dfd3e52cca61bd466fa403fd73dd16395e146f735b1d9f3834d56ecd3e5170bacd61316ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceba558930d2d7ad5d4017aefe9f10522b546f422de30fb56b4f161a79e7848a5b592ec2954f191ef51e7f568881a8912fe10a3d2d658b5e00eaec73414e5d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b96cdc2e6cb6278acde90c7234cad7840e8695a60b14ad2d46881a4b6693c2299d8a805a940b4fdfecc0dcd926d6c2d7c8ecfee957b4c4c841fb238d8db18e33"} 16:55:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:46 INFO - Copying logs to upload dir... 16:55:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.920904 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-13 16:55:46.612930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 16:55:46.616349) ========= 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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 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/9221be945e7b0800e07e5635aba9a264c47df977a2e7db5184771c0dfd3e52cca61bd466fa403fd73dd16395e146f735b1d9f3834d56ecd3e5170bacd61316ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceba558930d2d7ad5d4017aefe9f10522b546f422de30fb56b4f161a79e7848a5b592ec2954f191ef51e7f568881a8912fe10a3d2d658b5e00eaec73414e5d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b96cdc2e6cb6278acde90c7234cad7840e8695a60b14ad2d46881a4b6693c2299d8a805a940b4fdfecc0dcd926d6c2d7c8ecfee957b4c4c841fb238d8db18e33"} build_url:https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/GHiCnmY8SWaxoN2Q5TZE6g/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/9221be945e7b0800e07e5635aba9a264c47df977a2e7db5184771c0dfd3e52cca61bd466fa403fd73dd16395e146f735b1d9f3834d56ecd3e5170bacd61316ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceba558930d2d7ad5d4017aefe9f10522b546f422de30fb56b4f161a79e7848a5b592ec2954f191ef51e7f568881a8912fe10a3d2d658b5e00eaec73414e5d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b96cdc2e6cb6278acde90c7234cad7840e8695a60b14ad2d46881a4b6693c2299d8a805a940b4fdfecc0dcd926d6c2d7c8ecfee957b4c4c841fb238d8db18e33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 16:55:46.641105) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:55:46.641424) ========= 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=62c568580acbfdaac3eec7be000001dc-1487032508.517929-83878177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 16:55:46.724795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 16:55:46.725123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 16:55:46.725423) ========= ========= Total master_lag: 0.17 =========