builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1486495226.2 results: success (0) buildid: 20170207093257 builduid: d1b00b423c824d54aec10f4ec8a66f6b revision: be5204c4c3eeadb750181b939e58fbecada490db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.202839) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.203420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.203767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.220509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.220878) ========= 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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-07 11:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2017-02-07 11:20:26 (213 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157365 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.392470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.392861) ========= 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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:26.444773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 11:20:26.445153) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev be5204c4c3eeadb750181b939e58fbecada490db --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 be5204c4c3eeadb750181b939e58fbecada490db --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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-07 11:20:26,962 truncating revision to first 12 chars 2017-02-07 11:20:26,962 Setting DEBUG logging. 2017-02-07 11:20:26,962 attempt 1/10 2017-02-07 11:20:26,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/be5204c4c3ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 11:20:28,340 unpacking tar archive at: mozilla-beta-be5204c4c3ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.763241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 11:20:28.222377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:28.222802) ========= script_repo_revision: be5204c4c3eeadb750181b939e58fbecada490db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:28.223297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:28.223629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 11:20:28.234718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-07 11:20:28.235033) ========= /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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:28 INFO - MultiFileLogger online at 20170207 11:20:28 in /builds/slave/test 11:20:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:20:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:28 INFO - {'append_to_log': False, 11:20:28 INFO - 'base_work_dir': '/builds/slave/test', 11:20:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:20:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:28 INFO - 'branch': 'Mozilla-Beta', 11:20:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:28 INFO - 'config_files': ('talos/linux_config.py',), 11:20:28 INFO - 'default_actions': ('clobber', 11:20:28 INFO - 'read-buildbot-config', 11:20:28 INFO - 'download-and-extract', 11:20:28 INFO - 'populate-webroot', 11:20:28 INFO - 'create-virtualenv', 11:20:28 INFO - 'install', 11:20:28 INFO - 'run-tests'), 11:20:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:28 INFO - 'download_minidump_stackwalk': True, 11:20:28 INFO - 'download_symbols': 'ondemand', 11:20:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:28 INFO - 'installer_path': 'installer.exe', 11:20:28 INFO - 'log_level': 'info', 11:20:28 INFO - 'log_name': 'talos', 11:20:28 INFO - 'log_to_console': True, 11:20:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:28 INFO - 'opt_config_files': (), 11:20:28 INFO - 'pip_index': False, 11:20:28 INFO - 'sps_profile': False, 11:20:28 INFO - 'sps_profile_interval': 0, 11:20:28 INFO - 'suite': 'dromaeojs', 11:20:28 INFO - 'system_bits': '32', 11:20:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:28 INFO - 'title': 'talos-linux64-ix-008', 11:20:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:28 INFO - 'use_talos_json': True, 11:20:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:28 INFO - 'work_dir': 'build'} 11:20:28 INFO - [mozharness: 2017-02-07 19:20:28.849757Z] Running clobber step. 11:20:28 INFO - Running pre-action listener: _resource_record_pre_action 11:20:28 INFO - Running main action method: clobber 11:20:28 INFO - rmtree: /builds/slave/test/build 11:20:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:29 INFO - Running post-action listener: _resource_record_post_action 11:20:29 INFO - [mozharness: 2017-02-07 19:20:29.867412Z] Finished clobber step (success) 11:20:29 INFO - [mozharness: 2017-02-07 19:20:29.867510Z] Running read-buildbot-config step. 11:20:29 INFO - Running pre-action listener: _resource_record_pre_action 11:20:29 INFO - Running main action method: read_buildbot_config 11:20:29 INFO - Using buildbot properties: 11:20:29 INFO - { 11:20:29 INFO - "project": "", 11:20:29 INFO - "product": "firefox", 11:20:29 INFO - "script_repo_revision": "production", 11:20:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:20:29 INFO - "repository": "", 11:20:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:20:29 INFO - "buildid": "20170207093257", 11:20:29 INFO - "pgo_build": "True", 11:20:29 INFO - "basedir": "/builds/slave/test", 11:20:29 INFO - "buildnumber": 547, 11:20:29 INFO - "slavename": "talos-linux64-ix-008", 11:20:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:20:29 INFO - "platform": "ubuntu64_hw", 11:20:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:20:29 INFO - "branch": "mozilla-beta", 11:20:29 INFO - "repo_path": "releases/mozilla-beta", 11:20:29 INFO - "revision": "be5204c4c3eeadb750181b939e58fbecada490db", 11:20:29 INFO - "stage_platform": "linux64-pgo", 11:20:29 INFO - "builduid": "d1b00b423c824d54aec10f4ec8a66f6b", 11:20:29 INFO - "slavebuilddir": "test" 11:20:29 INFO - } 11:20:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 11:20:29 INFO - Running post-action listener: _resource_record_post_action 11:20:29 INFO - [mozharness: 2017-02-07 19:20:29.869914Z] Finished read-buildbot-config step (success) 11:20:29 INFO - [mozharness: 2017-02-07 19:20:29.870002Z] Running download-and-extract step. 11:20:29 INFO - Running pre-action listener: _resource_record_pre_action 11:20:29 INFO - Running main action method: download_and_extract 11:20:29 INFO - mkdir: /builds/slave/test/build/tests 11:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:29 INFO - trying https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:20:29 INFO - Downloading https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:20:30 INFO - Downloaded 1327 bytes. 11:20:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 11:20:30 INFO - Using the following test package requirements: 11:20:30 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:20:30 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:30 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 11:20:30 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'jsshell-linux-x86_64.zip'], 11:20:30 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:30 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 11:20:30 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 11:20:30 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 11:20:30 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:30 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 11:20:30 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:30 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:20:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:30 INFO - Fetch https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:20:31 INFO - Http code: 200 11:20:31 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 11:20:31 INFO - x-amz-cf-id: ty7MYScQSQPXtkwAFWbuf0TYvW6hDY_sOHBZ9RYhuUXt5m77aXjWHg== 11:20:31 INFO - x-amz-version-id: sf3uMeFN7sJ0vxiOhW262OctgO8.3CKu 11:20:31 INFO - Expected file size: 21957597 11:20:31 INFO - Obtained file size: 21957597 11:20:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 11:20:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:35 INFO - Fetch https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 11:20:36 INFO - Http code: 200 11:20:36 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:20:36 INFO - x-amz-cf-id: JY-TgkFKF4sB_1S6-UBjUwWHqhrEhqPhfu4V53Dx1TdOBndO-8QCBg== 11:20:36 INFO - x-amz-version-id: sf3uMeFN7sJ0vxiOhW262OctgO8.3CKu 11:20:36 INFO - Expected file size: 21957597 11:20:36 INFO - Obtained file size: 21957597 11:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 11:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 11:20:41 INFO - Http code: 200 11:20:41 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:20:41 INFO - x-amz-cf-id: -Lwl0mChR01_rM8-ZY_FqP1ffMg0o9E9G-H6JqQhwxwtRlQMpI8How== 11:20:41 INFO - x-amz-version-id: 9W_ipaKsFZaXoILeOCBz_ZK3i3h77wVW 11:20:41 INFO - Expected file size: 14403005 11:20:41 INFO - Obtained file size: 14403005 11:20: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')]} 11:20:41 INFO - trying https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:20:41 INFO - Downloading https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:20:42 INFO - Downloaded 57727189 bytes. 11:20:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:20:42 INFO - mkdir: /builds/slave/test/properties 11:20:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:42 INFO - Contents: 11:20:42 INFO - build_url:https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 11:20:43 INFO - Running post-action listener: _resource_record_post_action 11:20:43 INFO - Running post-action listener: set_extra_try_arguments 11:20:43 INFO - [mozharness: 2017-02-07 19:20:43.553231Z] Finished download-and-extract step (success) 11:20:43 INFO - [mozharness: 2017-02-07 19:20:43.553546Z] Running populate-webroot step. 11:20:43 INFO - Running pre-action listener: _resource_record_pre_action 11:20:43 INFO - Running main action method: populate_webroot 11:20:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:43 INFO - '--tppagecycles', 11:20:43 INFO - '7'], 11:20:43 INFO - 'tests': ['tsvgm']}}, 11:20:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['damp', 'tps']}, 11:20:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'tests': ['damp', 'tps']}, 11:20:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['dromaeo_dom']}, 11:20:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['basic_compositor_video']}, 11:20:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['a11yr', 11:20:43 INFO - 'ts_paint', 11:20:43 INFO - 'tpaint', 11:20:43 INFO - 'sessionrestore', 11:20:43 INFO - 'sessionrestore_no_auto_restore', 11:20:43 INFO - 'tabpaint']}, 11:20:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['tsvgx', 11:20:43 INFO - 'tsvgr_opacity', 11:20:43 INFO - 'tart', 11:20:43 INFO - 'tscrollx', 11:20:43 INFO - 'cart']}, 11:20:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:43 INFO - 'tsvgr_opacity', 11:20:43 INFO - 'tart', 11:20:43 INFO - 'tscrollx', 11:20:43 INFO - 'cart']}, 11:20:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-e10s'], 11:20:43 INFO - 'tests': ['tp5o']}, 11:20:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'tests': ['tp5o']}, 11:20:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'talos_options': ['--disable-e10s', 11:20:43 INFO - '--xperf_path', 11:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:43 INFO - 'tests': ['tp5n']}, 11:20:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:43 INFO - 'talos_options': ['--xperf_path', 11:20:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:43 INFO - 'tests': ['tp5n']}}, 11:20:43 INFO - 'talos.zip': {'path': '', 11:20:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:43 INFO - Running post-action listener: _resource_record_post_action 11:20:43 INFO - [mozharness: 2017-02-07 19:20:43.569236Z] Finished populate-webroot step (success) 11:20:43 INFO - [mozharness: 2017-02-07 19:20:43.569324Z] Running create-virtualenv step. 11:20:43 INFO - Running pre-action listener: _resource_record_pre_action 11:20:43 INFO - Running main action method: create_virtualenv 11:20:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:43 INFO - Using real prefix '/usr' 11:20:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:46 INFO - Installing pip.................done. 11:20:46 INFO - Return code: 0 11:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:46 INFO - Reading from file tmpfile_stdout 11:20:46 INFO - Output received: 11:20:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:20:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:46 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:46 INFO - Using env: {'DISPLAY': ':0', 11:20:46 INFO - 'HOME': '/home/cltbld', 11:20:46 INFO - 'LANG': 'en_US.UTF-8', 11:20:46 INFO - 'LANGUAGE': 'en_US:en', 11:20:46 INFO - 'LOGNAME': 'cltbld', 11:20:46 INFO - 'MAIL': '/var/mail/cltbld', 11:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:46 INFO - 'MOZ_NO_REMOTE': '1', 11:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:46 INFO - 'NO_EM_RESTART': '1', 11:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:46 INFO - 'PWD': '/builds/slave/test', 11:20:46 INFO - 'SHELL': '/bin/bash', 11:20:46 INFO - 'SHLVL': '1', 11:20:46 INFO - 'TERM': 'linux', 11:20:46 INFO - 'TMOUT': '86400', 11:20:46 INFO - 'USER': 'cltbld', 11:20:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:46 INFO - '_': '/tools/buildbot/bin/python'} 11:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:46 INFO - Cleaning up... 11:20:46 INFO - Return code: 0 11:20:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:46 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:46 INFO - Using env: {'DISPLAY': ':0', 11:20:46 INFO - 'HOME': '/home/cltbld', 11:20:46 INFO - 'LANG': 'en_US.UTF-8', 11:20:46 INFO - 'LANGUAGE': 'en_US:en', 11:20:46 INFO - 'LOGNAME': 'cltbld', 11:20:46 INFO - 'MAIL': '/var/mail/cltbld', 11:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:46 INFO - 'MOZ_NO_REMOTE': '1', 11:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:46 INFO - 'NO_EM_RESTART': '1', 11:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:46 INFO - 'PWD': '/builds/slave/test', 11:20:46 INFO - 'SHELL': '/bin/bash', 11:20:46 INFO - 'SHLVL': '1', 11:20:46 INFO - 'TERM': 'linux', 11:20:46 INFO - 'TMOUT': '86400', 11:20:46 INFO - 'USER': 'cltbld', 11:20:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:46 INFO - '_': '/tools/buildbot/bin/python'} 11:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:46 INFO - Downloading/unpacking psutil>=3.1.1 11:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:48 INFO - Installing collected packages: psutil 11:20:48 INFO - Running setup.py install for psutil 11:20:49 INFO - building 'psutil._psutil_linux' extension 11:20:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:49 INFO - building 'psutil._psutil_posix' extension 11:20:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:49 INFO - Successfully installed psutil 11:20:49 INFO - Cleaning up... 11:20:49 INFO - Return code: 0 11:20:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:49 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:49 INFO - Using env: {'DISPLAY': ':0', 11:20:49 INFO - 'HOME': '/home/cltbld', 11:20:49 INFO - 'LANG': 'en_US.UTF-8', 11:20:49 INFO - 'LANGUAGE': 'en_US:en', 11:20:49 INFO - 'LOGNAME': 'cltbld', 11:20:49 INFO - 'MAIL': '/var/mail/cltbld', 11:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:49 INFO - 'MOZ_NO_REMOTE': '1', 11:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:49 INFO - 'NO_EM_RESTART': '1', 11:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:49 INFO - 'PWD': '/builds/slave/test', 11:20:49 INFO - 'SHELL': '/bin/bash', 11:20:49 INFO - 'SHLVL': '1', 11:20:49 INFO - 'TERM': 'linux', 11:20:49 INFO - 'TMOUT': '86400', 11:20:49 INFO - 'USER': 'cltbld', 11:20:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:49 INFO - '_': '/tools/buildbot/bin/python'} 11:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:51 INFO - Installing collected packages: mozsystemmonitor 11:20:51 INFO - Running setup.py install for mozsystemmonitor 11:20:51 INFO - Successfully installed mozsystemmonitor 11:20:51 INFO - Cleaning up... 11:20:51 INFO - Return code: 0 11:20:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:51 INFO - Using env: {'DISPLAY': ':0', 11:20:51 INFO - 'HOME': '/home/cltbld', 11:20:51 INFO - 'LANG': 'en_US.UTF-8', 11:20:51 INFO - 'LANGUAGE': 'en_US:en', 11:20:51 INFO - 'LOGNAME': 'cltbld', 11:20:51 INFO - 'MAIL': '/var/mail/cltbld', 11:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:51 INFO - 'MOZ_NO_REMOTE': '1', 11:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:51 INFO - 'NO_EM_RESTART': '1', 11:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:51 INFO - 'PWD': '/builds/slave/test', 11:20:51 INFO - 'SHELL': '/bin/bash', 11:20:51 INFO - 'SHLVL': '1', 11:20:51 INFO - 'TERM': 'linux', 11:20:51 INFO - 'TMOUT': '86400', 11:20:51 INFO - 'USER': 'cltbld', 11:20:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:51 INFO - '_': '/tools/buildbot/bin/python'} 11:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:54 INFO - warning: no files found matching '*.txt' 11:20:54 INFO - no previously-included directories found matching 'build' 11:20:54 INFO - no previously-included directories found matching 'dist' 11:20:54 INFO - no previously-included directories found matching '.git*' 11:20:54 INFO - Installing collected packages: jsonschema, functools32 11:20:54 INFO - Running setup.py install for functools32 11:20:54 INFO - warning: no files found matching '*.txt' 11:20:54 INFO - no previously-included directories found matching 'build' 11:20:54 INFO - no previously-included directories found matching 'dist' 11:20:54 INFO - no previously-included directories found matching '.git*' 11:20:54 INFO - Successfully installed jsonschema functools32 11:20:54 INFO - Cleaning up... 11:20:54 INFO - Return code: 0 11:20:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:20:54 INFO - Using env: {'DISPLAY': ':0', 11:20:54 INFO - 'HOME': '/home/cltbld', 11:20:54 INFO - 'LANG': 'en_US.UTF-8', 11:20:54 INFO - 'LANGUAGE': 'en_US:en', 11:20:54 INFO - 'LOGNAME': 'cltbld', 11:20:54 INFO - 'MAIL': '/var/mail/cltbld', 11:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:54 INFO - 'MOZ_NO_REMOTE': '1', 11:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:54 INFO - 'NO_EM_RESTART': '1', 11:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:54 INFO - 'PWD': '/builds/slave/test', 11:20:54 INFO - 'SHELL': '/bin/bash', 11:20:54 INFO - 'SHLVL': '1', 11:20:54 INFO - 'TERM': 'linux', 11:20:54 INFO - 'TMOUT': '86400', 11:20:54 INFO - 'USER': 'cltbld', 11:20:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:54 INFO - '_': '/tools/buildbot/bin/python'} 11:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:54 INFO - Cleaning up... 11:20:54 INFO - Return code: 0 11:20:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:20:54 INFO - Using env: {'DISPLAY': ':0', 11:20:54 INFO - 'HOME': '/home/cltbld', 11:20:54 INFO - 'LANG': 'en_US.UTF-8', 11:20:54 INFO - 'LANGUAGE': 'en_US:en', 11:20:54 INFO - 'LOGNAME': 'cltbld', 11:20:54 INFO - 'MAIL': '/var/mail/cltbld', 11:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:54 INFO - 'MOZ_NO_REMOTE': '1', 11:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:54 INFO - 'NO_EM_RESTART': '1', 11:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:54 INFO - 'PWD': '/builds/slave/test', 11:20:54 INFO - 'SHELL': '/bin/bash', 11:20:54 INFO - 'SHLVL': '1', 11:20:54 INFO - 'TERM': 'linux', 11:20:54 INFO - 'TMOUT': '86400', 11:20:54 INFO - 'USER': 'cltbld', 11:20:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:54 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Downloading docopt-0.6.1.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:57 INFO - Running setup.py install for blobuploader 11:20:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:58 INFO - Running setup.py install for requests 11:20:58 INFO - Running setup.py install for docopt 11:20:58 INFO - Successfully installed blobuploader requests docopt 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:58 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:58 INFO - Running setup.py (path:/tmp/pip-O9IfFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:58 INFO - Running setup.py (path:/tmp/pip-9fi9VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:58 INFO - Running setup.py (path:/tmp/pip-6cgzHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:58 INFO - Running setup.py (path:/tmp/pip-rrRZHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:59 INFO - Running setup.py (path:/tmp/pip-NQsYQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 INFO - Running setup.py (path:/tmp/pip-HVp8iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 INFO - Running setup.py (path:/tmp/pip-lZAaHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 INFO - Running setup.py (path:/tmp/pip-z1hYsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:59 INFO - Running setup.py (path:/tmp/pip-gKbAxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:59 INFO - Running setup.py (path:/tmp/pip-5EntVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 INFO - Running setup.py (path:/tmp/pip-iOpgg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:59 INFO - Running setup.py (path:/tmp/pip-b5kW8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:59 INFO - Running setup.py (path:/tmp/pip-ApeMaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:59 INFO - Running setup.py (path:/tmp/pip-pQLlXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:59 INFO - Running setup.py (path:/tmp/pip-wuKewA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:59 INFO - Running setup.py (path:/tmp/pip-WEUExP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:59 INFO - Running setup.py (path:/tmp/pip-HrHKjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:59 INFO - Running setup.py install for manifestparser 11:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozcrash 11:21:00 INFO - Running setup.py install for mozdebug 11:21:00 INFO - Running setup.py install for mozdevice 11:21:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozfile 11:21:00 INFO - Running setup.py install for mozhttpd 11:21:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozinfo 11:21:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozInstall 11:21:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozleak 11:21:00 INFO - Running setup.py install for mozlog 11:21:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for moznetwork 11:21:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozprocess 11:21:01 INFO - Running setup.py install for mozprofile 11:21:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozrunner 11:21:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Running setup.py install for mozscreenshot 11:21:01 INFO - Running setup.py install for moztest 11:21:01 INFO - Running setup.py install for mozversion 11:21:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:01 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:01 INFO - Using env: {'DISPLAY': ':0', 11:21:01 INFO - 'HOME': '/home/cltbld', 11:21:01 INFO - 'LANG': 'en_US.UTF-8', 11:21:01 INFO - 'LANGUAGE': 'en_US:en', 11:21:01 INFO - 'LOGNAME': 'cltbld', 11:21:01 INFO - 'MAIL': '/var/mail/cltbld', 11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:01 INFO - 'MOZ_NO_REMOTE': '1', 11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:01 INFO - 'NO_EM_RESTART': '1', 11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:01 INFO - 'PWD': '/builds/slave/test', 11:21:01 INFO - 'SHELL': '/bin/bash', 11:21:01 INFO - 'SHLVL': '1', 11:21:01 INFO - 'TERM': 'linux', 11:21:01 INFO - 'TMOUT': '86400', 11:21:01 INFO - 'USER': 'cltbld', 11:21:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:01 INFO - '_': '/tools/buildbot/bin/python'} 11:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Running setup.py (path:/tmp/pip-8ZKCUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Running setup.py (path:/tmp/pip-3L2yXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Running setup.py (path:/tmp/pip-jph3px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Running setup.py (path:/tmp/pip-4ZpMTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Running setup.py (path:/tmp/pip-NNCGAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:02 INFO - Running setup.py (path:/tmp/pip-DU8th8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:02 INFO - Running setup.py (path:/tmp/pip-vUuAzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:02 INFO - Running setup.py (path:/tmp/pip-_Nrbf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:02 INFO - Running setup.py (path:/tmp/pip-H_c0Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:02 INFO - Running setup.py (path:/tmp/pip-aayhHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:02 INFO - Running setup.py (path:/tmp/pip-5ZUMkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:02 INFO - Running setup.py (path:/tmp/pip-z_w3g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:02 INFO - Running setup.py (path:/tmp/pip-siDhm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:02 INFO - Running setup.py (path:/tmp/pip-QthDCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Running setup.py (path:/tmp/pip-rJS_Ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Running setup.py (path:/tmp/pip-gFBUXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Running setup.py (path:/tmp/pip-4mLMok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Downloading blessings-1.6.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:05 INFO - Installing collected packages: blessings 11:21:05 INFO - Running setup.py install for blessings 11:21:05 INFO - Successfully installed blessings 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:05 INFO - Reading from file tmpfile_stdout 11:21:05 INFO - Current package versions: 11:21:05 INFO - argparse == 1.2.1 11:21:05 INFO - blessings == 1.6 11:21:05 INFO - blobuploader == 1.2.4 11:21:05 INFO - docopt == 0.6.1 11:21:05 INFO - functools32 == 3.2.3-2 11:21:05 INFO - jsonschema == 2.5.1 11:21:05 INFO - manifestparser == 1.1 11:21:05 INFO - mozInstall == 1.12 11:21:05 INFO - mozcrash == 1.0 11:21:05 INFO - mozdebug == 0.1 11:21:05 INFO - mozdevice == 0.48 11:21:05 INFO - mozfile == 1.2 11:21:05 INFO - mozhttpd == 0.7 11:21:05 INFO - mozinfo == 0.9 11:21:05 INFO - mozleak == 0.1 11:21:05 INFO - mozlog == 3.4 11:21:05 INFO - moznetwork == 0.27 11:21:05 INFO - mozprocess == 0.23 11:21:05 INFO - mozprofile == 0.28 11:21:05 INFO - mozrunner == 6.13 11:21:05 INFO - mozscreenshot == 0.1 11:21:05 INFO - mozsystemmonitor == 0.3 11:21:05 INFO - moztest == 0.8 11:21:05 INFO - mozversion == 1.4 11:21:05 INFO - psutil == 3.1.1 11:21:05 INFO - requests == 1.2.3 11:21:05 INFO - wsgiref == 0.1.2 11:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:05 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 0x7fdf4b43af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, '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': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Running post-action listener: _resource_record_post_action 11:21:06 INFO - Running post-action listener: _start_resource_monitoring 11:21:06 INFO - Starting resource monitoring. 11:21:06 INFO - [mozharness: 2017-02-07 19:21:06.230898Z] Finished create-virtualenv step (success) 11:21:06 INFO - [mozharness: 2017-02-07 19:21:06.231413Z] Running install step. 11:21:06 INFO - Running pre-action listener: _resource_record_pre_action 11:21:06 INFO - Running main action method: install 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:06 INFO - Reading from file tmpfile_stdout 11:21:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:06 INFO - Reading from file tmpfile_stdout 11:21:06 INFO - Output received: 11:21:06 INFO - Usage: mozinstall [options] installer 11:21:06 INFO - Options: 11:21:06 INFO - -h, --help show this help message and exit 11:21:06 INFO - -d DEST, --destination=DEST 11:21:06 INFO - Directory to install application into. [default: 11:21:06 INFO - "/builds/slave/test"] 11:21:06 INFO - --app=APP Application being installed. [default: firefox] 11:21:06 INFO - mkdir: /builds/slave/test/build/application 11:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:21:20 INFO - Reading from file tmpfile_stdout 11:21:20 INFO - Output received: 11:21:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:20 INFO - Running post-action listener: _resource_record_post_action 11:21:20 INFO - [mozharness: 2017-02-07 19:21:20.160190Z] Finished install step (success) 11:21:20 INFO - [mozharness: 2017-02-07 19:21:20.160432Z] Running run-tests step. 11:21:20 INFO - Running pre-action listener: _resource_record_pre_action 11:21:20 INFO - Running main action method: run_tests 11:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:20 INFO - Python 2.7.3 11:21:20 INFO - Return code: 0 11:21:20 INFO - grabbing minidump binary from tooltool 11:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:20 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 0x265bf60>, '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 0x265cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:20 INFO - Return code: 0 11:21:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:20 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/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:21:20 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/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:21:20 INFO - Using env: {'DISPLAY': ':0', 11:21:20 INFO - 'HOME': '/home/cltbld', 11:21:20 INFO - 'LANG': 'en_US.UTF-8', 11:21:20 INFO - 'LANGUAGE': 'en_US:en', 11:21:20 INFO - 'LOGNAME': 'cltbld', 11:21:20 INFO - 'MAIL': '/var/mail/cltbld', 11:21:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:20 INFO - 'MOZ_NO_REMOTE': '1', 11:21:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:20 INFO - 'NO_EM_RESTART': '1', 11:21:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:20 INFO - 'PWD': '/builds/slave/test', 11:21:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:20 INFO - 'SHELL': '/bin/bash', 11:21:20 INFO - 'SHLVL': '1', 11:21:20 INFO - 'TERM': 'linux', 11:21:20 INFO - 'TMOUT': '86400', 11:21:20 INFO - 'USER': 'cltbld', 11:21:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757', 11:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:20 INFO - '_': '/tools/buildbot/bin/python'} 11:21:20 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/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:21:20 INFO - mozversion application_buildid: 20170207093257 11:21:20 INFO - mozversion application_changeset: be5204c4c3eeadb750181b939e58fbecada490db 11:21:20 INFO - mozversion application_display_name: Firefox 11:21:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:20 INFO - mozversion application_name: Firefox 11:21:20 INFO - mozversion application_remotingname: firefox 11:21:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:20 INFO - mozversion application_vendor: Mozilla 11:21:20 INFO - mozversion application_version: 52.0 11:21:20 INFO - mozversion platform_buildid: 20170207093257 11:21:20 INFO - mozversion platform_changeset: be5204c4c3eeadb750181b939e58fbecada490db 11:21:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:20 INFO - mozversion platform_version: 52.0 11:21:20 INFO - using testdate: 1486495280 11:21:20 INFO - actual date: 1486495280 11:21:20 INFO - starting webserver on 'localhost:48579' 11:21:20 INFO - SUITE-START | Running 2 tests 11:21:20 INFO - TEST-START | dromaeo_css 11:21:20 INFO - operating with platform_type : linux_ 11:21:20 INFO - Initialising browser for dromaeo_css test... 11:21:20 INFO - TEST-INFO | started process 18554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFD20ye/profile http://localhost:48579/getInfo.html) 11:21:24 INFO - PROCESS | 18554 | __metrics Screen width/height:1600/1200 11:21:24 INFO - PROCESS | 18554 | colorDepth:24 11:21:24 INFO - PROCESS | 18554 | Browser inner width/height: 1024/697 11:21:24 INFO - PROCESS | 18554 | __metrics 11:21:24 INFO - PROCESS | 18554 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:24 INFO - PROCESS | 18554 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:25 INFO - PROCESS | 18554 | console.error: PushService: 11:21:25 INFO - PROCESS | 18554 | stateChangeProcessEnqueue: Error transitioning state 11:21:25 INFO - PROCESS | 18554 | UnknownError 11:21:25 INFO - TEST-INFO | 18554: exit 0 11:21:25 INFO - Browser initialized. 11:21:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:25 INFO - TEST-INFO | started process 18644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFD20ye/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:37 INFO - PROCESS | 18644 | RSS: Main: 141406208 11:21:37 INFO - PROCESS | 18644 | 11:24:38 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48579/tests/dromaeo/cssquery-ext.html) 11:24:40 INFO - PROCESS | 18644 | RSS: Main: 223825920 11:24:40 INFO - PROCESS | 18644 | 11:27:42 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-ext.html (next: http://localhost:48579/tests/dromaeo/cssquery-jquery.html) 11:27:42 INFO - PROCESS | 18644 | RSS: Main: 226770944 11:27:42 INFO - PROCESS | 18644 | 11:30:44 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48579/tests/dromaeo/cssquery-mootools.html) 11:30:45 INFO - PROCESS | 18644 | RSS: Main: 214241280 11:30:45 INFO - PROCESS | 18644 | 11:33:47 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48579/tests/dromaeo/cssquery-prototype.html) 11:33:47 INFO - PROCESS | 18644 | RSS: Main: 173682688 11:33:47 INFO - PROCESS | 18644 | 11:36:50 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48579/tests/dromaeo/cssquery-yui.html) 11:36:51 INFO - PROCESS | 18644 | RSS: Main: 176578560 11:36:51 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | Cycle 1(1): loaded http://localhost:48579/tests/dromaeo/cssquery-yui.html (next: http://localhost:48579/tests/dromaeo/cssquery-dojo.html) 11:39:53 INFO - PROCESS | 18644 | RSS: Main: 265461760 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | __start_tp_report 11:39:53 INFO - PROCESS | 18644 | _x_x_mozilla_page_load 11:39:53 INFO - PROCESS | 18644 | _x_x_mozilla_page_load_details 11:39:53 INFO - PROCESS | 18644 | |i|pagename|runs| 11:39:53 INFO - PROCESS | 18644 | |0;dojo.html;3204.1348835814324;3259.348130373925;3264.2002709336202;3298.356820420019;3315.5855518060243;5500.862478438041;5597.272354593907;5608.859778505534;5617.241672374228;5618.297712785902;5553.7778488860395;5607.102863541834;5608.551315894729;5617.9157312640245;5653.321601407826;5051.015052064839;5074.112030394685;5104.2088476286235;5151.356080489939;5184.248283998818;5015.523525265112;5026.070177017264;5161.380634323887;5182.196759502283;5186.844394668166;5097.974510127444;5103.948960510403;5151.896962060757;5173.224016397533;5178.5339319461245;5190.740462976855;5253.474652534755;5259.658122222043;5268.104422248208;5285.022270879899;4985.227289770091;4992.400911890596;5151.253068305112;5171.146760784466;5229.477052294778;5439.374471935738;5449;5466.098093814516;5472.671639701631;5528.170774383834;5921.555883308769;5941.316748573926;5948.078047902582;5956.672383018932;6004.099385092228;5850.590458667895;5900.350961394243;5973.970130149321;6021.909671354933;6049.032154855246;5579.609427340088;5579.944200557983;5626.43735626434;5628.437156284339;5664.461876121762;6174.197354343906;6180.6909654517995;6184.381561843779;6188.907166392508;6189.96905015481;5759.280089988752;5805.709714514257;5902.61632993854;5909.881802363929;5915.615484993547;5913.852153696192;6000.309964354068;6001.909971350433;6057.242844644419;6085.817425477243;6009.098635204667;6017.157597936292;6031.819045428644;6033.637981721111;6039.396060393926;5832.24180856486;5978.402159784074;6053.273607167168;6057.061155520902;6081.239845019372;4573.176828170961;4595.954040459619;4625.629949604024;4626.976865115653;4627.814887404466;4096.56986016464;4125.092479654471;4127.9587204128175;4147.8963025924595;4149.087200815816;5754.251947246831;5757.913631295534;5763.337216220105;5766.567507436959;5774.913376299359;6022.247219097613;6058.939410605837;6063.969680151571;6066.363031881677;6074.9392506075255;5570.916436253459;5608.747606357723;5629.352624448241;5685.857853553694;5736.541076713853;5180.559652429586;5187.06632806091;5193.844184674465;5197.766100525486;5228.346456692913;6212.627242365382;6243.594166379171;6262.812115636447;6265.8746825063245;6270.592411493239;5894.263217097863;5945.64326140433;5954.553408494294;5970.3432622412365;6045.093236014457;6172.567920245539;6277.780277690259;6280.246370435394;6283.5601507895835;6285.088662144055;5927.321293306182;5932;5933.406659334032;5938.6436813791315;5976.61152025117;5879.382664820132;5879.911801322898;6060.848478788065;6061.696915154136;6072.210612620508;5801;5846.093855452412;5859.912101318569;5860.472557469848;5935.643861368331;5858.355580886014;5899.085641725539;5901.3213480448585;5903.11453281994;5916.704164791657;5638.407967163389;5885.558583106199;5893.145493903446;5894.557908156819;5899.439553242435;5762.193292939076;5785.450382213683;5814.912776308443;5835.94164058371;5874;5753.942460575508;5756.107803290497;5758.366579676149;5770.278715160605;5770.855728606651 11:39:53 INFO - PROCESS | 18644 | |1;ext.html;580.9912851307229;613.9109829074785;651.9217693876734;656.6815094679083;662.7614058938781;34423.65576344236;36751.999999999935;36761.26477470449;36769.63230367695;45151.548484515144;43391.566084339145;47406;47422.288665669956;47462;47484.0503189936;8931.374803763723;9074.500902450363;9084.18242358191;9084.454932704026;9090.090990900922;8534.530600816952;8780.341474389414;8786.736397908073;8901.332400070021;10655.147588192925;10647.414392208426;10936.56253749849;10980.450977451135;11026.228164028522;11026.889731102707;10847.132229421628;10872.945635271852;10896.564137434492;10903.890961090367;10911.07255883251;10711.678649640524;10788.676339709822;10794.514246858911;10807.945960270226;10810.67567972962;44206;44570.33144502835;44669.55330446686;44674.77662611699;44689;3565.8573657053685;3577.3918433866047;3627.4921510988484;3695.0392897846755;3750.5686846012786;31091.067267981998;32902.177445564055;33031.50452743211;33200.33599328024;33288.83355583231;4556.954430455686;4587.9541204588195;4616.699914505546;4629.629629629621;4639.652026098022;338529;338710;339518;339615;341808;62551.37448625547;62801.057984130275;62872;62909.37090629035;62958.055629165596;39248.215035699126;40689.38965915514;64890.67554662196;65028;65293.67353163204;19211.903940480486;19486;19487.123079461457;19488.123034463482;19492.70760938587;14675.119492830465;14826.481073162387;14833.035852669542;14875.70248595022;14882.553523394316;18393.356232532064;18866.71699924502;19833.30583429573;20528.486787830127;20575;7132.714691412285;7159.921233869382;7334.926650733424;7361.558306501627;7402.555846649218;965.8937516873139;1002.5037606384886;1028.665683652816;1055.762453447968;1101.432762127505;31988.520172197437;32147.839260804016;32338.514922276183;32999.67000329966;33034.504482432785;1108.4900945564968;1160.5067846165346;1170.3329102411715;1206.7888119579038;1229.932353720554;14764.926175369055;17509.474715758548;18037.909810450863;18308.542286442946;19064.904675476533;507869;508461;508576;511392;512527;61657;61996;62069;62156.68921655363;62168.37831621716;1283.7625039367747;1356.1659579358623;1366.7539842828387;1372.5745019044127;1412.6892083741561;30414.695853041187;32349.838250808596;33970.15074623154;34006.48990265198;34172.82913585516;51589;52122.21816672677;52148.21777673262;52156;52159.73920130375;316238;318208;318258;318397;318984;26789.196324110308;27230.455390892468;29371;30024;30292.84853575718;47820.760896195294;47862;48094;48425.27362089642;48801.75599121982;40549.8144874123;40864.18271634491;40904.590954090076;42108.157836843704;42179.57820421879;40527.79736101301;40752.59247407488;40794;42350.576494234665;42407.36388954106;40774.38838417367;41546.79226603969;41739.37390939078;41911.7904410476;41958.370624440046;33669.49495757615;35958.460623091196;36314.455283170246;36565.81717091398;36865.815670921475;28447.43105137927;28458.43083138367;28544.42911141724;28655.57016644794;28700.856495717388 11:39:53 INFO - PROCESS | 18644 | |2;jquery.html;401.5362256593632;404.0807163702576;414.761512130525;415.14480170848054;426.5222950295669;14518.419263229485;18599.814001859977;19611.803881961176;20319.085641146165;20352.287669931575;15620.453284135057;16770.74843877343;18960.905195474003;19039.714404283946;19357.128929198185;5732.656040637554;5896.204012458327;5907.704614769265;5908.793192238272;5918.05311150216;5676.574256930726;5814.5057670098095;5814.970925145369;5878.529717622601;5880.26496687914;5817.8836423271505;5820.621659592113;5822.767089316422;5825.126231065332;5840.328362238333;5655.971720141414;5797.188393624875;5800.651960882361;5820.854478638025;5839.065749480105;5218.452062533417;5221.582273418117;5236.293100431431;5251.86870328241;5261.421243663194;22719.204827830945;22734;23232.3030309091;23302;23554.528909421886;2479.838810477313;2487.564676181661;2490.0786708917635;2646.7220941801024;2680.276325392133;10154.187664986783;10241.590336386536;10550.050495455369;13768.24274664893;15243;1859.9907000464912;1862.6274745051044;1905.3045638341905;1911.2641632971267;1947.6299503094508;81899;83298.16701832965;84247;84893.15106848977;86606;11196.720081998015;11286.604968826216;11299.435028248554;11405.144614153805;11640.417979101012;15917.442889498812;15924.442644507619;15934;15935.282912268976;15952.441664541917;7405.814854628569;7808.726694565663;7944.682212711542;8509.404341696021;8661.543227766593;7864.6854125834325;7972.521648701097;7972.720954766555;8090.676372945134;8443.788905277293;4823.614110871122;4844.539768721966;4882.023595280958;4976.527229913152;5044.394672639307;2017.818396344336;2030.664940284866;2039.3677959832498;2052.8768273903615;2056.804603562659;907.8819753432143;978.951052447389;1012.1447376966452;1031.6131450705984;1037.1029059863315;18209.18433459932;18565.071746412625;19075.61848763017;19120.2351905925;19288.710669339973;980.2990861534038;990.8513722941616;995.7560397702609;1012.0385633648064;1030.9278350515392;9716.271279653913;10362.792744145076;10503.2122590806;10512.159027277952;10610.522526486327;444087;450140;460872;463915;464757;89976;91226.54386728157;91880.54059729658;95718.52140739252;95956.52021739847;984.522506584306;994.627014869424;1021.1677482851452;1025.5795123999274;1027.3014350241758;16310.347586096423;16574.419895303607;16611.501654949887;16861.409850655167;17043.914780426017;42376.72869813911;43119.56880431281;43447.696569102976;43842.56157438512;44793.328100079176;59755.70122149535;62115.689421552604;62565.06152407808;62960;63779.68110159419;6147.354527774519;6308.369163083838;7870.898074269492;8834.29325653959;9028.09719028092;12175.45210465549;12284.447199875849;12550.497980080694;12880;13197.670058248621;10551.736206594589;10622.787544248917;10662.680119596114;10772;10953.56185752561;10594.947025264824;10762.031417172491;10914.126869850552;10948;11138.220324577202;11072.169587280825;11454.312741235553;11497.252678575866;11509.712257193638;11569.537218511501;8686.39195256326;8727.73816785472;8761.693340733043;8775.692850750193;8780.253678437404;9421.764455888384;11090.778184436105;11130.443477826238;11190.496427660612;11438.771224575628 11:39:53 INFO - PROCESS | 18644 | |3;mootools.html;1341.0143544494788;1489.9627509312268;1504.29298229832;1669.5408762590287;1812.2026308424302;7307.817304567382;8022.037355517339;8338.332933365331;8346.833063338738;8556.187162219594;8327.16728327167;8408.117147699495;8408.537530435824;8409.159084091587;8410.453320534176;2373.3860974537265;2392.4616961183683;2406.302172370011;2412.4571971306405;2422;2345.6247000479925;2390.4143484846236;2394.1500767227644;2394.844335118212;2403.3030421177923;2187.0814258011674;2189.6496560550313;2213.878236696981;2228.008536201391;2228.0642130305228;2177.618916689573;2197.7582465928735;2214.712087428624;2217.1020736601704;2217.866927984318;2260.6382978723327;2281.0191617604423;2282.224043825091;2283.3264187064688;2283.7259528856475;8199.590020498952;8356.080831108573;8395.790105247417;8458.492490450531;8460.703875364394;5170.353705786777;5318.414974352818;5323.920141197885;5326.067938110815;5329.626926115174;3233.849490089088;3247.41546521626;3288.4245257079915;3307.9503807442907;3481.8781342652887;1088.8366744988236;1106.2256420505678;1113.209621168963;1161.5818305410046;1163.6974386659444;11437.656870293904;11450;11493.655190344303;11529.077673786078;11533.423328833525;4129.2773764591075;4357.607815296638;4377.759223242689;4404.867853964386;4419.712718673276;9176.95411522938;9177.082291770903;9180.17378435944;9182.540872956326;9183.448993060438;5031.798728050837;5106.489351064938;5110.412302585176;5112.309838171874;5116.258142569307;4241.851535196253;4375.146846364992;4592.816287348535;4696.060787842445;4831.347768051339;3792.241551689618;3860.4788353571907;3875.8643447479203;3942.3692209246956;3948.526176858795;1184.620921305174;1192.1297452859462;1200.5737963023175;1203.9036877049814;1215.2040413529153;847.6228078505129;948.7580666930027;974.605284859633;1025.4462590201356;1040.0431602925175;5772.9711351442975;6001.789937352171;6159;6159.353267906895;6258.249010118815;951.3483263964207;974.3958745577787;977.5405559387077;998.8351921932945;1009.9192064634811;3996.004993757803;4276.743395396286;4302.612764851178;4363.258246098171;4408.448943882015;9787.951060244795;10038.297319187586;10068.647597334058;10109.292349535463;10116.74708132288;9835.508224588742;9956.80086398268;10077.193824494023;10118.747031324128;10123.139533139618;7935.722249721232;8084.474509157004;8089;8092.433529652868;8107.1892810718455;5814.447627475383;5841.50347220491;5965.463108320272;5980.850478738066;6021.789237376671;9278.11857873501;9516.809663806824;9517.095875891779;9576.569054392708;9617;9650.806983860424;9735.659251926148;9812.705618831447;9863.76702912136;9875.604975801174;6528.738850445929;6734.696938637871;6735.898961515483;6862.142232220973;6963;7700.691972321044;7886.487378320391;8004.439689221698;8173.591320433836;8178.263956243966;6988.545744526589;7062.258462861531;7118.074650295428;7178.461615378763;7232.240614735588;6628.237752658313;6712.899306510309;7007.859842803014;7097.7160913562875;7112.786616401516;6698.330166983263;6703.731850726112;6753.189617245962;6757.189137303555;6762.154730658668;5229.47705229474;5233.973830130825;5260.710660913686;5406.513413792777;5407.702576358338;5307.230451584576;5347.866303342447;5424.864378390572;5427.267318911896;5450.509454149145 11:39:53 INFO - PROCESS | 18644 | |4;prototype.html;346.4699010513914;350.52153810049276;357.22125765830486;360.16621521178484;363.19733389209847;5373.973130134349;5425.2675888755;5438.592105592082;5473.917891231635;5477.452254774521;5339.759710813013;5353.197020446925;5385.142125966535;5394.676319420838;5416.508406133174;3991.4611527443712;4203.663706903456;4240.745555266694;4254.808533615995;4292.334688123338;4199;4217.954292168296;4225.471816022997;4227.915441691164;4272.658187345005;3986.5016872890887;4186.330187170053;4188.623023927846;4234.9153016939645;4238.597333253351;4084.4281800547947;4094.2016306820333;4144.937825932613;4161.91904047976;4167.4790651168605;3672.1186915140443;3675.981620091909;3679.025058359537;3683.9447408288897;3711.0536813112753;5011.32347133136;5197.324347834795;5198.324217851693;5224.268602395668;5236;4505.2654727929985;4749;4753.31076993834;4761.190597598416;4761.857144285677;5541.722913854291;5552.361478429992;5554;5559.332880054379;5561.416051314594;3942.172143849795;4006.579309172553;4068.9593104068877;4070.653994410479;4085.530164031115;5685.260916080924;5734.397888221718;5736.3403208631125;5741.999999999958;5747.2241247431475;4103.158852435244;4109.219248342805;4110.486189226347;4144.8756537303925;4161.417401563784;4082.4284600156;4199.559046300094;4208.410822484854;4217.4306468626955;4219.8523051693655;4707.411573553306;4727.858164255078;4741.762911854394;4744.928826067612;4782.976085119552;5572.665640061609;5575.330960284792;5579.469950354791;5579.832605021856;5591.916121258185;1403.2422491854488;1405.1709491400122;1406.2617126008722;1406.5920882944035;1411.8799902008238;932.6222879733718;978.9853152202722;980.9068138526828;990.7820279538635;995.875515560555;5177.482251774868;5203.32356793622;5219.921701174486;5239.764210610456;5248.50417630981;5462.481064298885;5483.533899618577;5507.530255938733;5509.5041446270025;5545.417731138253;5214.634975551751;5221.660592061504;5238.947610523922;5381.515663590296;5424.972875135599;2899.608552845381;2945.23423909785;2953.808002479832;2955.6305461817274;2957.3937342844665;5708.914366284509;5746.5977381583725;5750.568707346965;5752.913706294409;5754.1944127822135;5519.69641669712;5614.6631202128;5670.234518340054;5684.834608905165;5698.287714035746;5676.318841739017;5700.657960522299;5723.742431590588;5726.713664316768;5753.453421924911;5298.602604804578;5539.833804985696;5543.780368318963;5555.611107222618;5578.354385456219;5461.836144915659;5470.304205696247;5486.423925487767;5486.835394938158;5512.80705175317;5689.516391106637;5713.628614140068;5715.31416230055;5723.168586052423;5734.655920644608;3918.5885482023978;3987.860424885115;4032.9596704032583;4108.8356465741035;4135.31767258399;5679.438154507378;5695.971520142372;5701.600887937971;5716.399778023414;5726.656400615976;5572.164175373727;5576.525995290446;5586.972065139648;5590.357108932362;5609.971950140223;5443.292371991616;5533.833984980457;5551.25058117149;5560;5578.832635020955;5528.474794894479;5545.417731138173;5547.750351234124;5570.404416356441;5571.721413929368;5474.2609747683555;5568.136938774496;5581.358143813513;5589.736156856479;5617.185508101221;5437.972810135924;5455.454454554513;5465;5473.67157970523;5478.671279723229 11:39:53 INFO - PROCESS | 18644 | |5;yui.html;789.8499285135824;792.7502836606473;810.7243537197354;847.5677404523693;888.6223355074092;14462.5661230163;15076.32156552955;15101.924490377532;15326.770098448533;15409.84590154098;13742.725145497108;14898.180600066991;15082.698346033072;15089.62275943102;15111.093334399944;859.6647307550045;885.0706757904208;885.2519620920312;885.5306687455659;887.529609307065;874.0647507167333;876.9254613357872;877.6489404238292;877.806882485852;878.1964502480255;932.0818993291603;934.2759361494861;935.3966691483989;935.5976929920132;936.035883040466;926.2775035472342;928.2481190235931;928.9489078100702;929.1359036096428;929.4655573045526;679.7179170644176;680.2415306932735;680.5746408494691;680.6868840333452;680.8400025993888;14912.478063267734;15046.473373431878;15838;15947.521574352788;15994.920025399915;14682.70634587313;14898;14902.478413255592;14952.252387380697;15175.772363414557;11768.176227663982;11851.288922664668;11880.584179553674;12028.45871935765;12138.757224855453;3824.445455408978;3834.3864981603087;3846.365349717293;3899.629535194152;3930.0371409004692;62360;63391;65373.67313163451;65386.673066634365;65438.3456165437;11115.444227788577;11249.775004499865;11302.886971130349;11323.094152467782;11360.943195284137;18820.341288055126;19307.4207773767;19337.51656208606;19907.502312442306;21548.892255538623;7827.45207835446;7936.642851071716;8525.531095789791;8628.870566941501;8645.092265312052;4466.888327791767;4496.460424748986;4536.7731613419855;4610.193216187154;4652.069586082797;3562.3943929531524;3680.7607505512055;3688.354537955847;3690.9261814763554;3691.870784522529;617.6109051297653;620.2061361457341;625.7027911741886;631.3087169549336;636.9840753981188;732.5568031341069;740.2486476226634;740.5408646639011;744.6016381236121;760.4866714967485;9200.723978280663;10011;10060.943600921944;10112.494375281207;10162.542685579167;701.1095908196562;731.7438896386222;737.1228238396292;756.1606616655508;770.9569640452845;4851.951480485221;4863.489333619919;4942.28336891156;4945.109880221595;4990.6506544541535;91066.54466727756;92308.53845730863;92466.53766731123;92474;94309.52845235729;79424.20575794284;81809.18190818134;83155;83415.58292208622;85756;73664;74047.57503235117;74587.62706186435;78011.82982255271;78146.04634884173;9434.575444105169;9492.572834222614;9726.270529710442;9850.901490984998;9876.308658393844;39636;40222;40276.39585406163;42091.36862946997;51915;45600.7719961398;46700;60320.39679603323;61359;63303.683481582295;12845.35773211317;13071.331100359757;13238.338083096;13265.403056862271;13408.865911340761;13110.410031548794;13750.224367284163;14133.363998620292;14212.644683882985;14298.714025719635;13170.275634840176;13196.274204918438;13216.273104979318;13238.801417978546;13422.798658020332;12276.508939642314;12691.555795547112;12788.808167877303;12860.614181574567;13069.477220911058;12744.171628844095;12991;13069.607911762663;13100.737985240052;13142.474301027853;10462.529186186792;10608.575656973635;10741.248112632353;11103.444827758742;11299.152563557602;10649.840252396376;11094.889051109709;11167.888321116685;11341.829872551752;11348.432578370883 11:39:53 INFO - PROCESS | 18644 | __end_tp_report 11:39:53 INFO - PROCESS | 18644 | __start_cc_report 11:39:53 INFO - PROCESS | 18644 | _x_x_mozilla_cycle_collect,1241 11:39:53 INFO - PROCESS | 18644 | __end_cc_report 11:39:53 INFO - PROCESS | 18644 | __startTimestamp1486496393635__endTimestamp 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | ------- Summary: start ------- 11:39:53 INFO - PROCESS | 18644 | Number of tests: 6 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#0] dojo.html Cycles:165 Average:5583.51 Median:5774.91 stddev:625.63 (10.8%) stddev-sans-first:599.06 11:39:53 INFO - PROCESS | 18644 | Values: 3204.1 3259.3 3264.2 3298.4 3315.6 5500.9 5597.3 5608.9 5617.2 5618.3 5553.8 5607.1 5608.6 5617.9 5653.3 5051.0 5074.1 5104.2 5151.4 5184.2 5015.5 5026.1 5161.4 5182.2 5186.8 5098.0 5103.9 5151.9 5173.2 5178.5 5190.7 5253.5 5259.7 5268.1 5285.0 4985.2 4992.4 5151.3 5171.1 5229.5 5439.4 5449.0 5466.1 5472.7 5528.2 5921.6 5941.3 5948.1 5956.7 6004.1 5850.6 5900.4 5974.0 6021.9 6049.0 5579.6 5579.9 5626.4 5628.4 5664.5 6174.2 6180.7 6184.4 6188.9 6190.0 5759.3 5805.7 5902.6 5909.9 5915.6 5913.9 6000.3 6001.9 6057.2 6085.8 6009.1 6017.2 6031.8 6033.6 6039.4 5832.2 5978.4 6053.3 6057.1 6081.2 4573.2 4596.0 4625.6 4627.0 4627.8 4096.6 4125.1 4128.0 4147.9 4149.1 5754.3 5757.9 5763.3 5766.6 5774.9 6022.2 6058.9 6064.0 6066.4 6074.9 5570.9 5608.7 5629.4 5685.9 5736.5 5180.6 5187.1 5193.8 5197.8 5228.3 6212.6 6243.6 6262.8 6265.9 6270.6 5894.3 5945.6 5954.6 5970.3 6045.1 6172.6 6277.8 6280.2 6283.6 6285.1 5927.3 5932.0 5933.4 5938.6 5976.6 5879.4 5879.9 6060.8 6061.7 6072.2 5801.0 5846.1 5859.9 5860.5 5935.6 5858.4 5899.1 5901.3 5903.1 5916.7 5638.4 5885.6 5893.1 5894.6 5899.4 5762.2 5785.5 5814.9 5835.9 5874.0 5753.9 5756.1 5758.4 5770.3 5770.9 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#1] ext.html Cycles:180 Average:56506.89 Median:19970.97 stddev:105203.88 (526.8%) stddev-sans-first:105415.21 11:39:53 INFO - PROCESS | 18644 | Values: 581.0 613.9 651.9 656.7 662.8 34423.7 36752.0 36761.3 36769.6 45151.5 43391.6 47406.0 47422.3 47462.0 47484.1 8931.4 9074.5 9084.2 9084.5 9090.1 8534.5 8780.3 8786.7 8901.3 10655.1 10647.4 10936.6 10980.5 11026.2 11026.9 10847.1 10872.9 10896.6 10903.9 10911.1 10711.7 10788.7 10794.5 10807.9 10810.7 44206.0 44570.3 44669.6 44674.8 44689.0 3565.9 3577.4 3627.5 3695.0 3750.6 31091.1 32902.2 33031.5 33200.3 33288.8 4557.0 4588.0 4616.7 4629.6 4639.7 338529.0 338710.0 339518.0 339615.0 341808.0 62551.4 62801.1 62872.0 62909.4 62958.1 39248.2 40689.4 64890.7 65028.0 65293.7 19211.9 19486.0 19487.1 19488.1 19492.7 14675.1 14826.5 14833.0 14875.7 14882.6 18393.4 18866.7 19833.3 20528.5 20575.0 7132.7 7159.9 7334.9 7361.6 7402.6 965.9 1002.5 1028.7 1055.8 1101.4 31988.5 32147.8 32338.5 32999.7 33034.5 1108.5 1160.5 1170.3 1206.8 1229.9 14764.9 17509.5 18037.9 18308.5 19064.9 507869.0 508461.0 508576.0 511392.0 512527.0 61657.0 61996.0 62069.0 62156.7 62168.4 1283.8 1356.2 1366.8 1372.6 1412.7 30414.7 32349.8 33970.2 34006.5 34172.8 51589.0 52122.2 52148.2 52156.0 52159.7 316238.0 318208.0 318258.0 318397.0 318984.0 26789.2 27230.5 29371.0 30024.0 30292.8 47820.8 47862.0 48094.0 48425.3 48801.8 40549.8 40864.2 40904.6 42108.2 42179.6 40527.8 40752.6 40794.0 42350.6 42407.4 40774.4 41546.8 41739.4 41911.8 41958.4 33669.5 35958.5 36314.5 36565.8 36865.8 28447.4 28458.4 28544.4 28655.6 28700.9 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#2] jquery.html Cycles:180 Average:28247.25 Median:1540.91 stddev:75684.87 (4911.7%) stddev-sans-first:75868.31 11:39:53 INFO - PROCESS | 18644 | Values: 401.5 404.1 414.8 415.1 426.5 14518.4 18599.8 19611.8 20319.1 20352.3 15620.5 16770.7 18960.9 19039.7 19357.1 5732.7 5896.2 5907.7 5908.8 5918.1 5676.6 5814.5 5815.0 5878.5 5880.3 5817.9 5820.6 5822.8 5825.1 5840.3 5656.0 5797.2 5800.7 5820.9 5839.1 5218.5 5221.6 5236.3 5251.9 5261.4 22719.2 22734.0 23232.3 23302.0 23554.5 2479.8 2487.6 2490.1 2646.7 2680.3 10154.2 10241.6 10550.1 13768.2 15243.0 1860.0 1862.6 1905.3 1911.3 1947.6 81899.0 83298.2 84247.0 84893.2 86606.0 11196.7 11286.6 11299.4 11405.1 11640.4 15917.4 15924.4 15934.0 15935.3 15952.4 7405.8 7808.7 7944.7 8509.4 8661.5 7864.7 7972.5 7972.7 8090.7 8443.8 4823.6 4844.5 4882.0 4976.5 5044.4 2017.8 2030.7 2039.4 2052.9 2056.8 907.9 979.0 1012.1 1031.6 1037.1 18209.2 18565.1 19075.6 19120.2 19288.7 980.3 990.9 995.8 1012.0 1030.9 9716.3 10362.8 10503.2 10512.2 10610.5 444087.0 450140.0 460872.0 463915.0 464757.0 89976.0 91226.5 91880.5 95718.5 95956.5 984.5 994.6 1021.2 1025.6 1027.3 16310.3 16574.4 16611.5 16861.4 17043.9 42376.7 43119.6 43447.7 43842.6 44793.3 59755.7 62115.7 62565.1 62960.0 63779.7 6147.4 6308.4 7870.9 8834.3 9028.1 12175.5 12284.4 12550.5 12880.0 13197.7 10551.7 10622.8 10662.7 10772.0 10953.6 10594.9 10762.0 10914.1 10948.0 11138.2 11072.2 11454.3 11497.3 11509.7 11569.5 8686.4 8727.7 8761.7 8775.7 8780.3 9421.8 11090.8 11130.4 11190.5 11438.8 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#3] mootools.html Cycles:180 Average:5533.77 Median:5321.17 stddev:3020.09 (56.8%) stddev-sans-first:3012.13 11:39:53 INFO - PROCESS | 18644 | Values: 1341.0 1490.0 1504.3 1669.5 1812.2 7307.8 8022.0 8338.3 8346.8 8556.2 8327.2 8408.1 8408.5 8409.2 8410.5 2373.4 2392.5 2406.3 2412.5 2422.0 2345.6 2390.4 2394.2 2394.8 2403.3 2187.1 2189.6 2213.9 2228.0 2228.1 2177.6 2197.8 2214.7 2217.1 2217.9 2260.6 2281.0 2282.2 2283.3 2283.7 8199.6 8356.1 8395.8 8458.5 8460.7 5170.4 5318.4 5323.9 5326.1 5329.6 3233.8 3247.4 3288.4 3308.0 3481.9 1088.8 1106.2 1113.2 1161.6 1163.7 11437.7 11450.0 11493.7 11529.1 11533.4 4129.3 4357.6 4377.8 4404.9 4419.7 9177.0 9177.1 9180.2 9182.5 9183.4 5031.8 5106.5 5110.4 5112.3 5116.3 4241.9 4375.1 4592.8 4696.1 4831.3 3792.2 3860.5 3875.9 3942.4 3948.5 1184.6 1192.1 1200.6 1203.9 1215.2 847.6 948.8 974.6 1025.4 1040.0 5773.0 6001.8 6159.0 6159.4 6258.2 951.3 974.4 977.5 998.8 1009.9 3996.0 4276.7 4302.6 4363.3 4408.4 9788.0 10038.3 10068.6 10109.3 10116.7 9835.5 9956.8 10077.2 10118.7 10123.1 7935.7 8084.5 8089.0 8092.4 8107.2 5814.4 5841.5 5965.5 5980.9 6021.8 9278.1 9516.8 9517.1 9576.6 9617.0 9650.8 9735.7 9812.7 9863.8 9875.6 6528.7 6734.7 6735.9 6862.1 6963.0 7700.7 7886.5 8004.4 8173.6 8178.3 6988.5 7062.3 7118.1 7178.5 7232.2 6628.2 6712.9 7007.9 7097.7 7112.8 6698.3 6703.7 6753.2 6757.2 6762.2 5229.5 5234.0 5260.7 5406.5 5407.7 5307.2 5347.9 5424.9 5427.3 5450.5 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#4] prototype.html Cycles:180 Average:4666.37 Median:5420.74 stddev:1349.66 (24.9%) stddev-sans-first:1313.92 11:39:53 INFO - PROCESS | 18644 | Values: 346.5 350.5 357.2 360.2 363.2 5374.0 5425.3 5438.6 5473.9 5477.5 5339.8 5353.2 5385.1 5394.7 5416.5 3991.5 4203.7 4240.7 4254.8 4292.3 4199.0 4218.0 4225.5 4227.9 4272.7 3986.5 4186.3 4188.6 4234.9 4238.6 4084.4 4094.2 4144.9 4161.9 4167.5 3672.1 3676.0 3679.0 3683.9 3711.1 5011.3 5197.3 5198.3 5224.3 5236.0 4505.3 4749.0 4753.3 4761.2 4761.9 5541.7 5552.4 5554.0 5559.3 5561.4 3942.2 4006.6 4069.0 4070.7 4085.5 5685.3 5734.4 5736.3 5742.0 5747.2 4103.2 4109.2 4110.5 4144.9 4161.4 4082.4 4199.6 4208.4 4217.4 4219.9 4707.4 4727.9 4741.8 4744.9 4783.0 5572.7 5575.3 5579.5 5579.8 5591.9 1403.2 1405.2 1406.3 1406.6 1411.9 932.6 979.0 980.9 990.8 995.9 5177.5 5203.3 5219.9 5239.8 5248.5 5462.5 5483.5 5507.5 5509.5 5545.4 5214.6 5221.7 5238.9 5381.5 5425.0 2899.6 2945.2 2953.8 2955.6 2957.4 5708.9 5746.6 5750.6 5752.9 5754.2 5519.7 5614.7 5670.2 5684.8 5698.3 5676.3 5700.7 5723.7 5726.7 5753.5 5298.6 5539.8 5543.8 5555.6 5578.4 5461.8 5470.3 5486.4 5486.8 5512.8 5689.5 5713.6 5715.3 5723.2 5734.7 3918.6 3987.9 4033.0 4108.8 4135.3 5679.4 5696.0 5701.6 5716.4 5726.7 5572.2 5576.5 5587.0 5590.4 5610.0 5443.3 5533.8 5551.3 5560.0 5578.8 5528.5 5545.4 5547.8 5570.4 5571.7 5474.3 5568.1 5581.4 5589.7 5617.2 5438.0 5455.5 5465.0 5473.7 5478.7 11:39:53 INFO - PROCESS | 18644 | 11:39:53 INFO - PROCESS | 18644 | [#5] yui.html Cycles:180 Average:18252.34 Median:25068.77 stddev:24399.63 (97.3%) stddev-sans-first:24432.84 11:39:53 INFO - PROCESS | 18644 | Values: 789.8 792.8 810.7 847.6 888.6 14462.6 15076.3 15101.9 15326.8 15409.8 13742.7 14898.2 15082.7 15089.6 15111.1 859.7 885.1 885.3 885.5 887.5 874.1 876.9 877.6 877.8 878.2 932.1 934.3 935.4 935.6 936.0 926.3 928.2 928.9 929.1 929.5 679.7 680.2 680.6 680.7 680.8 14912.5 15046.5 15838.0 15947.5 15994.9 14682.7 14898.0 14902.5 14952.3 15175.8 11768.2 11851.3 11880.6 12028.5 12138.8 3824.4 3834.4 3846.4 3899.6 3930.0 62360.0 63391.0 65373.7 65386.7 65438.3 11115.4 11249.8 11302.9 11323.1 11360.9 18820.3 19307.4 19337.5 19907.5 21548.9 7827.5 7936.6 8525.5 8628.9 8645.1 4466.9 4496.5 4536.8 4610.2 4652.1 3562.4 3680.8 3688.4 3690.9 3691.9 617.6 620.2 625.7 631.3 637.0 732.6 740.2 740.5 744.6 760.5 9200.7 10011.0 10060.9 10112.5 10162.5 701.1 731.7 737.1 756.2 771.0 4852.0 4863.5 4942.3 4945.1 4990.7 91066.5 92308.5 92466.5 92474.0 94309.5 79424.2 81809.2 83155.0 83415.6 85756.0 73664.0 74047.6 74587.6 78011.8 78146.0 9434.6 9492.6 9726.3 9850.9 9876.3 39636.0 40222.0 40276.4 42091.4 51915.0 45600.8 46700.0 60320.4 61359.0 63303.7 12845.4 13071.3 13238.3 13265.4 13408.9 13110.4 13750.2 14133.4 14212.6 14298.7 13170.3 13196.3 13216.3 13238.8 13422.8 12276.5 12691.6 12788.8 12860.6 13069.5 12744.2 12991.0 13069.6 13100.7 13142.5 10462.5 10608.6 10741.2 11103.4 11299.2 10649.8 11094.9 11167.9 11341.8 11348.4 11:39:53 INFO - PROCESS | 18644 | -------- Summary: end -------- 11:39:53 INFO - PROCESS | 18644 | 11:39:54 INFO - TEST-INFO | 18644: exit 0 11:39:54 INFO - TEST-OK | dromaeo_css | took 1113977ms 11:39:54 INFO - TEST-START | kraken 11:39:54 INFO - operating with platform_type : linux_ 11:39:54 INFO - Initialising browser for kraken test... 11:39:54 INFO - TEST-INFO | started process 18946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR2_Y3t/profile http://localhost:48579/getInfo.html) 11:39:58 INFO - PROCESS | 18946 | __metrics Screen width/height:1600/1200 11:39:58 INFO - PROCESS | 18946 | colorDepth:24 11:39:58 INFO - PROCESS | 18946 | Browser inner width/height: 1024/697 11:39:58 INFO - PROCESS | 18946 | __metrics 11:39:58 INFO - PROCESS | 18946 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:39:58 INFO - PROCESS | 18946 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:59 INFO - PROCESS | 18946 | console.error: PushService: 11:39:59 INFO - PROCESS | 18946 | stateChangeProcessEnqueue: Error transitioning state 11:39:59 INFO - PROCESS | 18946 | UnknownError 11:39:59 INFO - TEST-INFO | 18946: exit 0 11:39:59 INFO - Browser initialized. 11:39:59 INFO - Running cycle 1/1 for kraken test... 11:39:59 INFO - TEST-INFO | started process 19039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR2_Y3t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:11 INFO - PROCESS | 19039 | RSS: Main: 141340672 11:40:11 INFO - PROCESS | 19039 | 11:40:14 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48579/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:15 INFO - PROCESS | 19039 | RSS: Main: 183406592 11:40:15 INFO - PROCESS | 19039 | 11:40:17 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48579/tests/kraken/driver.html?testName=audio-dft) 11:40:18 INFO - PROCESS | 19039 | RSS: Main: 173469696 11:40:18 INFO - PROCESS | 19039 | 11:40:20 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48579/tests/kraken/driver.html?testName=audio-fft) 11:40:21 INFO - PROCESS | 19039 | RSS: Main: 264261632 11:40:21 INFO - PROCESS | 19039 | 11:40:23 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48579/tests/kraken/driver.html?testName=audio-oscillator) 11:40:24 INFO - PROCESS | 19039 | RSS: Main: 171397120 11:40:24 INFO - PROCESS | 19039 | 11:40:26 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:26 INFO - PROCESS | 19039 | RSS: Main: 173424640 11:40:26 INFO - PROCESS | 19039 | 11:40:29 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48579/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:30 INFO - PROCESS | 19039 | RSS: Main: 208879616 11:40:30 INFO - PROCESS | 19039 | 11:40:33 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48579/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:34 INFO - PROCESS | 19039 | RSS: Main: 210526208 11:40:34 INFO - PROCESS | 19039 | 11:40:36 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48579/tests/kraken/driver.html?testName=json-parse-financial) 11:40:37 INFO - PROCESS | 19039 | RSS: Main: 209522688 11:40:37 INFO - PROCESS | 19039 | 11:40:38 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:39 INFO - PROCESS | 19039 | RSS: Main: 171327488 11:40:39 INFO - PROCESS | 19039 | 11:40:41 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:41 INFO - PROCESS | 19039 | RSS: Main: 178913280 11:40:41 INFO - PROCESS | 19039 | 11:40:43 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:44 INFO - PROCESS | 19039 | RSS: Main: 188321792 11:40:44 INFO - PROCESS | 19039 | 11:40:47 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:47 INFO - PROCESS | 19039 | RSS: Main: 195817472 11:40:47 INFO - PROCESS | 19039 | 11:40:50 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:50 INFO - PROCESS | 19039 | RSS: Main: 192573440 11:40:50 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | Cycle 1(1): loaded http://localhost:48579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48579/tests/kraken/driver.html?testName=ai-astar) 11:40:52 INFO - PROCESS | 19039 | RSS: Main: 243761152 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | __start_tp_report 11:40:52 INFO - PROCESS | 19039 | _x_x_mozilla_page_load 11:40:52 INFO - PROCESS | 19039 | _x_x_mozilla_page_load_details 11:40:52 INFO - PROCESS | 19039 | |i|pagename|runs| 11:40:52 INFO - PROCESS | 19039 | |0;ai-astar;101;112;111;113;113;112;112;112;110;112 11:40:52 INFO - PROCESS | 19039 | |1;audio-beat-detection;143;118;123;165;117;119;116;116;147;118 11:40:52 INFO - PROCESS | 19039 | |2;audio-dft;160;160;159;160;160;160;160;160;163;158 11:40:52 INFO - PROCESS | 19039 | |3;audio-fft;74;75;75;104;75;75;75;74;97;75 11:40:52 INFO - PROCESS | 19039 | |4;audio-oscillator;82;81;125;81;82;80;96;81;81;118 11:40:52 INFO - PROCESS | 19039 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 11:40:52 INFO - PROCESS | 19039 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;147;145 11:40:52 INFO - PROCESS | 19039 | |7;imaging-desaturate;84;84;85;84;84;84;85;84;85;84 11:40:52 INFO - PROCESS | 19039 | |8;json-parse-financial;49;49;53;51;49;49;51;48;49;50 11:40:52 INFO - PROCESS | 19039 | |9;json-stringify-tinderbox;58;59;58;59;58;58;59;59;59;59 11:40:52 INFO - PROCESS | 19039 | |10;stanford-crypto-aes;74;81;77;74;74;74;78;74;79;74 11:40:52 INFO - PROCESS | 19039 | |11;stanford-crypto-ccm;127;130;122;131;127;129;121;119;175;132 11:40:52 INFO - PROCESS | 19039 | |12;stanford-crypto-pbkdf2;154;153;158;154;159;154;153;154;155;154 11:40:52 INFO - PROCESS | 19039 | |13;stanford-crypto-sha256-iterative;63;64;62;63;60;66;61;61;63;61 11:40:52 INFO - PROCESS | 19039 | __end_tp_report 11:40:52 INFO - PROCESS | 19039 | __start_cc_report 11:40:52 INFO - PROCESS | 19039 | _x_x_mozilla_cycle_collect,1551 11:40:52 INFO - PROCESS | 19039 | __end_cc_report 11:40:52 INFO - PROCESS | 19039 | __startTimestamp1486496452809__endTimestamp 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | ------- Summary: start ------- 11:40:52 INFO - PROCESS | 19039 | Number of tests: 14 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.55 (3.2%) stddev-sans-first:0.93 11:40:52 INFO - PROCESS | 19039 | Values: 101.0 112.0 111.0 113.0 113.0 112.0 112.0 112.0 110.0 112.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:121.00 stddev:17.22 (14.2%) stddev-sans-first:17.41 11:40:52 INFO - PROCESS | 19039 | Values: 143.0 118.0 123.0 165.0 117.0 119.0 116.0 116.0 147.0 118.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 11:40:52 INFO - PROCESS | 19039 | Values: 160.0 160.0 159.0 160.0 160.0 160.0 160.0 160.0 163.0 158.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:10.99 (14.7%) stddev-sans-first:11.45 11:40:52 INFO - PROCESS | 19039 | Values: 74.0 75.0 75.0 104.0 75.0 75.0 75.0 74.0 97.0 75.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:81.00 stddev:16.97 (21.0%) stddev-sans-first:17.71 11:40:52 INFO - PROCESS | 19039 | Values: 82.0 81.0 125.0 81.0 82.0 80.0 96.0 81.0 81.0 118.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:40:52 INFO - PROCESS | 19039 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:40:52 INFO - PROCESS | 19039 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 145.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 11:40:52 INFO - PROCESS | 19039 | Values: 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.50 stddev:1.48 (3.0%) stddev-sans-first:1.54 11:40:52 INFO - PROCESS | 19039 | Values: 49.0 49.0 53.0 51.0 49.0 49.0 51.0 48.0 49.0 50.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 11:40:52 INFO - PROCESS | 19039 | Values: 58.0 59.0 58.0 59.0 58.0 58.0 59.0 59.0 59.0 59.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.64 (3.5%) stddev-sans-first:2.71 11:40:52 INFO - PROCESS | 19039 | Values: 74.0 81.0 77.0 74.0 74.0 74.0 78.0 74.0 79.0 74.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:129.50 stddev:15.98 (12.3%) stddev-sans-first:16.87 11:40:52 INFO - PROCESS | 19039 | Values: 127.0 130.0 122.0 131.0 127.0 129.0 121.0 119.0 175.0 132.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:154.00 stddev:2.04 (1.3%) stddev-sans-first:2.15 11:40:52 INFO - PROCESS | 19039 | Values: 154.0 153.0 158.0 154.0 159.0 154.0 153.0 154.0 155.0 154.0 11:40:52 INFO - PROCESS | 19039 | 11:40:52 INFO - PROCESS | 19039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 11:40:52 INFO - PROCESS | 19039 | Values: 63.0 64.0 62.0 63.0 60.0 66.0 61.0 61.0 63.0 61.0 11:40:52 INFO - PROCESS | 19039 | -------- Summary: end -------- 11:40:52 INFO - PROCESS | 19039 | 11:40:53 INFO - TEST-INFO | 19039: exit 0 11:40:53 INFO - TEST-OK | kraken | took 59457ms 11:40:53 INFO - SUITE-END | took 1173s 11:40:53 INFO - Completed test suite (00:19:33) 11:40:53 INFO - javascript benchmark 11:40:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3204.1348835814324, 3259.348130373925, 3264.2002709336202, 3298.356820420019, 3315.5855518060243, 5500.862478438041, 5597.272354593907, 5608.859778505534, 5617.241672374228, 5618.297712785902, 5553.7778488860395, 5607.102863541834, 5608.551315894729, 5617.9157312640245, 5653.321601407826, 5051.015052064839, 5074.112030394685, 5104.2088476286235, 5151.356080489939, 5184.248283998818, 5015.523525265112, 5026.070177017264, 5161.380634323887, 5182.196759502283, 5186.844394668166, 5097.974510127444, 5103.948960510403, 5151.896962060757, 5173.224016397533, 5178.5339319461245, 5190.740462976855, 5253.474652534755, 5259.658122222043, 5268.104422248208, 5285.022270879899, 4985.227289770091, 4992.400911890596, 5151.253068305112, 5171.146760784466, 5229.477052294778, 5439.374471935738, 5449.0, 5466.098093814516, 5472.671639701631, 5528.170774383834, 5921.555883308769, 5941.316748573926, 5948.078047902582, 5956.672383018932, 6004.099385092228, 5850.590458667895, 5900.350961394243, 5973.970130149321, 6021.909671354933, 6049.032154855246, 5579.609427340088, 5579.944200557983, 5626.43735626434, 5628.437156284339, 5664.461876121762, 6174.197354343906, 6180.6909654517995, 6184.381561843779, 6188.907166392508, 6189.96905015481, 5759.280089988752, 5805.709714514257, 5902.61632993854, 5909.881802363929, 5915.615484993547, 5913.852153696192, 6000.309964354068, 6001.909971350433, 6057.242844644419, 6085.817425477243, 6009.098635204667, 6017.157597936292, 6031.819045428644, 6033.637981721111, 6039.396060393926, 5832.24180856486, 5978.402159784074, 6053.273607167168, 6057.061155520902, 6081.239845019372, 4573.176828170961, 4595.954040459619, 4625.629949604024, 4626.976865115653, 4627.814887404466, 4096.56986016464, 4125.092479654471, 4127.9587204128175, 4147.8963025924595, 4149.087200815816, 5754.251947246831, 5757.913631295534, 5763.337216220105, 5766.567507436959, 5774.913376299359, 6022.247219097613, 6058.939410605837, 6063.969680151571, 6066.363031881677, 6074.9392506075255, 5570.916436253459, 5608.747606357723, 5629.352624448241, 5685.857853553694, 5736.541076713853, 5180.559652429586, 5187.06632806091, 5193.844184674465, 5197.766100525486, 5228.346456692913, 6212.627242365382, 6243.594166379171, 6262.812115636447, 6265.8746825063245, 6270.592411493239, 5894.263217097863, 5945.64326140433, 5954.553408494294, 5970.3432622412365, 6045.093236014457, 6172.567920245539, 6277.780277690259, 6280.246370435394, 6283.5601507895835, 6285.088662144055, 5927.321293306182, 5932.0, 5933.406659334032, 5938.6436813791315, 5976.61152025117, 5879.382664820132, 5879.911801322898, 6060.848478788065, 6061.696915154136, 6072.210612620508, 5801.0, 5846.093855452412, 5859.912101318569, 5860.472557469848, 5935.643861368331, 5858.355580886014, 5899.085641725539, 5901.3213480448585, 5903.11453281994, 5916.704164791657, 5638.407967163389, 5885.558583106199, 5893.145493903446, 5894.557908156819, 5899.439553242435, 5762.193292939076, 5785.450382213683, 5814.912776308443, 5835.94164058371, 5874.0, 5753.942460575508, 5756.107803290497, 5758.366579676149, 5770.278715160605, 5770.855728606651], "value": 5541.861342836397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9912851307229, 613.9109829074785, 651.9217693876734, 656.6815094679083, 662.7614058938781, 34423.65576344236, 36751.999999999935, 36761.26477470449, 36769.63230367695, 45151.548484515144, 43391.566084339145, 47406.0, 47422.288665669956, 47462.0, 47484.0503189936, 8931.374803763723, 9074.500902450363, 9084.18242358191, 9084.454932704026, 9090.090990900922, 8534.530600816952, 8780.341474389414, 8786.736397908073, 8901.332400070021, 10655.147588192925, 10647.414392208426, 10936.56253749849, 10980.450977451135, 11026.228164028522, 11026.889731102707, 10847.132229421628, 10872.945635271852, 10896.564137434492, 10903.890961090367, 10911.07255883251, 10711.678649640524, 10788.676339709822, 10794.514246858911, 10807.945960270226, 10810.67567972962, 44206.0, 44570.33144502835, 44669.55330446686, 44674.77662611699, 44689.0, 3565.8573657053685, 3577.3918433866047, 3627.4921510988484, 3695.0392897846755, 3750.5686846012786, 31091.067267981998, 32902.177445564055, 33031.50452743211, 33200.33599328024, 33288.83355583231, 4556.954430455686, 4587.9541204588195, 4616.699914505546, 4629.629629629621, 4639.652026098022, 338529.0, 338710.0, 339518.0, 339615.0, 341808.0, 62551.37448625547, 62801.057984130275, 62872.0, 62909.37090629035, 62958.055629165596, 39248.215035699126, 40689.38965915514, 64890.67554662196, 65028.0, 65293.67353163204, 19211.903940480486, 19486.0, 19487.123079461457, 19488.123034463482, 19492.70760938587, 14675.119492830465, 14826.481073162387, 14833.035852669542, 14875.70248595022, 14882.553523394316, 18393.356232532064, 18866.71699924502, 19833.30583429573, 20528.486787830127, 20575.0, 7132.714691412285, 7159.921233869382, 7334.926650733424, 7361.558306501627, 7402.555846649218, 965.8937516873139, 1002.5037606384886, 1028.665683652816, 1055.762453447968, 1101.432762127505, 31988.520172197437, 32147.839260804016, 32338.514922276183, 32999.67000329966, 33034.504482432785, 1108.4900945564968, 1160.5067846165346, 1170.3329102411715, 1206.7888119579038, 1229.932353720554, 14764.926175369055, 17509.474715758548, 18037.909810450863, 18308.542286442946, 19064.904675476533, 507869.0, 508461.0, 508576.0, 511392.0, 512527.0, 61657.0, 61996.0, 62069.0, 62156.68921655363, 62168.37831621716, 1283.7625039367747, 1356.1659579358623, 1366.7539842828387, 1372.5745019044127, 1412.6892083741561, 30414.695853041187, 32349.838250808596, 33970.15074623154, 34006.48990265198, 34172.82913585516, 51589.0, 52122.21816672677, 52148.21777673262, 52156.0, 52159.73920130375, 316238.0, 318208.0, 318258.0, 318397.0, 318984.0, 26789.196324110308, 27230.455390892468, 29371.0, 30024.0, 30292.84853575718, 47820.760896195294, 47862.0, 48094.0, 48425.27362089642, 48801.75599121982, 40549.8144874123, 40864.18271634491, 40904.590954090076, 42108.157836843704, 42179.57820421879, 40527.79736101301, 40752.59247407488, 40794.0, 42350.576494234665, 42407.36388954106, 40774.38838417367, 41546.79226603969, 41739.37390939078, 41911.7904410476, 41958.370624440046, 33669.49495757615, 35958.460623091196, 36314.455283170246, 36565.81717091398, 36865.815670921475, 28447.43105137927, 28458.43083138367, 28544.42911141724, 28655.57016644794, 28700.856495717388], "value": 20683.42575154409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.5362256593632, 404.0807163702576, 414.761512130525, 415.14480170848054, 426.5222950295669, 14518.419263229485, 18599.814001859977, 19611.803881961176, 20319.085641146165, 20352.287669931575, 15620.453284135057, 16770.74843877343, 18960.905195474003, 19039.714404283946, 19357.128929198185, 5732.656040637554, 5896.204012458327, 5907.704614769265, 5908.793192238272, 5918.05311150216, 5676.574256930726, 5814.5057670098095, 5814.970925145369, 5878.529717622601, 5880.26496687914, 5817.8836423271505, 5820.621659592113, 5822.767089316422, 5825.126231065332, 5840.328362238333, 5655.971720141414, 5797.188393624875, 5800.651960882361, 5820.854478638025, 5839.065749480105, 5218.452062533417, 5221.582273418117, 5236.293100431431, 5251.86870328241, 5261.421243663194, 22719.204827830945, 22734.0, 23232.3030309091, 23302.0, 23554.528909421886, 2479.838810477313, 2487.564676181661, 2490.0786708917635, 2646.7220941801024, 2680.276325392133, 10154.187664986783, 10241.590336386536, 10550.050495455369, 13768.24274664893, 15243.0, 1859.9907000464912, 1862.6274745051044, 1905.3045638341905, 1911.2641632971267, 1947.6299503094508, 81899.0, 83298.16701832965, 84247.0, 84893.15106848977, 86606.0, 11196.720081998015, 11286.604968826216, 11299.435028248554, 11405.144614153805, 11640.417979101012, 15917.442889498812, 15924.442644507619, 15934.0, 15935.282912268976, 15952.441664541917, 7405.814854628569, 7808.726694565663, 7944.682212711542, 8509.404341696021, 8661.543227766593, 7864.6854125834325, 7972.521648701097, 7972.720954766555, 8090.676372945134, 8443.788905277293, 4823.614110871122, 4844.539768721966, 4882.023595280958, 4976.527229913152, 5044.394672639307, 2017.818396344336, 2030.664940284866, 2039.3677959832498, 2052.8768273903615, 2056.804603562659, 907.8819753432143, 978.951052447389, 1012.1447376966452, 1031.6131450705984, 1037.1029059863315, 18209.18433459932, 18565.071746412625, 19075.61848763017, 19120.2351905925, 19288.710669339973, 980.2990861534038, 990.8513722941616, 995.7560397702609, 1012.0385633648064, 1030.9278350515392, 9716.271279653913, 10362.792744145076, 10503.2122590806, 10512.159027277952, 10610.522526486327, 444087.0, 450140.0, 460872.0, 463915.0, 464757.0, 89976.0, 91226.54386728157, 91880.54059729658, 95718.52140739252, 95956.52021739847, 984.522506584306, 994.627014869424, 1021.1677482851452, 1025.5795123999274, 1027.3014350241758, 16310.347586096423, 16574.419895303607, 16611.501654949887, 16861.409850655167, 17043.914780426017, 42376.72869813911, 43119.56880431281, 43447.696569102976, 43842.56157438512, 44793.328100079176, 59755.70122149535, 62115.689421552604, 62565.06152407808, 62960.0, 63779.68110159419, 6147.354527774519, 6308.369163083838, 7870.898074269492, 8834.29325653959, 9028.09719028092, 12175.45210465549, 12284.447199875849, 12550.497980080694, 12880.0, 13197.670058248621, 10551.736206594589, 10622.787544248917, 10662.680119596114, 10772.0, 10953.56185752561, 10594.947025264824, 10762.031417172491, 10914.126869850552, 10948.0, 11138.220324577202, 11072.169587280825, 11454.312741235553, 11497.252678575866, 11509.712257193638, 11569.537218511501, 8686.39195256326, 8727.73816785472, 8761.693340733043, 8775.692850750193, 8780.253678437404, 9421.764455888384, 11090.778184436105, 11130.443477826238, 11190.496427660612, 11438.771224575628], "value": 9207.89668311583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.0143544494788, 1489.9627509312268, 1504.29298229832, 1669.5408762590287, 1812.2026308424302, 7307.817304567382, 8022.037355517339, 8338.332933365331, 8346.833063338738, 8556.187162219594, 8327.16728327167, 8408.117147699495, 8408.537530435824, 8409.159084091587, 8410.453320534176, 2373.3860974537265, 2392.4616961183683, 2406.302172370011, 2412.4571971306405, 2422.0, 2345.6247000479925, 2390.4143484846236, 2394.1500767227644, 2394.844335118212, 2403.3030421177923, 2187.0814258011674, 2189.6496560550313, 2213.878236696981, 2228.008536201391, 2228.0642130305228, 2177.618916689573, 2197.7582465928735, 2214.712087428624, 2217.1020736601704, 2217.866927984318, 2260.6382978723327, 2281.0191617604423, 2282.224043825091, 2283.3264187064688, 2283.7259528856475, 8199.590020498952, 8356.080831108573, 8395.790105247417, 8458.492490450531, 8460.703875364394, 5170.353705786777, 5318.414974352818, 5323.920141197885, 5326.067938110815, 5329.626926115174, 3233.849490089088, 3247.41546521626, 3288.4245257079915, 3307.9503807442907, 3481.8781342652887, 1088.8366744988236, 1106.2256420505678, 1113.209621168963, 1161.5818305410046, 1163.6974386659444, 11437.656870293904, 11450.0, 11493.655190344303, 11529.077673786078, 11533.423328833525, 4129.2773764591075, 4357.607815296638, 4377.759223242689, 4404.867853964386, 4419.712718673276, 9176.95411522938, 9177.082291770903, 9180.17378435944, 9182.540872956326, 9183.448993060438, 5031.798728050837, 5106.489351064938, 5110.412302585176, 5112.309838171874, 5116.258142569307, 4241.851535196253, 4375.146846364992, 4592.816287348535, 4696.060787842445, 4831.347768051339, 3792.241551689618, 3860.4788353571907, 3875.8643447479203, 3942.3692209246956, 3948.526176858795, 1184.620921305174, 1192.1297452859462, 1200.5737963023175, 1203.9036877049814, 1215.2040413529153, 847.6228078505129, 948.7580666930027, 974.605284859633, 1025.4462590201356, 1040.0431602925175, 5772.9711351442975, 6001.789937352171, 6159.0, 6159.353267906895, 6258.249010118815, 951.3483263964207, 974.3958745577787, 977.5405559387077, 998.8351921932945, 1009.9192064634811, 3996.004993757803, 4276.743395396286, 4302.612764851178, 4363.258246098171, 4408.448943882015, 9787.951060244795, 10038.297319187586, 10068.647597334058, 10109.292349535463, 10116.74708132288, 9835.508224588742, 9956.80086398268, 10077.193824494023, 10118.747031324128, 10123.139533139618, 7935.722249721232, 8084.474509157004, 8089.0, 8092.433529652868, 8107.1892810718455, 5814.447627475383, 5841.50347220491, 5965.463108320272, 5980.850478738066, 6021.789237376671, 9278.11857873501, 9516.809663806824, 9517.095875891779, 9576.569054392708, 9617.0, 9650.806983860424, 9735.659251926148, 9812.705618831447, 9863.76702912136, 9875.604975801174, 6528.738850445929, 6734.696938637871, 6735.898961515483, 6862.142232220973, 6963.0, 7700.691972321044, 7886.487378320391, 8004.439689221698, 8173.591320433836, 8178.263956243966, 6988.545744526589, 7062.258462861531, 7118.074650295428, 7178.461615378763, 7232.240614735588, 6628.237752658313, 6712.899306510309, 7007.859842803014, 7097.7160913562875, 7112.786616401516, 6698.330166983263, 6703.731850726112, 6753.189617245962, 6757.189137303555, 6762.154730658668, 5229.47705229474, 5233.973830130825, 5260.710660913686, 5406.513413792777, 5407.702576358338, 5307.230451584576, 5347.866303342447, 5424.864378390572, 5427.267318911896, 5450.509454149145], "value": 4493.875838793551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4699010513914, 350.52153810049276, 357.22125765830486, 360.16621521178484, 363.19733389209847, 5373.973130134349, 5425.2675888755, 5438.592105592082, 5473.917891231635, 5477.452254774521, 5339.759710813013, 5353.197020446925, 5385.142125966535, 5394.676319420838, 5416.508406133174, 3991.4611527443712, 4203.663706903456, 4240.745555266694, 4254.808533615995, 4292.334688123338, 4199.0, 4217.954292168296, 4225.471816022997, 4227.915441691164, 4272.658187345005, 3986.5016872890887, 4186.330187170053, 4188.623023927846, 4234.9153016939645, 4238.597333253351, 4084.4281800547947, 4094.2016306820333, 4144.937825932613, 4161.91904047976, 4167.4790651168605, 3672.1186915140443, 3675.981620091909, 3679.025058359537, 3683.9447408288897, 3711.0536813112753, 5011.32347133136, 5197.324347834795, 5198.324217851693, 5224.268602395668, 5236.0, 4505.2654727929985, 4749.0, 4753.31076993834, 4761.190597598416, 4761.857144285677, 5541.722913854291, 5552.361478429992, 5554.0, 5559.332880054379, 5561.416051314594, 3942.172143849795, 4006.579309172553, 4068.9593104068877, 4070.653994410479, 4085.530164031115, 5685.260916080924, 5734.397888221718, 5736.3403208631125, 5741.999999999958, 5747.2241247431475, 4103.158852435244, 4109.219248342805, 4110.486189226347, 4144.8756537303925, 4161.417401563784, 4082.4284600156, 4199.559046300094, 4208.410822484854, 4217.4306468626955, 4219.8523051693655, 4707.411573553306, 4727.858164255078, 4741.762911854394, 4744.928826067612, 4782.976085119552, 5572.665640061609, 5575.330960284792, 5579.469950354791, 5579.832605021856, 5591.916121258185, 1403.2422491854488, 1405.1709491400122, 1406.2617126008722, 1406.5920882944035, 1411.8799902008238, 932.6222879733718, 978.9853152202722, 980.9068138526828, 990.7820279538635, 995.875515560555, 5177.482251774868, 5203.32356793622, 5219.921701174486, 5239.764210610456, 5248.50417630981, 5462.481064298885, 5483.533899618577, 5507.530255938733, 5509.5041446270025, 5545.417731138253, 5214.634975551751, 5221.660592061504, 5238.947610523922, 5381.515663590296, 5424.972875135599, 2899.608552845381, 2945.23423909785, 2953.808002479832, 2955.6305461817274, 2957.3937342844665, 5708.914366284509, 5746.5977381583725, 5750.568707346965, 5752.913706294409, 5754.1944127822135, 5519.69641669712, 5614.6631202128, 5670.234518340054, 5684.834608905165, 5698.287714035746, 5676.318841739017, 5700.657960522299, 5723.742431590588, 5726.713664316768, 5753.453421924911, 5298.602604804578, 5539.833804985696, 5543.780368318963, 5555.611107222618, 5578.354385456219, 5461.836144915659, 5470.304205696247, 5486.423925487767, 5486.835394938158, 5512.80705175317, 5689.516391106637, 5713.628614140068, 5715.31416230055, 5723.168586052423, 5734.655920644608, 3918.5885482023978, 3987.860424885115, 4032.9596704032583, 4108.8356465741035, 4135.31767258399, 5679.438154507378, 5695.971520142372, 5701.600887937971, 5716.399778023414, 5726.656400615976, 5572.164175373727, 5576.525995290446, 5586.972065139648, 5590.357108932362, 5609.971950140223, 5443.292371991616, 5533.833984980457, 5551.25058117149, 5560.0, 5578.832635020955, 5528.474794894479, 5545.417731138173, 5547.750351234124, 5570.404416356441, 5571.721413929368, 5474.2609747683555, 5568.136938774496, 5581.358143813513, 5589.736156856479, 5617.185508101221, 5437.972810135924, 5455.454454554513, 5465.0, 5473.67157970523, 5478.671279723229], "value": 4242.984219463365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.8499285135824, 792.7502836606473, 810.7243537197354, 847.5677404523693, 888.6223355074092, 14462.5661230163, 15076.32156552955, 15101.924490377532, 15326.770098448533, 15409.84590154098, 13742.725145497108, 14898.180600066991, 15082.698346033072, 15089.62275943102, 15111.093334399944, 859.6647307550045, 885.0706757904208, 885.2519620920312, 885.5306687455659, 887.529609307065, 874.0647507167333, 876.9254613357872, 877.6489404238292, 877.806882485852, 878.1964502480255, 932.0818993291603, 934.2759361494861, 935.3966691483989, 935.5976929920132, 936.035883040466, 926.2775035472342, 928.2481190235931, 928.9489078100702, 929.1359036096428, 929.4655573045526, 679.7179170644176, 680.2415306932735, 680.5746408494691, 680.6868840333452, 680.8400025993888, 14912.478063267734, 15046.473373431878, 15838.0, 15947.521574352788, 15994.920025399915, 14682.70634587313, 14898.0, 14902.478413255592, 14952.252387380697, 15175.772363414557, 11768.176227663982, 11851.288922664668, 11880.584179553674, 12028.45871935765, 12138.757224855453, 3824.445455408978, 3834.3864981603087, 3846.365349717293, 3899.629535194152, 3930.0371409004692, 62360.0, 63391.0, 65373.67313163451, 65386.673066634365, 65438.3456165437, 11115.444227788577, 11249.775004499865, 11302.886971130349, 11323.094152467782, 11360.943195284137, 18820.341288055126, 19307.4207773767, 19337.51656208606, 19907.502312442306, 21548.892255538623, 7827.45207835446, 7936.642851071716, 8525.531095789791, 8628.870566941501, 8645.092265312052, 4466.888327791767, 4496.460424748986, 4536.7731613419855, 4610.193216187154, 4652.069586082797, 3562.3943929531524, 3680.7607505512055, 3688.354537955847, 3690.9261814763554, 3691.870784522529, 617.6109051297653, 620.2061361457341, 625.7027911741886, 631.3087169549336, 636.9840753981188, 732.5568031341069, 740.2486476226634, 740.5408646639011, 744.6016381236121, 760.4866714967485, 9200.723978280663, 10011.0, 10060.943600921944, 10112.494375281207, 10162.542685579167, 701.1095908196562, 731.7438896386222, 737.1228238396292, 756.1606616655508, 770.9569640452845, 4851.951480485221, 4863.489333619919, 4942.28336891156, 4945.109880221595, 4990.6506544541535, 91066.54466727756, 92308.53845730863, 92466.53766731123, 92474.0, 94309.52845235729, 79424.20575794284, 81809.18190818134, 83155.0, 83415.58292208622, 85756.0, 73664.0, 74047.57503235117, 74587.62706186435, 78011.82982255271, 78146.04634884173, 9434.575444105169, 9492.572834222614, 9726.270529710442, 9850.901490984998, 9876.308658393844, 39636.0, 40222.0, 40276.39585406163, 42091.36862946997, 51915.0, 45600.7719961398, 46700.0, 60320.39679603323, 61359.0, 63303.683481582295, 12845.35773211317, 13071.331100359757, 13238.338083096, 13265.403056862271, 13408.865911340761, 13110.410031548794, 13750.224367284163, 14133.363998620292, 14212.644683882985, 14298.714025719635, 13170.275634840176, 13196.274204918438, 13216.273104979318, 13238.801417978546, 13422.798658020332, 12276.508939642314, 12691.555795547112, 12788.808167877303, 12860.614181574567, 13069.477220911058, 12744.171628844095, 12991.0, 13069.607911762663, 13100.737985240052, 13142.474301027853, 10462.529186186792, 10608.575656973635, 10741.248112632353, 11103.444827758742, 11299.152563557602, 10649.840252396376, 11094.889051109709, 11167.888321116685, 11341.829872551752, 11348.432578370883], "value": 7399.330587041618, "unit": "score"}], "name": "dromaeo_css", "value": 7280.507102124184, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 113.0, 113.0, 112.0, 112.0, 112.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 123.0, 165.0, 117.0, 119.0, 116.0, 116.0, 147.0, 118.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 104.0, 75.0, 75.0, 75.0, 74.0, 97.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 125.0, 81.0, 82.0, 80.0, 96.0, 81.0, 81.0, 118.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 53.0, 51.0, 49.0, 49.0, 51.0, 48.0, 49.0, 50.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 77.0, 74.0, 74.0, 74.0, 78.0, 74.0, 79.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 130.0, 122.0, 131.0, 127.0, 129.0, 121.0, 119.0, 175.0, 132.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 158.0, 154.0, 159.0, 154.0, 153.0, 154.0, 155.0, 154.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 60.0, 66.0, 61.0, 61.0, 63.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1449.7, "alertThreshold": 2.0}]} 11:40:54 INFO - Return code: 0 11:40:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:54 INFO - # TBPL SUCCESS # 11:40:54 INFO - Running post-action listener: _resource_record_post_action 11:40:54 INFO - [mozharness: 2017-02-07 19:40:54.145578Z] Finished run-tests step (success) 11:40:54 INFO - Running post-run listener: _resource_record_post_run 11:40:54 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325816320; Read time: 96; Write time: 215236 11:40:54 INFO - TinderboxPrint: CPU usage
13.0% 11:40:54 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 11:40:54 INFO - TinderboxPrint: I/O write bytes / time
325,816,320 / 215,236 11:40:54 INFO - TinderboxPrint: CPU idle
8,248.0 (87.0%) 11:40:54 INFO - TinderboxPrint: CPU user
1,185.8 (12.5%) 11:40:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:54 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 113352704; Read time: 0; Write time: 111404 11:40:54 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 208605184; Read time: 96; Write time: 103424 11:40:54 INFO - Running post-run listener: _upload_blobber_files 11:40:54 INFO - Blob upload gear active. 11:40:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:40:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:40:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:59 INFO - (blobuploader) - INFO - Done attempting. 11:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:00 INFO - (blobuploader) - INFO - Done attempting. 11:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:01 INFO - (blobuploader) - INFO - Done attempting. 11:41:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:01 INFO - Return code: 0 11:41:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d22814b688f592f13be678ccc9d99b24439f967cb6a608413b994b2de9ff505043396805f9e792d2870deac59bb17520ee73ac83c4b0335a8ebd5220e7d87d9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f956e7649a5c7e2de820107e7cc1ddac71604604795047f3b5eda1dde6c927bcb71c9bfc242b1fb8ac191a5bb45b59b71f1cdaa5dd0ecd6de6479c8aa7d7b708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33c631f200c3925239fb9e6b6e171a2a79a4e58833b0cdb19816bbacc1998eb72e9996df9437c16560e09272e384f5b0869a3c01cfb5baa9645d5cccf26cf76e"} 11:41:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:01 INFO - Contents: 11:41:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d22814b688f592f13be678ccc9d99b24439f967cb6a608413b994b2de9ff505043396805f9e792d2870deac59bb17520ee73ac83c4b0335a8ebd5220e7d87d9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f956e7649a5c7e2de820107e7cc1ddac71604604795047f3b5eda1dde6c927bcb71c9bfc242b1fb8ac191a5bb45b59b71f1cdaa5dd0ecd6de6479c8aa7d7b708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33c631f200c3925239fb9e6b6e171a2a79a4e58833b0cdb19816bbacc1998eb72e9996df9437c16560e09272e384f5b0869a3c01cfb5baa9645d5cccf26cf76e"} 11:41:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:01 INFO - Copying logs to upload dir... 11:41:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.641790 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-07 11:41:00.889337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 11:41:00.893033) ========= 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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 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/d22814b688f592f13be678ccc9d99b24439f967cb6a608413b994b2de9ff505043396805f9e792d2870deac59bb17520ee73ac83c4b0335a8ebd5220e7d87d9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f956e7649a5c7e2de820107e7cc1ddac71604604795047f3b5eda1dde6c927bcb71c9bfc242b1fb8ac191a5bb45b59b71f1cdaa5dd0ecd6de6479c8aa7d7b708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33c631f200c3925239fb9e6b6e171a2a79a4e58833b0cdb19816bbacc1998eb72e9996df9437c16560e09272e384f5b0869a3c01cfb5baa9645d5cccf26cf76e"} build_url:https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/PYfZ37R7TuOWAPWj0TAFtQ/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/d22814b688f592f13be678ccc9d99b24439f967cb6a608413b994b2de9ff505043396805f9e792d2870deac59bb17520ee73ac83c4b0335a8ebd5220e7d87d9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f956e7649a5c7e2de820107e7cc1ddac71604604795047f3b5eda1dde6c927bcb71c9bfc242b1fb8ac191a5bb45b59b71f1cdaa5dd0ecd6de6479c8aa7d7b708", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/33c631f200c3925239fb9e6b6e171a2a79a4e58833b0cdb19816bbacc1998eb72e9996df9437c16560e09272e384f5b0869a3c01cfb5baa9645d5cccf26cf76e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 11:41:00.917749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:41:00.918073) ========= 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=32c5991c409366f7fec8a718000001d2-1486495226.25152-877772757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 11:41:01.002623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 11:41:01.002952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 11:41:01.003245) ========= ========= Total master_lag: 0.17 =========