builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1485812354.52 results: success (0) buildid: 20170130115108 builduid: 19f5cfcb49cd4bb68030b6a2f0254512 revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.516597) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.517159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.517439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.533858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.534279) ========= 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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-30 13:39:14-- 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% 37.5M=0s 2017-01-30 13:39:14 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.218940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.767159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.767525) ========= 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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019213 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.817025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:14.817371) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 787766dd27b7373797a3fa6ab7115c85f27c04f2 --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 787766dd27b7373797a3fa6ab7115c85f27c04f2 --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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-30 13:39:14,974 truncating revision to first 12 chars 2017-01-30 13:39:14,974 Setting DEBUG logging. 2017-01-30 13:39:14,974 attempt 1/10 2017-01-30 13:39:14,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/787766dd27b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 13:39:15,528 unpacking tar archive at: mozilla-beta-787766dd27b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.866008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:15.696593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:15.696935) ========= script_repo_revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:15.697331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:15.697589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:39:15.707782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-30 13:39:15.708136) ========= /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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:39:15 INFO - MultiFileLogger online at 20170130 13:39:15 in /builds/slave/test 13:39:15 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 13:39:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:39:15 INFO - {'append_to_log': False, 13:39:15 INFO - 'base_work_dir': '/builds/slave/test', 13:39:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:39:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:39:15 INFO - 'branch': 'Mozilla-Beta', 13:39:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:39:15 INFO - 'config_files': ('talos/linux_config.py',), 13:39:15 INFO - 'default_actions': ('clobber', 13:39:15 INFO - 'read-buildbot-config', 13:39:15 INFO - 'download-and-extract', 13:39:15 INFO - 'populate-webroot', 13:39:15 INFO - 'create-virtualenv', 13:39:15 INFO - 'install', 13:39:15 INFO - 'run-tests'), 13:39:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:39:15 INFO - 'download_minidump_stackwalk': True, 13:39:15 INFO - 'download_symbols': 'ondemand', 13:39:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:39:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:39:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:39:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:39:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:39:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:39:15 INFO - 'installer_path': 'installer.exe', 13:39:15 INFO - 'log_level': 'info', 13:39:15 INFO - 'log_name': 'talos', 13:39:15 INFO - 'log_to_console': True, 13:39:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:39:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:39:15 INFO - 'opt_config_files': (), 13:39:15 INFO - 'pip_index': False, 13:39:15 INFO - 'sps_profile': False, 13:39:15 INFO - 'sps_profile_interval': 0, 13:39:15 INFO - 'suite': 'dromaeojs', 13:39:15 INFO - 'system_bits': '32', 13:39:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:39:15 INFO - 'title': 'talos-linux64-ix-024', 13:39:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:39:15 INFO - 'use_talos_json': True, 13:39:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:39:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:39:15 INFO - 'work_dir': 'build'} 13:39:15 INFO - [mozharness: 2017-01-30 21:39:15.962977Z] Running clobber step. 13:39:15 INFO - Running pre-action listener: _resource_record_pre_action 13:39:15 INFO - Running main action method: clobber 13:39:15 INFO - rmtree: /builds/slave/test/build 13:39:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:39:16 INFO - Running post-action listener: _resource_record_post_action 13:39:16 INFO - [mozharness: 2017-01-30 21:39:16.418784Z] Finished clobber step (success) 13:39:16 INFO - [mozharness: 2017-01-30 21:39:16.418884Z] Running read-buildbot-config step. 13:39:16 INFO - Running pre-action listener: _resource_record_pre_action 13:39:16 INFO - Running main action method: read_buildbot_config 13:39:16 INFO - Using buildbot properties: 13:39:16 INFO - { 13:39:16 INFO - "project": "", 13:39:16 INFO - "product": "firefox", 13:39:16 INFO - "script_repo_revision": "production", 13:39:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:39:16 INFO - "repository": "", 13:39:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:39:16 INFO - "buildid": "20170130115108", 13:39:16 INFO - "pgo_build": "True", 13:39:16 INFO - "basedir": "/builds/slave/test", 13:39:16 INFO - "buildnumber": 1, 13:39:16 INFO - "slavename": "talos-linux64-ix-024", 13:39:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:39:16 INFO - "platform": "ubuntu64_hw", 13:39:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:39:16 INFO - "branch": "mozilla-beta", 13:39:16 INFO - "repo_path": "releases/mozilla-beta", 13:39:16 INFO - "revision": "787766dd27b7373797a3fa6ab7115c85f27c04f2", 13:39:16 INFO - "stage_platform": "linux64-pgo", 13:39:16 INFO - "builduid": "19f5cfcb49cd4bb68030b6a2f0254512", 13:39:16 INFO - "slavebuilddir": "test" 13:39:16 INFO - } 13:39:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 13:39:16 INFO - Running post-action listener: _resource_record_post_action 13:39:16 INFO - [mozharness: 2017-01-30 21:39:16.421309Z] Finished read-buildbot-config step (success) 13:39:16 INFO - [mozharness: 2017-01-30 21:39:16.421398Z] Running download-and-extract step. 13:39:16 INFO - Running pre-action listener: _resource_record_pre_action 13:39:16 INFO - Running main action method: download_and_extract 13:39:16 INFO - mkdir: /builds/slave/test/build/tests 13:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:16 INFO - trying https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:39:16 INFO - Downloading https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/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 13:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/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 13:39:17 INFO - Downloaded 1327 bytes. 13:39:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:39:17 INFO - Using the following test package requirements: 13:39:17 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:39:17 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:39:17 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 13:39:17 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'jsshell-linux-x86_64.zip'], 13:39:17 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:39:17 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:39:17 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 13:39:17 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 13:39:17 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:39:17 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:39:17 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:39:17 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:39:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:39:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:39:17 INFO - Fetch https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:39:17 INFO - Http code: 200 13:39:17 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 13:39:17 INFO - x-amz-cf-id: j9-WZg-7jAeKr06L3VdmG5YtZJ3lss6j-GlJ8aMAzobSG9R31w_VLw== 13:39:17 INFO - x-amz-version-id: CGEE9jcdgEPIadQYmA5O6rMKs58FTYHy 13:39:17 INFO - Expected file size: 21951268 13:39:17 INFO - Obtained file size: 21951268 13:39:21 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 13:39:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:39:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:39:21 INFO - Fetch https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:39:22 INFO - Http code: 200 13:39:22 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 13:39:22 INFO - x-amz-cf-id: E6DtRKi8KQyD-WXzeydE6W9l16auWwdXIsEYmZanW4V472djgwyVqQ== 13:39:22 INFO - x-amz-version-id: CGEE9jcdgEPIadQYmA5O6rMKs58FTYHy 13:39:22 INFO - Expected file size: 21951268 13:39:22 INFO - Obtained file size: 21951268 13:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 13:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 13:39:27 INFO - Http code: 200 13:39:27 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:39:27 INFO - x-amz-cf-id: eELRYu2pMhC33dD_rCqFrakNBB_vRcLRPVF1dj18ZJQ_QBc1TTEaeg== 13:39:27 INFO - x-amz-version-id: gs5tC3yqbze4bu6FMS83SxarF9Jr8T.H 13:39:27 INFO - Expected file size: 14402992 13:39:27 INFO - Obtained file size: 14402992 13:39:28 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')]} 13:39:28 INFO - trying https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:39:28 INFO - Downloading https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/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 13:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/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 13:39:29 INFO - Downloaded 57686204 bytes. 13:39:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:39:29 INFO - mkdir: /builds/slave/test/properties 13:39:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:39:29 INFO - Writing to file /builds/slave/test/properties/build_url 13:39:29 INFO - Contents: 13:39:29 INFO - build_url:https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:39:29 INFO - Running post-action listener: _resource_record_post_action 13:39:29 INFO - Running post-action listener: set_extra_try_arguments 13:39:29 INFO - [mozharness: 2017-01-30 21:39:29.797823Z] Finished download-and-extract step (success) 13:39:29 INFO - [mozharness: 2017-01-30 21:39:29.798050Z] Running populate-webroot step. 13:39:29 INFO - Running pre-action listener: _resource_record_pre_action 13:39:29 INFO - Running main action method: populate_webroot 13:39:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:39:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:39:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:39:29 INFO - '--tppagecycles', 13:39:29 INFO - '7'], 13:39:29 INFO - 'tests': ['tsvgm']}}, 13:39:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:39:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:39:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:39:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:39:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:39:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['damp', 'tps']}, 13:39:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'tests': ['damp', 'tps']}, 13:39:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['dromaeo_dom']}, 13:39:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:39:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['basic_compositor_video']}, 13:39:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:39:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'other-e10s': {'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['a11yr', 13:39:29 INFO - 'ts_paint', 13:39:29 INFO - 'tpaint', 13:39:29 INFO - 'sessionrestore', 13:39:29 INFO - 'sessionrestore_no_auto_restore', 13:39:29 INFO - 'tabpaint']}, 13:39:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['tsvgx', 13:39:29 INFO - 'tsvgr_opacity', 13:39:29 INFO - 'tart', 13:39:29 INFO - 'tscrollx', 13:39:29 INFO - 'cart']}, 13:39:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:39:29 INFO - 'tsvgr_opacity', 13:39:29 INFO - 'tart', 13:39:29 INFO - 'tscrollx', 13:39:29 INFO - 'cart']}, 13:39:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'talos_options': ['--disable-e10s'], 13:39:29 INFO - 'tests': ['tp5o']}, 13:39:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'tests': ['tp5o']}, 13:39:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'talos_options': ['--disable-e10s', 13:39:29 INFO - '--xperf_path', 13:39:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:29 INFO - 'tests': ['tp5n']}, 13:39:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:39:29 INFO - 'talos_options': ['--xperf_path', 13:39:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:39:29 INFO - 'tests': ['tp5n']}}, 13:39:29 INFO - 'talos.zip': {'path': '', 13:39:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:39:29 INFO - Running post-action listener: _resource_record_post_action 13:39:29 INFO - [mozharness: 2017-01-30 21:39:29.817071Z] Finished populate-webroot step (success) 13:39:29 INFO - [mozharness: 2017-01-30 21:39:29.817158Z] Running create-virtualenv step. 13:39:29 INFO - Running pre-action listener: _resource_record_pre_action 13:39:29 INFO - Running main action method: create_virtualenv 13:39:29 INFO - Creating virtualenv /builds/slave/test/build/venv 13:39:29 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 13:39:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:39:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:39:29 INFO - Using real prefix '/usr' 13:39:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:39:30 INFO - Installing distribute.............................................................................................................................................................................................done. 13:39:32 INFO - Installing pip.................done. 13:39:32 INFO - Return code: 0 13:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:39:32 INFO - Reading from file tmpfile_stdout 13:39:32 INFO - Output received: 13:39:32 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) 13:39:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:39:32 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')]} 13:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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')]} 13:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:32 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 13:39:32 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 13:39:32 INFO - Using env: {'DISPLAY': ':0', 13:39:32 INFO - 'HOME': '/home/cltbld', 13:39:32 INFO - 'LANG': 'en_US.UTF-8', 13:39:32 INFO - 'LANGUAGE': 'en_US:en', 13:39:32 INFO - 'LOGNAME': 'cltbld', 13:39:32 INFO - 'MAIL': '/var/mail/cltbld', 13:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:32 INFO - 'MOZ_NO_REMOTE': '1', 13:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:32 INFO - 'NO_EM_RESTART': '1', 13:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:32 INFO - 'PWD': '/builds/slave/test', 13:39:32 INFO - 'SHELL': '/bin/bash', 13:39:32 INFO - 'SHLVL': '1', 13:39:32 INFO - 'TERM': 'linux', 13:39:32 INFO - 'TMOUT': '86400', 13:39:32 INFO - 'USER': 'cltbld', 13:39:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:32 INFO - '_': '/tools/buildbot/bin/python'} 13:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:32 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 13:39:32 INFO - Cleaning up... 13:39:32 INFO - Return code: 0 13:39:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:39:32 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')]} 13:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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')]} 13:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:32 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 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:32 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 13:39:32 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 13:39:32 INFO - Using env: {'DISPLAY': ':0', 13:39:32 INFO - 'HOME': '/home/cltbld', 13:39:32 INFO - 'LANG': 'en_US.UTF-8', 13:39:32 INFO - 'LANGUAGE': 'en_US:en', 13:39:32 INFO - 'LOGNAME': 'cltbld', 13:39:32 INFO - 'MAIL': '/var/mail/cltbld', 13:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:32 INFO - 'MOZ_NO_REMOTE': '1', 13:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:32 INFO - 'NO_EM_RESTART': '1', 13:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:32 INFO - 'PWD': '/builds/slave/test', 13:39:32 INFO - 'SHELL': '/bin/bash', 13:39:32 INFO - 'SHLVL': '1', 13:39:32 INFO - 'TERM': 'linux', 13:39:32 INFO - 'TMOUT': '86400', 13:39:32 INFO - 'USER': 'cltbld', 13:39:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:32 INFO - '_': '/tools/buildbot/bin/python'} 13:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:33 INFO - Downloading/unpacking psutil>=3.1.1 13:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:39:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:35 INFO - Installing collected packages: psutil 13:39:35 INFO - Running setup.py install for psutil 13:39:35 INFO - building 'psutil._psutil_linux' extension 13:39:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:39:35 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 13:39:35 INFO - building 'psutil._psutil_posix' extension 13:39:35 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 13:39:35 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 13:39:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:39:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:39:35 INFO - Successfully installed psutil 13:39:35 INFO - Cleaning up... 13:39:35 INFO - Return code: 0 13:39:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:39:35 INFO - Using env: {'DISPLAY': ':0', 13:39:35 INFO - 'HOME': '/home/cltbld', 13:39:35 INFO - 'LANG': 'en_US.UTF-8', 13:39:35 INFO - 'LANGUAGE': 'en_US:en', 13:39:35 INFO - 'LOGNAME': 'cltbld', 13:39:35 INFO - 'MAIL': '/var/mail/cltbld', 13:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:35 INFO - 'MOZ_NO_REMOTE': '1', 13:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:35 INFO - 'NO_EM_RESTART': '1', 13:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:35 INFO - 'PWD': '/builds/slave/test', 13:39:35 INFO - 'SHELL': '/bin/bash', 13:39:35 INFO - 'SHLVL': '1', 13:39:35 INFO - 'TERM': 'linux', 13:39:35 INFO - 'TMOUT': '86400', 13:39:35 INFO - 'USER': 'cltbld', 13:39:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:35 INFO - '_': '/tools/buildbot/bin/python'} 13:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:39:35 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 13:39:35 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 13:39:35 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 13:39:35 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 13:39:35 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 13:39:35 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 13:39:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:39:38 INFO - Installing collected packages: mozsystemmonitor 13:39:38 INFO - Running setup.py install for mozsystemmonitor 13:39:38 INFO - Successfully installed mozsystemmonitor 13:39:38 INFO - Cleaning up... 13:39:38 INFO - Return code: 0 13:39:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:39:38 INFO - Using env: {'DISPLAY': ':0', 13:39:38 INFO - 'HOME': '/home/cltbld', 13:39:38 INFO - 'LANG': 'en_US.UTF-8', 13:39:38 INFO - 'LANGUAGE': 'en_US:en', 13:39:38 INFO - 'LOGNAME': 'cltbld', 13:39:38 INFO - 'MAIL': '/var/mail/cltbld', 13:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:38 INFO - 'MOZ_NO_REMOTE': '1', 13:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:38 INFO - 'NO_EM_RESTART': '1', 13:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:38 INFO - 'PWD': '/builds/slave/test', 13:39:38 INFO - 'SHELL': '/bin/bash', 13:39:38 INFO - 'SHLVL': '1', 13:39:38 INFO - 'TERM': 'linux', 13:39:38 INFO - 'TMOUT': '86400', 13:39:38 INFO - 'USER': 'cltbld', 13:39:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:38 INFO - '_': '/tools/buildbot/bin/python'} 13:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:38 INFO - Downloading/unpacking jsonschema==2.5.1 13:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:39:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:39:40 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 13:39:40 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 13:39:40 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 13:39:40 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 13:39:40 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 13:39:40 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 13:39:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:39:40 INFO - warning: no files found matching '*.txt' 13:39:40 INFO - no previously-included directories found matching 'build' 13:39:40 INFO - no previously-included directories found matching 'dist' 13:39:40 INFO - no previously-included directories found matching '.git*' 13:39:40 INFO - Installing collected packages: jsonschema, functools32 13:39:40 INFO - Running setup.py install for functools32 13:39:40 INFO - warning: no files found matching '*.txt' 13:39:40 INFO - no previously-included directories found matching 'build' 13:39:40 INFO - no previously-included directories found matching 'dist' 13:39:40 INFO - no previously-included directories found matching '.git*' 13:39:40 INFO - Successfully installed jsonschema functools32 13:39:40 INFO - Cleaning up... 13:39:40 INFO - Return code: 0 13:39:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:39:40 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')]} 13:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:40 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')]} 13:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:40 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 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:40 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 13:39:40 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 13:39:40 INFO - Using env: {'DISPLAY': ':0', 13:39:40 INFO - 'HOME': '/home/cltbld', 13:39:40 INFO - 'LANG': 'en_US.UTF-8', 13:39:40 INFO - 'LANGUAGE': 'en_US:en', 13:39:40 INFO - 'LOGNAME': 'cltbld', 13:39:40 INFO - 'MAIL': '/var/mail/cltbld', 13:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:40 INFO - 'MOZ_NO_REMOTE': '1', 13:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:40 INFO - 'NO_EM_RESTART': '1', 13:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:40 INFO - 'PWD': '/builds/slave/test', 13:39:40 INFO - 'SHELL': '/bin/bash', 13:39:40 INFO - 'SHLVL': '1', 13:39:40 INFO - 'TERM': 'linux', 13:39:40 INFO - 'TMOUT': '86400', 13:39:40 INFO - 'USER': 'cltbld', 13:39:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:40 INFO - '_': '/tools/buildbot/bin/python'} 13:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:39:41 INFO - Cleaning up... 13:39:41 INFO - Return code: 0 13:39:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:39: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')]} 13:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39: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')]} 13:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:39:41 INFO - Using env: {'DISPLAY': ':0', 13:39:41 INFO - 'HOME': '/home/cltbld', 13:39:41 INFO - 'LANG': 'en_US.UTF-8', 13:39:41 INFO - 'LANGUAGE': 'en_US:en', 13:39:41 INFO - 'LOGNAME': 'cltbld', 13:39:41 INFO - 'MAIL': '/var/mail/cltbld', 13:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:41 INFO - 'MOZ_NO_REMOTE': '1', 13:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:41 INFO - 'NO_EM_RESTART': '1', 13:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:41 INFO - 'PWD': '/builds/slave/test', 13:39:41 INFO - 'SHELL': '/bin/bash', 13:39:41 INFO - 'SHLVL': '1', 13:39:41 INFO - 'TERM': 'linux', 13:39:41 INFO - 'TMOUT': '86400', 13:39:41 INFO - 'USER': 'cltbld', 13:39:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:41 INFO - '_': '/tools/buildbot/bin/python'} 13:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:39:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:39:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:39:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:43 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 13:39:44 INFO - Downloading docopt-0.6.1.tar.gz 13:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:39:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:39:44 INFO - Running setup.py install for blobuploader 13:39:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:39:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:39:44 INFO - Running setup.py install for requests 13:39:44 INFO - Running setup.py install for docopt 13:39:44 INFO - Successfully installed blobuploader requests docopt 13:39:44 INFO - Cleaning up... 13:39:44 INFO - Return code: 0 13:39:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:44 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')]} 13:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:44 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')]} 13:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:44 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 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:44 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 13:39:44 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 13:39:44 INFO - Using env: {'DISPLAY': ':0', 13:39:44 INFO - 'HOME': '/home/cltbld', 13:39:44 INFO - 'LANG': 'en_US.UTF-8', 13:39:44 INFO - 'LANGUAGE': 'en_US:en', 13:39:44 INFO - 'LOGNAME': 'cltbld', 13:39:44 INFO - 'MAIL': '/var/mail/cltbld', 13:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:44 INFO - 'MOZ_NO_REMOTE': '1', 13:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:44 INFO - 'NO_EM_RESTART': '1', 13:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:44 INFO - 'PWD': '/builds/slave/test', 13:39:44 INFO - 'SHELL': '/bin/bash', 13:39:44 INFO - 'SHLVL': '1', 13:39:44 INFO - 'TERM': 'linux', 13:39:44 INFO - 'TMOUT': '86400', 13:39:44 INFO - 'USER': 'cltbld', 13:39:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:44 INFO - '_': '/tools/buildbot/bin/python'} 13:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:45 INFO - Running setup.py (path:/tmp/pip-5TyzTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:45 INFO - Running setup.py (path:/tmp/pip-oCs1Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:45 INFO - Running setup.py (path:/tmp/pip-UUJhIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:45 INFO - Running setup.py (path:/tmp/pip-nptRyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:45 INFO - Running setup.py (path:/tmp/pip-4AyQRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:45 INFO - Running setup.py (path:/tmp/pip-YlL6e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:45 INFO - Running setup.py (path:/tmp/pip-QrIUg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:45 INFO - Running setup.py (path:/tmp/pip-BGfSk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:45 INFO - Running setup.py (path:/tmp/pip-Bxv0DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:45 INFO - Running setup.py (path:/tmp/pip-tEKMBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:45 INFO - Running setup.py (path:/tmp/pip-5XcV5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:45 INFO - Running setup.py (path:/tmp/pip-upcS83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:45 INFO - Running setup.py (path:/tmp/pip-2tjWok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:45 INFO - Running setup.py (path:/tmp/pip-ebX1NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:46 INFO - Running setup.py (path:/tmp/pip-rpNukO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:46 INFO - Running setup.py (path:/tmp/pip-dfsvSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:46 INFO - Running setup.py (path:/tmp/pip-RYBUdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:39:46 INFO - Running setup.py install for manifestparser 13:39:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Running setup.py install for mozcrash 13:39:46 INFO - Running setup.py install for mozdebug 13:39:46 INFO - Running setup.py install for mozdevice 13:39:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Running setup.py install for mozfile 13:39:46 INFO - Running setup.py install for mozhttpd 13:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Running setup.py install for mozinfo 13:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:39:46 INFO - Running setup.py install for mozInstall 13:39:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Running setup.py install for mozleak 13:39:47 INFO - Running setup.py install for mozlog 13:39:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Running setup.py install for moznetwork 13:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Running setup.py install for mozprocess 13:39:47 INFO - Running setup.py install for mozprofile 13:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Running setup.py install for mozrunner 13:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:39:47 INFO - Running setup.py install for mozscreenshot 13:39:47 INFO - Running setup.py install for moztest 13:39:47 INFO - Running setup.py install for mozversion 13:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:39:48 INFO - Cleaning up... 13:39:48 INFO - Return code: 0 13:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:48 INFO - Using env: {'DISPLAY': ':0', 13:39:48 INFO - 'HOME': '/home/cltbld', 13:39:48 INFO - 'LANG': 'en_US.UTF-8', 13:39:48 INFO - 'LANGUAGE': 'en_US:en', 13:39:48 INFO - 'LOGNAME': 'cltbld', 13:39:48 INFO - 'MAIL': '/var/mail/cltbld', 13:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:48 INFO - 'MOZ_NO_REMOTE': '1', 13:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:48 INFO - 'NO_EM_RESTART': '1', 13:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:48 INFO - 'PWD': '/builds/slave/test', 13:39:48 INFO - 'SHELL': '/bin/bash', 13:39:48 INFO - 'SHLVL': '1', 13:39:48 INFO - 'TERM': 'linux', 13:39:48 INFO - 'TMOUT': '86400', 13:39:48 INFO - 'USER': 'cltbld', 13:39:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:48 INFO - '_': '/tools/buildbot/bin/python'} 13:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:39:48 INFO - Running setup.py (path:/tmp/pip-ImQB1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:39:48 INFO - Running setup.py (path:/tmp/pip-ckx8mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:39:48 INFO - Running setup.py (path:/tmp/pip-YgQOG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:39:48 INFO - Running setup.py (path:/tmp/pip-2IHn9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:39:48 INFO - Running setup.py (path:/tmp/pip-GRhOMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:39:48 INFO - Running setup.py (path:/tmp/pip-bUZZTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:39:48 INFO - Running setup.py (path:/tmp/pip-5Hqyw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:39:48 INFO - Running setup.py (path:/tmp/pip-Okn5ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:39:48 INFO - Running setup.py (path:/tmp/pip-xlVQB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:39:48 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)) 13:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:39:48 INFO - Running setup.py (path:/tmp/pip-Q9uoPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:39:49 INFO - Running setup.py (path:/tmp/pip-loRoI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:39:49 INFO - Running setup.py (path:/tmp/pip-pau9JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:39:49 INFO - Running setup.py (path:/tmp/pip-Bgq0Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:39:49 INFO - Running setup.py (path:/tmp/pip-9xXbtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:49 INFO - Running setup.py (path:/tmp/pip-jmyxv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:39:49 INFO - Running setup.py (path:/tmp/pip-DBLSrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:39:49 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)) 13:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:39:49 INFO - Running setup.py (path:/tmp/pip-xYeX1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:39:49 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)) 13:39:49 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)) 13:39:49 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)) 13:39:49 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)) 13:39:49 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)) 13:39:49 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)) 13:39:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39: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 13:39:51 INFO - Downloading blessings-1.6.tar.gz 13:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:39:51 INFO - Installing collected packages: blessings 13:39:51 INFO - Running setup.py install for blessings 13:39:51 INFO - Successfully installed blessings 13:39:51 INFO - Cleaning up... 13:39:51 INFO - Return code: 0 13:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:52 INFO - Reading from file tmpfile_stdout 13:39:52 INFO - Current package versions: 13:39:52 INFO - argparse == 1.2.1 13:39:52 INFO - blessings == 1.6 13:39:52 INFO - blobuploader == 1.2.4 13:39:52 INFO - docopt == 0.6.1 13:39:52 INFO - functools32 == 3.2.3-2 13:39:52 INFO - jsonschema == 2.5.1 13:39:52 INFO - manifestparser == 1.1 13:39:52 INFO - mozInstall == 1.12 13:39:52 INFO - mozcrash == 1.0 13:39:52 INFO - mozdebug == 0.1 13:39:52 INFO - mozdevice == 0.48 13:39:52 INFO - mozfile == 1.2 13:39:52 INFO - mozhttpd == 0.7 13:39:52 INFO - mozinfo == 0.9 13:39:52 INFO - mozleak == 0.1 13:39:52 INFO - mozlog == 3.4 13:39:52 INFO - moznetwork == 0.27 13:39:52 INFO - mozprocess == 0.23 13:39:52 INFO - mozprofile == 0.28 13:39:52 INFO - mozrunner == 6.13 13:39:52 INFO - mozscreenshot == 0.1 13:39:52 INFO - mozsystemmonitor == 0.3 13:39:52 INFO - moztest == 0.8 13:39:52 INFO - mozversion == 1.4 13:39:52 INFO - psutil == 3.1.1 13:39:52 INFO - requests == 1.2.3 13:39:52 INFO - wsgiref == 0.1.2 13:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:39:52 INFO - Using env: {'DISPLAY': ':0', 13:39:52 INFO - 'HOME': '/home/cltbld', 13:39:52 INFO - 'LANG': 'en_US.UTF-8', 13:39:52 INFO - 'LANGUAGE': 'en_US:en', 13:39:52 INFO - 'LOGNAME': 'cltbld', 13:39:52 INFO - 'MAIL': '/var/mail/cltbld', 13:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:52 INFO - 'MOZ_NO_REMOTE': '1', 13:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:52 INFO - 'NO_EM_RESTART': '1', 13:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:52 INFO - 'PWD': '/builds/slave/test', 13:39:52 INFO - 'SHELL': '/bin/bash', 13:39:52 INFO - 'SHLVL': '1', 13:39:52 INFO - 'TERM': 'linux', 13:39:52 INFO - 'TMOUT': '86400', 13:39:52 INFO - 'USER': 'cltbld', 13:39:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:52 INFO - '_': '/tools/buildbot/bin/python'} 13:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:39:52 INFO - Cleaning up... 13:39:52 INFO - Return code: 0 13:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69b0f9ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x263d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x270aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, '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': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', '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 13:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:39:52 INFO - Using env: {'DISPLAY': ':0', 13:39:52 INFO - 'HOME': '/home/cltbld', 13:39:52 INFO - 'LANG': 'en_US.UTF-8', 13:39:52 INFO - 'LANGUAGE': 'en_US:en', 13:39:52 INFO - 'LOGNAME': 'cltbld', 13:39:52 INFO - 'MAIL': '/var/mail/cltbld', 13:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:39:52 INFO - 'MOZ_NO_REMOTE': '1', 13:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:39:52 INFO - 'NO_EM_RESTART': '1', 13:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:39:52 INFO - 'PWD': '/builds/slave/test', 13:39:52 INFO - 'SHELL': '/bin/bash', 13:39:52 INFO - 'SHLVL': '1', 13:39:52 INFO - 'TERM': 'linux', 13:39:52 INFO - 'TMOUT': '86400', 13:39:52 INFO - 'USER': 'cltbld', 13:39:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:39:52 INFO - '_': '/tools/buildbot/bin/python'} 13:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:39:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:39:52 INFO - Cleaning up... 13:39:52 INFO - Return code: 0 13:39:52 INFO - Running post-action listener: _resource_record_post_action 13:39:52 INFO - Running post-action listener: _start_resource_monitoring 13:39:52 INFO - Starting resource monitoring. 13:39:52 INFO - [mozharness: 2017-01-30 21:39:52.659641Z] Finished create-virtualenv step (success) 13:39:52 INFO - [mozharness: 2017-01-30 21:39:52.660095Z] Running install step. 13:39:52 INFO - Running pre-action listener: _resource_record_pre_action 13:39:52 INFO - Running main action method: install 13:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:39:52 INFO - Reading from file tmpfile_stdout 13:39:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:39:52 INFO - Reading from file tmpfile_stdout 13:39:52 INFO - Output received: 13:39:52 INFO - Usage: mozinstall [options] installer 13:39:52 INFO - Options: 13:39:52 INFO - -h, --help show this help message and exit 13:39:52 INFO - -d DEST, --destination=DEST 13:39:52 INFO - Directory to install application into. [default: 13:39:52 INFO - "/builds/slave/test"] 13:39:52 INFO - --app=APP Application being installed. [default: firefox] 13:39:52 INFO - mkdir: /builds/slave/test/build/application 13:39:52 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'] 13:39:52 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 13:40:06 INFO - Reading from file tmpfile_stdout 13:40:06 INFO - Output received: 13:40:06 INFO - /builds/slave/test/build/application/firefox/firefox 13:40:06 INFO - Running post-action listener: _resource_record_post_action 13:40:06 INFO - [mozharness: 2017-01-30 21:40:06.585778Z] Finished install step (success) 13:40:06 INFO - [mozharness: 2017-01-30 21:40:06.586022Z] Running run-tests step. 13:40:06 INFO - Running pre-action listener: _resource_record_pre_action 13:40:06 INFO - Running main action method: run_tests 13:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:40:06 INFO - Python 2.7.3 13:40:06 INFO - Return code: 0 13:40:06 INFO - grabbing minidump binary from tooltool 13:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:40:06 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 0x2707f60>, '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 0x2708d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27091d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:40:06 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 13:40:06 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 13:40:06 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 13:40:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:40:06 INFO - Return code: 0 13:40:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:40:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:40:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:40:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:40:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:40:06 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/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 13:40:06 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/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 13:40:06 INFO - Using env: {'DISPLAY': ':0', 13:40:06 INFO - 'HOME': '/home/cltbld', 13:40:06 INFO - 'LANG': 'en_US.UTF-8', 13:40:06 INFO - 'LANGUAGE': 'en_US:en', 13:40:06 INFO - 'LOGNAME': 'cltbld', 13:40:06 INFO - 'MAIL': '/var/mail/cltbld', 13:40:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:40:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:06 INFO - 'MOZ_NO_REMOTE': '1', 13:40:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:40:06 INFO - 'NO_EM_RESTART': '1', 13:40:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:06 INFO - 'PWD': '/builds/slave/test', 13:40:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:40:06 INFO - 'SHELL': '/bin/bash', 13:40:06 INFO - 'SHLVL': '1', 13:40:06 INFO - 'TERM': 'linux', 13:40:06 INFO - 'TMOUT': '86400', 13:40:06 INFO - 'USER': 'cltbld', 13:40:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766', 13:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:06 INFO - '_': '/tools/buildbot/bin/python'} 13:40:06 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/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 13:40:06 INFO - mozversion application_buildid: 20170130115108 13:40:06 INFO - mozversion application_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:40:06 INFO - mozversion application_display_name: Firefox 13:40:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:40:06 INFO - mozversion application_name: Firefox 13:40:06 INFO - mozversion application_remotingname: firefox 13:40:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:40:06 INFO - mozversion application_vendor: Mozilla 13:40:06 INFO - mozversion application_version: 52.0 13:40:06 INFO - mozversion platform_buildid: 20170130115108 13:40:06 INFO - mozversion platform_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:40:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:40:06 INFO - mozversion platform_version: 52.0 13:40:06 INFO - using testdate: 1485812406 13:40:06 INFO - actual date: 1485812406 13:40:06 INFO - starting webserver on 'localhost:36470' 13:40:06 INFO - SUITE-START | Running 2 tests 13:40:06 INFO - TEST-START | dromaeo_css 13:40:06 INFO - operating with platform_type : linux_ 13:40:06 INFO - Initialising browser for dromaeo_css test... 13:40:06 INFO - TEST-INFO | started process 10991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplY611O/profile http://localhost:36470/getInfo.html) 13:40:10 INFO - PROCESS | 10991 | __metrics Screen width/height:1600/1200 13:40:10 INFO - PROCESS | 10991 | colorDepth:24 13:40:10 INFO - PROCESS | 10991 | Browser inner width/height: 1024/697 13:40:10 INFO - PROCESS | 10991 | __metrics 13:40:11 INFO - PROCESS | 10991 | 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" 13:40:11 INFO - PROCESS | 10991 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:40:11 INFO - PROCESS | 10991 | console.error: PushService: 13:40:11 INFO - PROCESS | 10991 | stateChangeProcessEnqueue: Error transitioning state 13:40:11 INFO - PROCESS | 10991 | UnknownError 13:40:12 INFO - TEST-INFO | 10991: exit 0 13:40:12 INFO - Browser initialized. 13:40:12 INFO - Running cycle 1/1 for dromaeo_css test... 13:40:12 INFO - TEST-INFO | started process 11082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplY611O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:40:24 INFO - PROCESS | 11082 | RSS: Main: 144572416 13:40:24 INFO - PROCESS | 11082 | 13:43:25 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36470/tests/dromaeo/cssquery-ext.html) 13:43:26 INFO - PROCESS | 11082 | RSS: Main: 230944768 13:43:26 INFO - PROCESS | 11082 | 13:46:28 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-ext.html (next: http://localhost:36470/tests/dromaeo/cssquery-jquery.html) 13:46:29 INFO - PROCESS | 11082 | RSS: Main: 224780288 13:46:29 INFO - PROCESS | 11082 | 13:49:31 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36470/tests/dromaeo/cssquery-mootools.html) 13:49:31 INFO - PROCESS | 11082 | RSS: Main: 207290368 13:49:31 INFO - PROCESS | 11082 | 13:52:33 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36470/tests/dromaeo/cssquery-prototype.html) 13:52:34 INFO - PROCESS | 11082 | RSS: Main: 224632832 13:52:34 INFO - PROCESS | 11082 | 13:55:36 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36470/tests/dromaeo/cssquery-yui.html) 13:55:37 INFO - PROCESS | 11082 | RSS: Main: 175349760 13:55:37 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | Cycle 1(1): loaded http://localhost:36470/tests/dromaeo/cssquery-yui.html (next: http://localhost:36470/tests/dromaeo/cssquery-dojo.html) 13:58:39 INFO - PROCESS | 11082 | RSS: Main: 262750208 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | __start_tp_report 13:58:39 INFO - PROCESS | 11082 | _x_x_mozilla_page_load 13:58:39 INFO - PROCESS | 11082 | _x_x_mozilla_page_load_details 13:58:39 INFO - PROCESS | 11082 | |i|pagename|runs| 13:58:39 INFO - PROCESS | 11082 | |0;dojo.html;3212.919677008075;3230.903072907812;3233.757468189885;3272.5745653065096;3287.589051368579;5542.473465020822;5625.987322281988;5626.971865140674;5627.324721033477;5634.887302253953;5515.696636684981;5562.638428502155;5574.777008919638;5576.414476479962;5590.664560126395;5024.422191447985;5055.266986286986;5087.084324821531;5108.2593024011685;5131.409887862887;4955.058538877602;4985;5082.872928176788;5113.974430127862;5133.614978876581;4974.10466116099;5020.0712868119335;5032.874178145557;5057.140286151344;5078.7968481260705;5121.206213036985;5136.203888397305;5191.480851914816;5192.221166824968;5234.42421333653;4862.927056094161;5083.440821509631;5110.361204849394;5148.665336753099;5166.405863325691;5414.052540805344;5415.48552887475;5419.918701219485;5425.891482170335;5476.041692703761;5821.88356232873;5830.212921255618;5911.645301281937;5926.525877929756;5935.762569497215;5889.322727886262;5957.017092179785;5968.850778730523;5982.551308651825;5982.6410415374785;5516.7517461714315;5555.611107222537;5559.221708960789;5563.109902415635;5583.804566840141;6091.51267898567;6093.11649810775;6097.847553811191;6098.786542470993;6105.114758360013;5687.260656114761;5851.678157701367;5852.092925596539;5852.7658893643775;5859.384764599656;5799.217105690762;5837.387074357216;5874.471297583238;5877.52979761618;5952.583319167703;5886.440788125121;5894.381089985575;5894.764209431661;5895.587308888423;5899.911501327483;5848.210491583582;5906.852328691731;5912.970435147797;5920.615160014585;5933.139694744238;4525.683202175816;4560.817567297271;4562.543745625478;4578.862634120982;4584.633229341644;4072.1041370898356;4072.3687828386646;4090.9386359204636;4118.629323360912;4158.9376159357635;5583.0787919992745;5590.944090559124;5593.077142271561;5593.188987596775;5595.664260144323;5977.402259773988;5977.970110149508;5993.220881285405;5995.820125396245;5998.790042348497;5418.539424148913;5494.560435165177;5575.303087114111;5615.9157612635845;5617.494425501724;5203.505666961632;5251.343582052244;5252.395974462909;5252.816151434681;5273.630845840831;6170.753169873245;6179.073139029181;6186.350433204539;6188.288346840171;6192.071189321638;5828.184054232326;5912.024515954819;5950.285965684146;5953.345132035559;6055.939440605537;6128.167033931239;6128.655903792168;6134.528431832502;6134.834601026089;6143.815685529441;5883.470487656132;5886.911696324473;5889.67606781614;5892.616979896293;5922.73347699346;5793.565482588739;5793.826185214451;5886.58793884424;5987.371326010881;6008.459238668541;5755.539556835527;5789;5841.707914604168;5865.824025279248;5875.294964604275;5831.854203644773;5833.358330583717;5834.241548598655;5839.5036421904615;5842.474177324061;5646.802361917313;5647.237622920853;5813.418658134153;5832.416758324133;5834.970825146017;5813.709314534341;5895.616784908967;5904.734286957183;5939.07944268639;5996.340402555803;5789.2184555086205;5804.3905389935135;5805.535557155502;5808.883822323614;5818.301803783573 13:58:39 INFO - PROCESS | 11082 | |1;ext.html;597.2951916738247;610.6885488400916;654.492768104719;662.2384258103177;675.0414411535619;35166;45146.548534514644;46470.76764616172;46579.76710116449;46615.270778337734;47853.52146478534;48172.518274817245;48517.75741121298;48566.51433485664;48655;8471.06818249992;8836.11638836116;8968;8971.551422428853;8980.685676001342;8711.564421778918;10699.46502674867;10951.671449856518;10964.17768667349;11236.157288203376;10719.732006699816;10761.78476430471;10763.408012559306;10763.78472430551;10767;11051.557937682483;11082.224244302903;11082.944585277062;11115.555377784878;11125.165612579089;10883.292585981886;10946.616868409568;10946.726331841688;10959.726006849893;10980.670579882617;44689.329660055126;44915.32627010597;44987.32519012185;45034.32448513275;45066.54933450656;3613.8735144269826;3760.3983362661843;3904.5509766376663;3929.8231579578987;4351.28203846365;32877.17807054819;33547.83226083854;33729.49405758915;35520.467192992124;35704.28591428157;4195.244855925932;4292.635126014261;4374.4531933508315;4392.363107349448;4461.08547747711;344096;344875;345398;347869;349784;66279;66794.66602666955;66806.33193668099;66843.33156668372;66876;35894.8205258972;36662.08344791348;36790.8160459196;36794.816025919696;69916.6504167476;16598;16790.328386864632;16792;16802.243899024572;16810.243539040774;11707.648770536898;11965.641030769091;12307.56923507673;12646.620601381974;12764.872351276554;20254.189832406537;20684.689729654066;20922.581548368948;20928;20947;7564.319211271012;7690;7774.883376749353;7802.219778022152;7815.609219539114;980.9558569864373;1050.3960222871879;1059.9930066436916;1096.369587487198;1153.5270539079106;32723.67276327206;34066;34169.829150854086;34247.65752342495;34311.485327720104;1124.3984468309416;1177.140687298277;1214.6963259185204;1226.3561630144245;1244.9377531123407;15351.769723454157;16298.51104466868;17585.29658813633;17701;18254.361097361794;320398;322404;323167;324071;324198;56001;56283.71858140683;56391.43608563944;56464.15303770447;56491.43508564944;1292.095533126815;1336.652470357714;1371.5473893615283;1425.7932599772976;1431.957041288763;30578;31895;32279.35441291114;33010.33979320448;33252;48293.27560086672;48864.75567622139;48931.75534122306;49120.263196051375;49196.50803491919;256235;259458;261048.08427873216;261364;262416;25529.87235063813;26081.217563473125;27966.3008424791;28923.132306030853;29528.409431811673;45038.09923801571;45252.547474524836;45492.772536137105;45592.772036139606;45614.31578526391;38118.23763524659;38207;38888;39163.41254881122;39810;38171.23657526889;39019.804900975316;39130.21739565136;39388.212235755695;40083.59916400799;39348.80325598468;39844.2031159381;42775.7861210692;43306;43664.12671746611;36290.27419451649;39201.80399097986;39457.605423945395;39464;40043.3993490092;29570;29737.25656858596;29738.553921691626;30153.246168845955;30164.245893851952 13:58:39 INFO - PROCESS | 11082 | |2;jquery.html;412.2106166690787;412.77503760450554;418.88480667816344;424.9213895429346;428.8927768057986;18808.717869231954;20145.891975941337;20462.897685511587;20637.277695280667;20739.792602073976;19786.208551657917;19962.101705423254;20096.39710808678;20609.27867524637;20789.792102078976;5810.535157187415;6101.60339577926;6101.9389806102035;6102.389761023906;6105;5792.623479473842;5960.672163031031;5974.6713930733795;6083.239595050619;6084.5436592255755;5970.104484327364;5972.820815375524;5973.970130149365;5974.253218347707;5975.462208401243;5627.662340259598;5887.499562537147;5909.645421274694;5955.225820643311;5963.701814909259;5824.330202026778;5825.417458254183;5827.79602713903;5839.562032847511;5846.386129456431;13346.466141354334;13455.259960702157;13609.795853062213;13725.245111518961;13733.176009439465;2517.584598541257;2531.962020569693;2941.5734718465915;2965.8072225305286;3148.590683211191;10814.945925270402;10992.670219893336;11098.334099953949;12210.694732631755;15683.607909802233;1909.9140538675654;1990.601879624081;2016.4555569996166;2026.2097781865084;2055.095757866549;79650.60174699148;82455.58772206161;83017.58491207505;85329.57335213346;88101.99999999936;11021.173411994132;11557.30656160633;11691.123165762601;11962.521499140112;12071.637850864488;17000.48998530046;17052.147392630566;17083.316667333416;17091.9744815309;17099.914500427418;7978.162292959272;8051.315638170821;8073;8188.754337369888;8225.054118776417;7445.813854653677;7469.215732348134;7614.162442131361;7665.61671916402;7688.115866675292;4566.086782643484;4806.567408933212;5096.643234973591;5161.329027226437;5284.894302113936;2038.4801875521648;2103.8527303088636;2117.385958072173;2133;2139.6041732279577;891.3315013739696;969.4972792172105;998.9350692205129;1024.3290644627632;1026.0611540440414;20398.79601203969;20711.689324660143;20818.58362832735;20883;21038.368848934555;990.2474119668959;1022.6676330192718;1027.0653705128298;1055.461714525582;1055.5672174408455;10747.78504429907;11662.825057624143;11695.298282103102;11704.648860534198;11707.648770536727;449600;449714;450850;453125;454101;85771.57114214514;87854.56072719596;88815;90762.54618726864;93820.53089734507;993.9006099390148;998.9200863931013;1007.6322142417964;1020.7090979071078;1020.8417695257247;17263.741043884602;17531.21109550048;18474.353397631017;18480.168392422103;18501.72247416263;41120.177596447305;41624.58375416207;42592.5740742601;42692.786536068365;43774;57028.42971570231;57156.42843571511;58053;58215;59076;9082;9110.817783644157;9215.907840921773;9358.204552612831;9689.418634881647;11906.34515101643;13808.102473339603;13847.653808654864;14176.362063707364;14507.854921450651;11769.764604707687;12309.384530773605;12460.314682692177;12534.435950382072;12793.872061279268;11976.401179941142;12038.217515861441;12137.150399472306;12410.317432541297;12729.681757956125;12080.45637946277;12431.62705118848;12595.748085038065;12613.180143290656;12935.417906194056;8973.147550982647;8998.50508222028;9396.342256042011;9404.106609872051;9450.952745236506;11906.345151016778;12025.518979240733;12298.815517767061;12308.692282693004;12334.50661973511 13:58:39 INFO - PROCESS | 11082 | |3;mootools.html;1362.9114107583;1497.0568541818657;1524.1997951075687;1661.4434164554873;1765.4527096600054;7726.304632583066;8240.505569665816;8569.614367353468;8590.656373745058;8823.250023747989;8586.356023298247;8623.698170564032;8630.913690863104;8637.784055398603;8645;2434.6226334918115;2464.18681834994;2465.272744540365;2466.112199608149;2466.5436894174545;2415.927522174338;2513.195777351248;2521.6595759572497;2525.0657256815;2527.772500474957;2394.0782798622567;2425.721042080157;2475.096589744739;2484.3416494628937;2486.8507889526595;2372.2408829174583;2374.7387787343378;2383.9880800595975;2400.9639855402183;2407.205622144688;2361.114582031738;2391.0316321889663;2391.7727815857465;2393.5571919195004;2394.5450364430703;8438.662453501853;8501.532415717133;8644.913550864474;8700.477971321741;8713.825723485495;5400.054990376708;5557.5831812613815;5566.443355664442;5567.972160139214;5583.050881350139;3305.0910999475095;3415.6072051714123;3426.8457919393436;3434.587849458081;3472.2534655049285;1027.2655051638114;1053.1416895230439;1067.530286673861;1069.8234791259433;1079.6005477973201;11617.361045142514;11640.010599099087;11645;11653.009494193004;11761.764764704743;4432.423784907941;4690.202665546865;4723.362346083303;4778.211595086841;4811.663183577186;9482.051794820463;9483.47840868745;9494.240460763122;9502.144806967406;9514;5496.697681627469;5509.862253443696;5510.201020851954;5511.063119269734;5511.366192887789;4506.729596224237;4591.517890621503;5065.265536497187;5078.162103252922;5137.460566640524;3939.0546268895832;3962.32640451124;3969.4442778011103;4055.6552693020835;4077.8164982575854;1241.7330273991136;1260.7226410189744;1267.5436842736608;1280.1998750780763;1284.1460428814921;883.3419102768479;1008.495752123938;1012.3875055591261;1022.8721409823772;1025.43601019439;5800.419958004166;5837;6093.573449858556;6106.847328816726;6169.475594574422;479.95920346770913;481.46076394437756;487.7049385122021;531.4393315052579;533.706461446203;3905.4727611772046;3963;3990.780507072139;4076.9796151019054;4109.938350924738;10262.127719143808;10486.63296784624;10592.311499752492;10605.045545900906;10615.097716694167;10278.17774578047;10517.158627309796;10524.894751052545;10530.36817790935;10559.313644613076;7975.5613441261285;8141.185881411811;8219.506829590244;8230.876536851953;8233.547154906419;5794.594378393472;5829.621074630305;5863.941360586339;5869.090291004901;6003.609765365237;9572;9755.756106097404;9922.652707155215;9930.453825039693;9933.255005874733;9568.90431095708;9814.214862810815;9921.702348929544;9933.950330248592;9979.50102494887;6624.205095388585;6848.794536163923;6994.5803251805055;7102.644867756489;7170.784876453715;8042.9597852010365;8363.916360836558;8365.916340836757;8377.078521362768;8427.0730219677;7037.296270373126;7213.71145154209;7317.890231646423;7371.336579707852;7397.149327827368;7212.170600380813;7518.28576285252;7550.282723141293;7588.241175882588;7790.415718821225;6999.300069993164;7099.82250443743;7112.395446386908;7114.14630244374;7125.07374041392;5198.116320225495;5339.973300133474;5371.4897084776885;5384.461553844741;5539.750711218086;5309.309789727466;5373.650712703662;5402.5677945763455;5443.537299329601;5517.475839795213 13:58:39 INFO - PROCESS | 11082 | |4;prototype.html;353.7523733386629;357.5102110109151;358.95901884534857;367.5515870637821;369.2283128261932;5360.973195134024;5424.403315635277;5436.293281873361;5449.727513624312;5452.91820622691;5043.798248070082;5186.3257776489;5225.190095535198;5297.841064768054;5352.384475785286;4231.915361692764;4243.511996120455;4250.128723611652;4259.616634502886;4269.466316710411;4224.61978421942;4240.703150779446;4244.49066112067;4250.27745283301;4260.3822445745345;4130.896727581804;4192.119654872466;4224.598663126998;4232.936505952398;4234.597713217239;4153.210889930933;4198.685098617585;4215.66274698025;4227.070044590216;4230.873073807776;3752.5496940367057;3771.622837716234;3772.679322257584;3803.6386543278345;3806.4290356446477;5071.931481453705;5200;5249.186376111708;5261.316028916216;5267.341582302212;4851.151048566522;4855.854324370274;4863.975680121612;4874.439439464436;4883.658143929926;5585.525230355424;5586.486081263448;5599.6640201587625;5601.747921343509;5620.831375058755;4097.405876147972;4118.238125946679;4149.958500414988;4184.832606695729;4189.120284740177;5783.334916484616;5791.478766910956;5795.493726295615;5808.92127172595;5815.534757219454;4255.212785634606;4267.530571637118;4274.294741367702;4280.785960701953;4281.828726850953;4175.081482073939;4348.391095294761;4366.672499562545;4367.978160109179;4379.189849877783;4827.493113223061;4831.613470922318;4841.782119804547;4858.489858564871;4871.683340582851;5604.943950560524;5606.859828504238;5607.317804658586;5609.298837645294;5612.775488980476;1379.4275375718964;1431.2128329418779;1441.5747354530438;1447.5223176351778;1448.6740483391363;984.8128855517429;999.550202408919;1005.6731562242154;1006.2453160129902;1015.1777060580953;5138.841686491683;5177.275181474596;5185.910958698715;5186.6369354144845;5186.688798672017;5491.807786727445;5508.724563771795;5540.252065971123;5582.18578961839;5591.6365436246515;5001.524855138756;5172.327597412387;5191.558717508979;5204.42751297357;5220.530152286313;2909.6653884803095;2924.502834518137;2934.1930968983274;2945.6612489563545;2966.569847372119;5565.38780734127;5566.443355664401;5610.298712660918;5631.746571404296;5671.432856714296;5549.528290095306;5625.831225063254;5886.6173698709445;5940.881182376328;5946.583739138218;5825.766969321265;5901.645901245853;5912.290525137011;5915.733791979371;5927.347991720907;5599.692016938944;5793.91309130355;5796.3916237692365;5805.680687562056;5828.358880523054;5738.626989245686;5768.480836724715;5771.2686194142425;5798.652080875161;5810.912836307374;5850.970745146247;5905.852353691193;5917.230760001173;5945.10823376497;5955.553333500092;4008.819603117925;4135.669146468215;4146.253674338648;4152.335626299778;4194.3498757692605;5512.173174023928;5635.549156067423;5655.236543066633;5780;5820.185174075717;5633.492985631313;5640.323161220515;5647.661140331593;5658.405867383865;5682.659040457585;5549.214766672884;5554;5624.521915637053;5637.3235211774845;5643.419842444122;5634;5636.491761166241;5648.548116150616;5650.63270887391;5667.773289068556;5643.266375371176;5644.407337229532;5663.85840353978;5664.518515926193;5670.773169073191;5416.918746218888;5482.725863706719;5520.337559492887;5530.972345138249;5555.444475546853 13:58:39 INFO - PROCESS | 11082 | |5;yui.html;768.4044865229447;800.539689678435;805.5287656720815;864.7232885476648;895.3150839607697;15262.694746105071;16552;17126.743098853527;17258.913705431456;17349.65300693987;16483.752743708854;16517.587060323498;16671.08309043002;16802.83197168028;16899.324027038936;859.025006617489;877.1272583779116;877.188600544497;877.7630039889258;878.3280790195505;726.901868247785;760.9581473018982;848.9872651910226;872.8123453457505;878.4641368765048;915.4004127296631;917.7430319510514;919.3886065766291;919.797644518205;920.1442658327752;902.8465160922659;906.9591868365907;907.2605826251583;913.2283220678516;913.4610579757941;670.1355251725269;671.6943790575276;672.4821887146869;672.515788632184;672.9596224226563;15078.773818392732;15113.471028514059;15774.921125394414;15798.526044218577;15803.209839508094;14183.858161418357;14961;15068.924655376763;15127.168005759679;15207.239638018054;12182.086343524272;12220;12257.632271031884;12338.568150114792;12348.38258087101;3789.5073640426845;3795.411711184771;3863.265979463893;3863.3625451800417;3868.3423817951016;66113;66330.3366966329;67875.9999999995;68061;68083;10532.15742740579;10799.244052916221;10946.124310055176;10997.450127493594;11018.50416731249;20827.687584686242;20901.477463063544;20936.057877395553;21003.159873604884;21476.677849832264;8158.143394943446;8298.21166989135;8378.41351105429;8447.070822209675;8520.062793092755;4605.700629459075;4643.303504474288;4678.742669153229;4750.192467280571;4799.856004319876;3477.826108694555;3594.263176048904;3595.227026189382;3599;3701.0932321580844;572.6077636818709;580.5210701171551;582.4583137681911;586.024269591126;591.9023361145449;779.7777633374461;781.8358144789544;791.5369508837395;810.6190090657382;820.3601191070974;9752.21982241419;9788.951055244679;9818.410895346302;9903.25725570585;9950.502474876228;708.6954148200714;713.6717110129399;737.6385571070138;765.4182821056038;821.7146247404307;4788.490872655859;4892.437369702529;4907.60739140875;4989.750512474435;5000.424951130666;80932.59533702294;82626;84696.57651711826;85192.57403712942;87914.56042719874;42468.78765606152;53957;73860.63069684617;75835.24164758282;78089.609551953;44250.55749442529;46484.5351546487;58040.70979645075;59165.112523312186;66163;9974.650887218913;10299.031531419016;10587.523561439908;10622.468876556295;10663.57345706194;33972.1506962318;39130.21739565136;43707.9073023177;44712.552874470835;45089.323660144466;40085;59417;59709;60545.0918236218;61010.389896100474;13015.47938082504;13069.607911762663;13240.271785051915;13319.733605328032;13324.533641322507;14417.351219194952;14613.707725845636;14702.926485367505;14839.10965342083;15117.395304187708;14048.719025619635;14092.295385230902;14144.858551414765;14202.502912398017;14325.140491570539;13530.729385412433;13538;13613.455461781417;13779.242141682304;14317.928410357881;13648.522301719393;13859.099158554662;13996.510122146083;14262.786058209344;14346.49787257441;10955.945220273848;11048.281861678965;11090.889091108986;11221.943890280496;11225.550977961117;11562.826557601811;11735.882641173821;11914.344711040629;11922.940385298018;12012 13:58:39 INFO - PROCESS | 11082 | __end_tp_report 13:58:39 INFO - PROCESS | 11082 | __start_cc_report 13:58:39 INFO - PROCESS | 11082 | _x_x_mozilla_cycle_collect,1247 13:58:39 INFO - PROCESS | 11082 | __end_cc_report 13:58:39 INFO - PROCESS | 11082 | __startTimestamp1485813519717__endTimestamp 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | ------- Summary: start ------- 13:58:39 INFO - PROCESS | 11082 | Number of tests: 6 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#0] dojo.html Cycles:165 Average:5529.30 Median:5793.83 stddev:613.76 (10.6%) stddev-sans-first:588.13 13:58:39 INFO - PROCESS | 11082 | Values: 3212.9 3230.9 3233.8 3272.6 3287.6 5542.5 5626.0 5627.0 5627.3 5634.9 5515.7 5562.6 5574.8 5576.4 5590.7 5024.4 5055.3 5087.1 5108.3 5131.4 4955.1 4985.0 5082.9 5114.0 5133.6 4974.1 5020.1 5032.9 5057.1 5078.8 5121.2 5136.2 5191.5 5192.2 5234.4 4862.9 5083.4 5110.4 5148.7 5166.4 5414.1 5415.5 5419.9 5425.9 5476.0 5821.9 5830.2 5911.6 5926.5 5935.8 5889.3 5957.0 5968.9 5982.6 5982.6 5516.8 5555.6 5559.2 5563.1 5583.8 6091.5 6093.1 6097.8 6098.8 6105.1 5687.3 5851.7 5852.1 5852.8 5859.4 5799.2 5837.4 5874.5 5877.5 5952.6 5886.4 5894.4 5894.8 5895.6 5899.9 5848.2 5906.9 5913.0 5920.6 5933.1 4525.7 4560.8 4562.5 4578.9 4584.6 4072.1 4072.4 4090.9 4118.6 4158.9 5583.1 5590.9 5593.1 5593.2 5595.7 5977.4 5978.0 5993.2 5995.8 5998.8 5418.5 5494.6 5575.3 5615.9 5617.5 5203.5 5251.3 5252.4 5252.8 5273.6 6170.8 6179.1 6186.4 6188.3 6192.1 5828.2 5912.0 5950.3 5953.3 6055.9 6128.2 6128.7 6134.5 6134.8 6143.8 5883.5 5886.9 5889.7 5892.6 5922.7 5793.6 5793.8 5886.6 5987.4 6008.5 5755.5 5789.0 5841.7 5865.8 5875.3 5831.9 5833.4 5834.2 5839.5 5842.5 5646.8 5647.2 5813.4 5832.4 5835.0 5813.7 5895.6 5904.7 5939.1 5996.3 5789.2 5804.4 5805.5 5808.9 5818.3 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#1] ext.html Cycles:180 Average:49526.38 Median:192475.00 stddev:81389.82 (42.3%) stddev-sans-first:81535.23 13:58:39 INFO - PROCESS | 11082 | Values: 597.3 610.7 654.5 662.2 675.0 35166.0 45146.5 46470.8 46579.8 46615.3 47853.5 48172.5 48517.8 48566.5 48655.0 8471.1 8836.1 8968.0 8971.6 8980.7 8711.6 10699.5 10951.7 10964.2 11236.2 10719.7 10761.8 10763.4 10763.8 10767.0 11051.6 11082.2 11082.9 11115.6 11125.2 10883.3 10946.6 10946.7 10959.7 10980.7 44689.3 44915.3 44987.3 45034.3 45066.5 3613.9 3760.4 3904.6 3929.8 4351.3 32877.2 33547.8 33729.5 35520.5 35704.3 4195.2 4292.6 4374.5 4392.4 4461.1 344096.0 344875.0 345398.0 347869.0 349784.0 66279.0 66794.7 66806.3 66843.3 66876.0 35894.8 36662.1 36790.8 36794.8 69916.7 16598.0 16790.3 16792.0 16802.2 16810.2 11707.6 11965.6 12307.6 12646.6 12764.9 20254.2 20684.7 20922.6 20928.0 20947.0 7564.3 7690.0 7774.9 7802.2 7815.6 981.0 1050.4 1060.0 1096.4 1153.5 32723.7 34066.0 34169.8 34247.7 34311.5 1124.4 1177.1 1214.7 1226.4 1244.9 15351.8 16298.5 17585.3 17701.0 18254.4 320398.0 322404.0 323167.0 324071.0 324198.0 56001.0 56283.7 56391.4 56464.2 56491.4 1292.1 1336.7 1371.5 1425.8 1432.0 30578.0 31895.0 32279.4 33010.3 33252.0 48293.3 48864.8 48931.8 49120.3 49196.5 256235.0 259458.0 261048.1 261364.0 262416.0 25529.9 26081.2 27966.3 28923.1 29528.4 45038.1 45252.5 45492.8 45592.8 45614.3 38118.2 38207.0 38888.0 39163.4 39810.0 38171.2 39019.8 39130.2 39388.2 40083.6 39348.8 39844.2 42775.8 43306.0 43664.1 36290.3 39201.8 39457.6 39464.0 40043.4 29570.0 29737.3 29738.6 30153.2 30164.2 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#2] jquery.html Cycles:180 Average:28119.56 Median:2736.77 stddev:74615.85 (2726.4%) stddev-sans-first:74796.16 13:58:39 INFO - PROCESS | 11082 | Values: 412.2 412.8 418.9 424.9 428.9 18808.7 20145.9 20462.9 20637.3 20739.8 19786.2 19962.1 20096.4 20609.3 20789.8 5810.5 6101.6 6101.9 6102.4 6105.0 5792.6 5960.7 5974.7 6083.2 6084.5 5970.1 5972.8 5974.0 5974.3 5975.5 5627.7 5887.5 5909.6 5955.2 5963.7 5824.3 5825.4 5827.8 5839.6 5846.4 13346.5 13455.3 13609.8 13725.2 13733.2 2517.6 2532.0 2941.6 2965.8 3148.6 10814.9 10992.7 11098.3 12210.7 15683.6 1909.9 1990.6 2016.5 2026.2 2055.1 79650.6 82455.6 83017.6 85329.6 88102.0 11021.2 11557.3 11691.1 11962.5 12071.6 17000.5 17052.1 17083.3 17092.0 17099.9 7978.2 8051.3 8073.0 8188.8 8225.1 7445.8 7469.2 7614.2 7665.6 7688.1 4566.1 4806.6 5096.6 5161.3 5284.9 2038.5 2103.9 2117.4 2133.0 2139.6 891.3 969.5 998.9 1024.3 1026.1 20398.8 20711.7 20818.6 20883.0 21038.4 990.2 1022.7 1027.1 1055.5 1055.6 10747.8 11662.8 11695.3 11704.6 11707.6 449600.0 449714.0 450850.0 453125.0 454101.0 85771.6 87854.6 88815.0 90762.5 93820.5 993.9 998.9 1007.6 1020.7 1020.8 17263.7 17531.2 18474.4 18480.2 18501.7 41120.2 41624.6 42592.6 42692.8 43774.0 57028.4 57156.4 58053.0 58215.0 59076.0 9082.0 9110.8 9215.9 9358.2 9689.4 11906.3 13808.1 13847.7 14176.4 14507.9 11769.8 12309.4 12460.3 12534.4 12793.9 11976.4 12038.2 12137.2 12410.3 12729.7 12080.5 12431.6 12595.7 12613.2 12935.4 8973.1 8998.5 9396.3 9404.1 9451.0 11906.3 12025.5 12298.8 12308.7 12334.5 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#3] mootools.html Cycles:180 Average:5694.26 Median:2936.84 stddev:3130.68 (106.6%) stddev-sans-first:3122.54 13:58:39 INFO - PROCESS | 11082 | Values: 1362.9 1497.1 1524.2 1661.4 1765.5 7726.3 8240.5 8569.6 8590.7 8823.3 8586.4 8623.7 8630.9 8637.8 8645.0 2434.6 2464.2 2465.3 2466.1 2466.5 2415.9 2513.2 2521.7 2525.1 2527.8 2394.1 2425.7 2475.1 2484.3 2486.9 2372.2 2374.7 2384.0 2401.0 2407.2 2361.1 2391.0 2391.8 2393.6 2394.5 8438.7 8501.5 8644.9 8700.5 8713.8 5400.1 5557.6 5566.4 5568.0 5583.1 3305.1 3415.6 3426.8 3434.6 3472.3 1027.3 1053.1 1067.5 1069.8 1079.6 11617.4 11640.0 11645.0 11653.0 11761.8 4432.4 4690.2 4723.4 4778.2 4811.7 9482.1 9483.5 9494.2 9502.1 9514.0 5496.7 5509.9 5510.2 5511.1 5511.4 4506.7 4591.5 5065.3 5078.2 5137.5 3939.1 3962.3 3969.4 4055.7 4077.8 1241.7 1260.7 1267.5 1280.2 1284.1 883.3 1008.5 1012.4 1022.9 1025.4 5800.4 5837.0 6093.6 6106.8 6169.5 480.0 481.5 487.7 531.4 533.7 3905.5 3963.0 3990.8 4077.0 4109.9 10262.1 10486.6 10592.3 10605.0 10615.1 10278.2 10517.2 10524.9 10530.4 10559.3 7975.6 8141.2 8219.5 8230.9 8233.5 5794.6 5829.6 5863.9 5869.1 6003.6 9572.0 9755.8 9922.7 9930.5 9933.3 9568.9 9814.2 9921.7 9934.0 9979.5 6624.2 6848.8 6994.6 7102.6 7170.8 8043.0 8363.9 8365.9 8377.1 8427.1 7037.3 7213.7 7317.9 7371.3 7397.1 7212.2 7518.3 7550.3 7588.2 7790.4 6999.3 7099.8 7112.4 7114.1 7125.1 5198.1 5340.0 5371.5 5384.5 5539.8 5309.3 5373.7 5402.6 5443.5 5517.5 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#4] prototype.html Cycles:180 Average:4728.69 Median:5282.59 stddev:1363.12 (25.8%) stddev-sans-first:1326.80 13:58:39 INFO - PROCESS | 11082 | Values: 353.8 357.5 359.0 367.6 369.2 5361.0 5424.4 5436.3 5449.7 5452.9 5043.8 5186.3 5225.2 5297.8 5352.4 4231.9 4243.5 4250.1 4259.6 4269.5 4224.6 4240.7 4244.5 4250.3 4260.4 4130.9 4192.1 4224.6 4232.9 4234.6 4153.2 4198.7 4215.7 4227.1 4230.9 3752.5 3771.6 3772.7 3803.6 3806.4 5071.9 5200.0 5249.2 5261.3 5267.3 4851.2 4855.9 4864.0 4874.4 4883.7 5585.5 5586.5 5599.7 5601.7 5620.8 4097.4 4118.2 4150.0 4184.8 4189.1 5783.3 5791.5 5795.5 5808.9 5815.5 4255.2 4267.5 4274.3 4280.8 4281.8 4175.1 4348.4 4366.7 4368.0 4379.2 4827.5 4831.6 4841.8 4858.5 4871.7 5604.9 5606.9 5607.3 5609.3 5612.8 1379.4 1431.2 1441.6 1447.5 1448.7 984.8 999.6 1005.7 1006.2 1015.2 5138.8 5177.3 5185.9 5186.6 5186.7 5491.8 5508.7 5540.3 5582.2 5591.6 5001.5 5172.3 5191.6 5204.4 5220.5 2909.7 2924.5 2934.2 2945.7 2966.6 5565.4 5566.4 5610.3 5631.7 5671.4 5549.5 5625.8 5886.6 5940.9 5946.6 5825.8 5901.6 5912.3 5915.7 5927.3 5599.7 5793.9 5796.4 5805.7 5828.4 5738.6 5768.5 5771.3 5798.7 5810.9 5851.0 5905.9 5917.2 5945.1 5955.6 4008.8 4135.7 4146.3 4152.3 4194.3 5512.2 5635.5 5655.2 5780.0 5820.2 5633.5 5640.3 5647.7 5658.4 5682.7 5549.2 5554.0 5624.5 5637.3 5643.4 5634.0 5636.5 5648.5 5650.6 5667.8 5643.3 5644.4 5663.9 5664.5 5670.8 5416.9 5482.7 5520.3 5531.0 5555.4 13:58:39 INFO - PROCESS | 11082 | 13:58:39 INFO - PROCESS | 11082 | [#5] yui.html Cycles:180 Average:17286.13 Median:44900.94 stddev:21551.91 (48.0%) stddev-sans-first:21576.67 13:58:39 INFO - PROCESS | 11082 | Values: 768.4 800.5 805.5 864.7 895.3 15262.7 16552.0 17126.7 17258.9 17349.7 16483.8 16517.6 16671.1 16802.8 16899.3 859.0 877.1 877.2 877.8 878.3 726.9 761.0 849.0 872.8 878.5 915.4 917.7 919.4 919.8 920.1 902.8 907.0 907.3 913.2 913.5 670.1 671.7 672.5 672.5 673.0 15078.8 15113.5 15774.9 15798.5 15803.2 14183.9 14961.0 15068.9 15127.2 15207.2 12182.1 12220.0 12257.6 12338.6 12348.4 3789.5 3795.4 3863.3 3863.4 3868.3 66113.0 66330.3 67876.0 68061.0 68083.0 10532.2 10799.2 10946.1 10997.5 11018.5 20827.7 20901.5 20936.1 21003.2 21476.7 8158.1 8298.2 8378.4 8447.1 8520.1 4605.7 4643.3 4678.7 4750.2 4799.9 3477.8 3594.3 3595.2 3599.0 3701.1 572.6 580.5 582.5 586.0 591.9 779.8 781.8 791.5 810.6 820.4 9752.2 9789.0 9818.4 9903.3 9950.5 708.7 713.7 737.6 765.4 821.7 4788.5 4892.4 4907.6 4989.8 5000.4 80932.6 82626.0 84696.6 85192.6 87914.6 42468.8 53957.0 73860.6 75835.2 78089.6 44250.6 46484.5 58040.7 59165.1 66163.0 9974.7 10299.0 10587.5 10622.5 10663.6 33972.2 39130.2 43707.9 44712.6 45089.3 40085.0 59417.0 59709.0 60545.1 61010.4 13015.5 13069.6 13240.3 13319.7 13324.5 14417.4 14613.7 14702.9 14839.1 15117.4 14048.7 14092.3 14144.9 14202.5 14325.1 13530.7 13538.0 13613.5 13779.2 14317.9 13648.5 13859.1 13996.5 14262.8 14346.5 10955.9 11048.3 11090.9 11221.9 11225.6 11562.8 11735.9 11914.3 11922.9 12012.0 13:58:39 INFO - PROCESS | 11082 | -------- Summary: end -------- 13:58:39 INFO - PROCESS | 11082 | 13:58:40 INFO - TEST-INFO | 11082: exit 0 13:58:40 INFO - TEST-OK | dromaeo_css | took 1113629ms 13:58:40 INFO - TEST-START | kraken 13:58:40 INFO - operating with platform_type : linux_ 13:58:40 INFO - Initialising browser for kraken test... 13:58:40 INFO - TEST-INFO | started process 11386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TaHMu/profile http://localhost:36470/getInfo.html) 13:58:44 INFO - PROCESS | 11386 | __metrics Screen width/height:1600/1200 13:58:44 INFO - PROCESS | 11386 | colorDepth:24 13:58:44 INFO - PROCESS | 11386 | Browser inner width/height: 1024/697 13:58:44 INFO - PROCESS | 11386 | __metrics 13:58:45 INFO - PROCESS | 11386 | 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" 13:58:45 INFO - PROCESS | 11386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:58:45 INFO - PROCESS | 11386 | console.error: PushService: 13:58:45 INFO - PROCESS | 11386 | stateChangeProcessEnqueue: Error transitioning state 13:58:45 INFO - PROCESS | 11386 | UnknownError 13:58:46 INFO - TEST-INFO | 11386: exit 0 13:58:46 INFO - Browser initialized. 13:58:46 INFO - Running cycle 1/1 for kraken test... 13:58:46 INFO - TEST-INFO | started process 11482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TaHMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:58:58 INFO - PROCESS | 11482 | RSS: Main: 141803520 13:58:58 INFO - PROCESS | 11482 | 13:59:00 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-beat-detection) 13:59:01 INFO - PROCESS | 11482 | RSS: Main: 182697984 13:59:01 INFO - PROCESS | 11482 | 13:59:03 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-dft) 13:59:04 INFO - PROCESS | 11482 | RSS: Main: 173957120 13:59:04 INFO - PROCESS | 11482 | 13:59:07 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-fft) 13:59:07 INFO - PROCESS | 11482 | RSS: Main: 264687616 13:59:07 INFO - PROCESS | 11482 | 13:59:09 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36470/tests/kraken/driver.html?testName=audio-oscillator) 13:59:10 INFO - PROCESS | 11482 | RSS: Main: 171372544 13:59:10 INFO - PROCESS | 11482 | 13:59:12 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:59:13 INFO - PROCESS | 11482 | RSS: Main: 173953024 13:59:13 INFO - PROCESS | 11482 | 13:59:16 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-darkroom) 13:59:16 INFO - PROCESS | 11482 | RSS: Main: 211947520 13:59:16 INFO - PROCESS | 11482 | 13:59:20 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36470/tests/kraken/driver.html?testName=imaging-desaturate) 13:59:20 INFO - PROCESS | 11482 | RSS: Main: 210563072 13:59:20 INFO - PROCESS | 11482 | 13:59:23 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36470/tests/kraken/driver.html?testName=json-parse-financial) 13:59:23 INFO - PROCESS | 11482 | RSS: Main: 209637376 13:59:23 INFO - PROCESS | 11482 | 13:59:25 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:59:26 INFO - PROCESS | 11482 | RSS: Main: 171728896 13:59:26 INFO - PROCESS | 11482 | 13:59:27 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:59:28 INFO - PROCESS | 11482 | RSS: Main: 178728960 13:59:28 INFO - PROCESS | 11482 | 13:59:30 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:59:30 INFO - PROCESS | 11482 | RSS: Main: 187650048 13:59:30 INFO - PROCESS | 11482 | 13:59:33 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:59:34 INFO - PROCESS | 11482 | RSS: Main: 195801088 13:59:34 INFO - PROCESS | 11482 | 13:59:36 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:59:37 INFO - PROCESS | 11482 | RSS: Main: 192602112 13:59:37 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | Cycle 1(1): loaded http://localhost:36470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36470/tests/kraken/driver.html?testName=ai-astar) 13:59:39 INFO - PROCESS | 11482 | RSS: Main: 244273152 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | __start_tp_report 13:59:39 INFO - PROCESS | 11482 | _x_x_mozilla_page_load 13:59:39 INFO - PROCESS | 11482 | _x_x_mozilla_page_load_details 13:59:39 INFO - PROCESS | 11482 | |i|pagename|runs| 13:59:39 INFO - PROCESS | 11482 | |0;ai-astar;102;113;110;111;113;112;112;111;111;112 13:59:39 INFO - PROCESS | 11482 | |1;audio-beat-detection;144;119;116;156;117;123;116;118;149;118 13:59:39 INFO - PROCESS | 11482 | |2;audio-dft;161;161;160;161;160;161;160;161;161;162 13:59:39 INFO - PROCESS | 11482 | |3;audio-fft;74;74;75;104;75;75;75;77;98;75 13:59:39 INFO - PROCESS | 11482 | |4;audio-oscillator;81;82;124;82;82;82;97;82;81;119 13:59:39 INFO - PROCESS | 11482 | |5;imaging-gaussian-blur;117;116;118;117;116;117;116;117;116;116 13:59:39 INFO - PROCESS | 11482 | |6;imaging-darkroom;146;145;147;146;147;145;145;146;147;147 13:59:39 INFO - PROCESS | 11482 | |7;imaging-desaturate;85;85;84;84;85;84;85;84;85;84 13:59:39 INFO - PROCESS | 11482 | |8;json-parse-financial;50;51;49;50;50;55;49;50;49;49 13:59:39 INFO - PROCESS | 11482 | |9;json-stringify-tinderbox;61;60;60;59;60;61;59;60;60;60 13:59:39 INFO - PROCESS | 11482 | |10;stanford-crypto-aes;75;75;74;76;76;79;75;75;75;76 13:59:39 INFO - PROCESS | 11482 | |11;stanford-crypto-ccm;125;122;131;124;121;127;120;135;154;126 13:59:39 INFO - PROCESS | 11482 | |12;stanford-crypto-pbkdf2;160;160;153;158;157;160;156;163;156;158 13:59:39 INFO - PROCESS | 11482 | |13;stanford-crypto-sha256-iterative;63;64;63;63;61;64;63;61;64;61 13:59:39 INFO - PROCESS | 11482 | __end_tp_report 13:59:39 INFO - PROCESS | 11482 | __start_cc_report 13:59:39 INFO - PROCESS | 11482 | _x_x_mozilla_cycle_collect,1573 13:59:39 INFO - PROCESS | 11482 | __end_cc_report 13:59:39 INFO - PROCESS | 11482 | __startTimestamp1485813579301__endTimestamp 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | ------- Summary: start ------- 13:59:39 INFO - PROCESS | 11482 | Number of tests: 14 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.00 13:59:39 INFO - PROCESS | 11482 | Values: 102.0 113.0 110.0 111.0 113.0 112.0 112.0 111.0 111.0 112.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:121.00 stddev:15.61 (12.9%) stddev-sans-first:15.39 13:59:39 INFO - PROCESS | 11482 | Values: 144.0 119.0 116.0 156.0 117.0 123.0 116.0 118.0 149.0 118.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:59:39 INFO - PROCESS | 11482 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 160.0 161.0 161.0 162.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.08 (14.8%) stddev-sans-first:11.53 13:59:39 INFO - PROCESS | 11482 | Values: 74.0 74.0 75.0 104.0 75.0 75.0 75.0 77.0 98.0 75.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:16.71 (20.4%) stddev-sans-first:17.31 13:59:39 INFO - PROCESS | 11482 | Values: 81.0 82.0 124.0 82.0 82.0 82.0 97.0 82.0 81.0 119.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:59:39 INFO - PROCESS | 11482 | Values: 117.0 116.0 118.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 13:59:39 INFO - PROCESS | 11482 | Values: 146.0 145.0 147.0 146.0 147.0 145.0 145.0 146.0 147.0 147.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 13:59:39 INFO - PROCESS | 11482 | Values: 85.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 85.0 84.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.81 (3.6%) stddev-sans-first:1.92 13:59:39 INFO - PROCESS | 11482 | Values: 50.0 51.0 49.0 50.0 50.0 55.0 49.0 50.0 49.0 49.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 13:59:39 INFO - PROCESS | 11482 | Values: 61.0 60.0 60.0 59.0 60.0 61.0 59.0 60.0 60.0 60.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.50 stddev:1.35 (1.8%) stddev-sans-first:1.41 13:59:39 INFO - PROCESS | 11482 | Values: 75.0 75.0 74.0 76.0 76.0 79.0 75.0 75.0 75.0 76.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.50 stddev:10.06 (8.0%) stddev-sans-first:10.59 13:59:39 INFO - PROCESS | 11482 | Values: 125.0 122.0 131.0 124.0 121.0 127.0 120.0 135.0 154.0 126.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:159.00 stddev:2.81 (1.8%) stddev-sans-first:2.89 13:59:39 INFO - PROCESS | 11482 | Values: 160.0 160.0 153.0 158.0 157.0 160.0 156.0 163.0 156.0 158.0 13:59:39 INFO - PROCESS | 11482 | 13:59:39 INFO - PROCESS | 11482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 13:59:39 INFO - PROCESS | 11482 | Values: 63.0 64.0 63.0 63.0 61.0 64.0 63.0 61.0 64.0 61.0 13:59:39 INFO - PROCESS | 11482 | -------- Summary: end -------- 13:59:39 INFO - PROCESS | 11482 | 13:59:40 INFO - TEST-INFO | 11482: exit 0 13:59:40 INFO - TEST-OK | kraken | took 59901ms 13:59:40 INFO - SUITE-END | took 1173s 13:59:40 INFO - Completed test suite (00:19:33) 13:59:40 INFO - javascript benchmark 13:59:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3212.919677008075, 3230.903072907812, 3233.757468189885, 3272.5745653065096, 3287.589051368579, 5542.473465020822, 5625.987322281988, 5626.971865140674, 5627.324721033477, 5634.887302253953, 5515.696636684981, 5562.638428502155, 5574.777008919638, 5576.414476479962, 5590.664560126395, 5024.422191447985, 5055.266986286986, 5087.084324821531, 5108.2593024011685, 5131.409887862887, 4955.058538877602, 4985.0, 5082.872928176788, 5113.974430127862, 5133.614978876581, 4974.10466116099, 5020.0712868119335, 5032.874178145557, 5057.140286151344, 5078.7968481260705, 5121.206213036985, 5136.203888397305, 5191.480851914816, 5192.221166824968, 5234.42421333653, 4862.927056094161, 5083.440821509631, 5110.361204849394, 5148.665336753099, 5166.405863325691, 5414.052540805344, 5415.48552887475, 5419.918701219485, 5425.891482170335, 5476.041692703761, 5821.88356232873, 5830.212921255618, 5911.645301281937, 5926.525877929756, 5935.762569497215, 5889.322727886262, 5957.017092179785, 5968.850778730523, 5982.551308651825, 5982.6410415374785, 5516.7517461714315, 5555.611107222537, 5559.221708960789, 5563.109902415635, 5583.804566840141, 6091.51267898567, 6093.11649810775, 6097.847553811191, 6098.786542470993, 6105.114758360013, 5687.260656114761, 5851.678157701367, 5852.092925596539, 5852.7658893643775, 5859.384764599656, 5799.217105690762, 5837.387074357216, 5874.471297583238, 5877.52979761618, 5952.583319167703, 5886.440788125121, 5894.381089985575, 5894.764209431661, 5895.587308888423, 5899.911501327483, 5848.210491583582, 5906.852328691731, 5912.970435147797, 5920.615160014585, 5933.139694744238, 4525.683202175816, 4560.817567297271, 4562.543745625478, 4578.862634120982, 4584.633229341644, 4072.1041370898356, 4072.3687828386646, 4090.9386359204636, 4118.629323360912, 4158.9376159357635, 5583.0787919992745, 5590.944090559124, 5593.077142271561, 5593.188987596775, 5595.664260144323, 5977.402259773988, 5977.970110149508, 5993.220881285405, 5995.820125396245, 5998.790042348497, 5418.539424148913, 5494.560435165177, 5575.303087114111, 5615.9157612635845, 5617.494425501724, 5203.505666961632, 5251.343582052244, 5252.395974462909, 5252.816151434681, 5273.630845840831, 6170.753169873245, 6179.073139029181, 6186.350433204539, 6188.288346840171, 6192.071189321638, 5828.184054232326, 5912.024515954819, 5950.285965684146, 5953.345132035559, 6055.939440605537, 6128.167033931239, 6128.655903792168, 6134.528431832502, 6134.834601026089, 6143.815685529441, 5883.470487656132, 5886.911696324473, 5889.67606781614, 5892.616979896293, 5922.73347699346, 5793.565482588739, 5793.826185214451, 5886.58793884424, 5987.371326010881, 6008.459238668541, 5755.539556835527, 5789.0, 5841.707914604168, 5865.824025279248, 5875.294964604275, 5831.854203644773, 5833.358330583717, 5834.241548598655, 5839.5036421904615, 5842.474177324061, 5646.802361917313, 5647.237622920853, 5813.418658134153, 5832.416758324133, 5834.970825146017, 5813.709314534341, 5895.616784908967, 5904.734286957183, 5939.07944268639, 5996.340402555803, 5789.2184555086205, 5804.3905389935135, 5805.535557155502, 5808.883822323614, 5818.301803783573], "value": 5488.7603823780455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2951916738247, 610.6885488400916, 654.492768104719, 662.2384258103177, 675.0414411535619, 35166.0, 45146.548534514644, 46470.76764616172, 46579.76710116449, 46615.270778337734, 47853.52146478534, 48172.518274817245, 48517.75741121298, 48566.51433485664, 48655.0, 8471.06818249992, 8836.11638836116, 8968.0, 8971.551422428853, 8980.685676001342, 8711.564421778918, 10699.46502674867, 10951.671449856518, 10964.17768667349, 11236.157288203376, 10719.732006699816, 10761.78476430471, 10763.408012559306, 10763.78472430551, 10767.0, 11051.557937682483, 11082.224244302903, 11082.944585277062, 11115.555377784878, 11125.165612579089, 10883.292585981886, 10946.616868409568, 10946.726331841688, 10959.726006849893, 10980.670579882617, 44689.329660055126, 44915.32627010597, 44987.32519012185, 45034.32448513275, 45066.54933450656, 3613.8735144269826, 3760.3983362661843, 3904.5509766376663, 3929.8231579578987, 4351.28203846365, 32877.17807054819, 33547.83226083854, 33729.49405758915, 35520.467192992124, 35704.28591428157, 4195.244855925932, 4292.635126014261, 4374.4531933508315, 4392.363107349448, 4461.08547747711, 344096.0, 344875.0, 345398.0, 347869.0, 349784.0, 66279.0, 66794.66602666955, 66806.33193668099, 66843.33156668372, 66876.0, 35894.8205258972, 36662.08344791348, 36790.8160459196, 36794.816025919696, 69916.6504167476, 16598.0, 16790.328386864632, 16792.0, 16802.243899024572, 16810.243539040774, 11707.648770536898, 11965.641030769091, 12307.56923507673, 12646.620601381974, 12764.872351276554, 20254.189832406537, 20684.689729654066, 20922.581548368948, 20928.0, 20947.0, 7564.319211271012, 7690.0, 7774.883376749353, 7802.219778022152, 7815.609219539114, 980.9558569864373, 1050.3960222871879, 1059.9930066436916, 1096.369587487198, 1153.5270539079106, 32723.67276327206, 34066.0, 34169.829150854086, 34247.65752342495, 34311.485327720104, 1124.3984468309416, 1177.140687298277, 1214.6963259185204, 1226.3561630144245, 1244.9377531123407, 15351.769723454157, 16298.51104466868, 17585.29658813633, 17701.0, 18254.361097361794, 320398.0, 322404.0, 323167.0, 324071.0, 324198.0, 56001.0, 56283.71858140683, 56391.43608563944, 56464.15303770447, 56491.43508564944, 1292.095533126815, 1336.652470357714, 1371.5473893615283, 1425.7932599772976, 1431.957041288763, 30578.0, 31895.0, 32279.35441291114, 33010.33979320448, 33252.0, 48293.27560086672, 48864.75567622139, 48931.75534122306, 49120.263196051375, 49196.50803491919, 256235.0, 259458.0, 261048.08427873216, 261364.0, 262416.0, 25529.87235063813, 26081.217563473125, 27966.3008424791, 28923.132306030853, 29528.409431811673, 45038.09923801571, 45252.547474524836, 45492.772536137105, 45592.772036139606, 45614.31578526391, 38118.23763524659, 38207.0, 38888.0, 39163.41254881122, 39810.0, 38171.23657526889, 39019.804900975316, 39130.21739565136, 39388.212235755695, 40083.59916400799, 39348.80325598468, 39844.2031159381, 42775.7861210692, 43306.0, 43664.12671746611, 36290.27419451649, 39201.80399097986, 39457.605423945395, 39464.0, 40043.3993490092, 29570.0, 29737.25656858596, 29738.553921691626, 30153.246168845955, 30164.245893851952], "value": 20209.127142044905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.2106166690787, 412.77503760450554, 418.88480667816344, 424.9213895429346, 428.8927768057986, 18808.717869231954, 20145.891975941337, 20462.897685511587, 20637.277695280667, 20739.792602073976, 19786.208551657917, 19962.101705423254, 20096.39710808678, 20609.27867524637, 20789.792102078976, 5810.535157187415, 6101.60339577926, 6101.9389806102035, 6102.389761023906, 6105.0, 5792.623479473842, 5960.672163031031, 5974.6713930733795, 6083.239595050619, 6084.5436592255755, 5970.104484327364, 5972.820815375524, 5973.970130149365, 5974.253218347707, 5975.462208401243, 5627.662340259598, 5887.499562537147, 5909.645421274694, 5955.225820643311, 5963.701814909259, 5824.330202026778, 5825.417458254183, 5827.79602713903, 5839.562032847511, 5846.386129456431, 13346.466141354334, 13455.259960702157, 13609.795853062213, 13725.245111518961, 13733.176009439465, 2517.584598541257, 2531.962020569693, 2941.5734718465915, 2965.8072225305286, 3148.590683211191, 10814.945925270402, 10992.670219893336, 11098.334099953949, 12210.694732631755, 15683.607909802233, 1909.9140538675654, 1990.601879624081, 2016.4555569996166, 2026.2097781865084, 2055.095757866549, 79650.60174699148, 82455.58772206161, 83017.58491207505, 85329.57335213346, 88101.99999999936, 11021.173411994132, 11557.30656160633, 11691.123165762601, 11962.521499140112, 12071.637850864488, 17000.48998530046, 17052.147392630566, 17083.316667333416, 17091.9744815309, 17099.914500427418, 7978.162292959272, 8051.315638170821, 8073.0, 8188.754337369888, 8225.054118776417, 7445.813854653677, 7469.215732348134, 7614.162442131361, 7665.61671916402, 7688.115866675292, 4566.086782643484, 4806.567408933212, 5096.643234973591, 5161.329027226437, 5284.894302113936, 2038.4801875521648, 2103.8527303088636, 2117.385958072173, 2133.0, 2139.6041732279577, 891.3315013739696, 969.4972792172105, 998.9350692205129, 1024.3290644627632, 1026.0611540440414, 20398.79601203969, 20711.689324660143, 20818.58362832735, 20883.0, 21038.368848934555, 990.2474119668959, 1022.6676330192718, 1027.0653705128298, 1055.461714525582, 1055.5672174408455, 10747.78504429907, 11662.825057624143, 11695.298282103102, 11704.648860534198, 11707.648770536727, 449600.0, 449714.0, 450850.0, 453125.0, 454101.0, 85771.57114214514, 87854.56072719596, 88815.0, 90762.54618726864, 93820.53089734507, 993.9006099390148, 998.9200863931013, 1007.6322142417964, 1020.7090979071078, 1020.8417695257247, 17263.741043884602, 17531.21109550048, 18474.353397631017, 18480.168392422103, 18501.72247416263, 41120.177596447305, 41624.58375416207, 42592.5740742601, 42692.786536068365, 43774.0, 57028.42971570231, 57156.42843571511, 58053.0, 58215.0, 59076.0, 9082.0, 9110.817783644157, 9215.907840921773, 9358.204552612831, 9689.418634881647, 11906.34515101643, 13808.102473339603, 13847.653808654864, 14176.362063707364, 14507.854921450651, 11769.764604707687, 12309.384530773605, 12460.314682692177, 12534.435950382072, 12793.872061279268, 11976.401179941142, 12038.217515861441, 12137.150399472306, 12410.317432541297, 12729.681757956125, 12080.45637946277, 12431.62705118848, 12595.748085038065, 12613.180143290656, 12935.417906194056, 8973.147550982647, 8998.50508222028, 9396.342256042011, 9404.106609872051, 9450.952745236506, 11906.345151016778, 12025.518979240733, 12298.815517767061, 12308.692282693004, 12334.50661973511], "value": 9487.239645966685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.9114107583, 1497.0568541818657, 1524.1997951075687, 1661.4434164554873, 1765.4527096600054, 7726.304632583066, 8240.505569665816, 8569.614367353468, 8590.656373745058, 8823.250023747989, 8586.356023298247, 8623.698170564032, 8630.913690863104, 8637.784055398603, 8645.0, 2434.6226334918115, 2464.18681834994, 2465.272744540365, 2466.112199608149, 2466.5436894174545, 2415.927522174338, 2513.195777351248, 2521.6595759572497, 2525.0657256815, 2527.772500474957, 2394.0782798622567, 2425.721042080157, 2475.096589744739, 2484.3416494628937, 2486.8507889526595, 2372.2408829174583, 2374.7387787343378, 2383.9880800595975, 2400.9639855402183, 2407.205622144688, 2361.114582031738, 2391.0316321889663, 2391.7727815857465, 2393.5571919195004, 2394.5450364430703, 8438.662453501853, 8501.532415717133, 8644.913550864474, 8700.477971321741, 8713.825723485495, 5400.054990376708, 5557.5831812613815, 5566.443355664442, 5567.972160139214, 5583.050881350139, 3305.0910999475095, 3415.6072051714123, 3426.8457919393436, 3434.587849458081, 3472.2534655049285, 1027.2655051638114, 1053.1416895230439, 1067.530286673861, 1069.8234791259433, 1079.6005477973201, 11617.361045142514, 11640.010599099087, 11645.0, 11653.009494193004, 11761.764764704743, 4432.423784907941, 4690.202665546865, 4723.362346083303, 4778.211595086841, 4811.663183577186, 9482.051794820463, 9483.47840868745, 9494.240460763122, 9502.144806967406, 9514.0, 5496.697681627469, 5509.862253443696, 5510.201020851954, 5511.063119269734, 5511.366192887789, 4506.729596224237, 4591.517890621503, 5065.265536497187, 5078.162103252922, 5137.460566640524, 3939.0546268895832, 3962.32640451124, 3969.4442778011103, 4055.6552693020835, 4077.8164982575854, 1241.7330273991136, 1260.7226410189744, 1267.5436842736608, 1280.1998750780763, 1284.1460428814921, 883.3419102768479, 1008.495752123938, 1012.3875055591261, 1022.8721409823772, 1025.43601019439, 5800.419958004166, 5837.0, 6093.573449858556, 6106.847328816726, 6169.475594574422, 479.95920346770913, 481.46076394437756, 487.7049385122021, 531.4393315052579, 533.706461446203, 3905.4727611772046, 3963.0, 3990.780507072139, 4076.9796151019054, 4109.938350924738, 10262.127719143808, 10486.63296784624, 10592.311499752492, 10605.045545900906, 10615.097716694167, 10278.17774578047, 10517.158627309796, 10524.894751052545, 10530.36817790935, 10559.313644613076, 7975.5613441261285, 8141.185881411811, 8219.506829590244, 8230.876536851953, 8233.547154906419, 5794.594378393472, 5829.621074630305, 5863.941360586339, 5869.090291004901, 6003.609765365237, 9572.0, 9755.756106097404, 9922.652707155215, 9930.453825039693, 9933.255005874733, 9568.90431095708, 9814.214862810815, 9921.702348929544, 9933.950330248592, 9979.50102494887, 6624.205095388585, 6848.794536163923, 6994.5803251805055, 7102.644867756489, 7170.784876453715, 8042.9597852010365, 8363.916360836558, 8365.916340836757, 8377.078521362768, 8427.0730219677, 7037.296270373126, 7213.71145154209, 7317.890231646423, 7371.336579707852, 7397.149327827368, 7212.170600380813, 7518.28576285252, 7550.282723141293, 7588.241175882588, 7790.415718821225, 6999.300069993164, 7099.82250443743, 7112.395446386908, 7114.14630244374, 7125.07374041392, 5198.116320225495, 5339.973300133474, 5371.4897084776885, 5384.461553844741, 5539.750711218086, 5309.309789727466, 5373.650712703662, 5402.5677945763455, 5443.537299329601, 5517.475839795213], "value": 4545.827816339825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7523733386629, 357.5102110109151, 358.95901884534857, 367.5515870637821, 369.2283128261932, 5360.973195134024, 5424.403315635277, 5436.293281873361, 5449.727513624312, 5452.91820622691, 5043.798248070082, 5186.3257776489, 5225.190095535198, 5297.841064768054, 5352.384475785286, 4231.915361692764, 4243.511996120455, 4250.128723611652, 4259.616634502886, 4269.466316710411, 4224.61978421942, 4240.703150779446, 4244.49066112067, 4250.27745283301, 4260.3822445745345, 4130.896727581804, 4192.119654872466, 4224.598663126998, 4232.936505952398, 4234.597713217239, 4153.210889930933, 4198.685098617585, 4215.66274698025, 4227.070044590216, 4230.873073807776, 3752.5496940367057, 3771.622837716234, 3772.679322257584, 3803.6386543278345, 3806.4290356446477, 5071.931481453705, 5200.0, 5249.186376111708, 5261.316028916216, 5267.341582302212, 4851.151048566522, 4855.854324370274, 4863.975680121612, 4874.439439464436, 4883.658143929926, 5585.525230355424, 5586.486081263448, 5599.6640201587625, 5601.747921343509, 5620.831375058755, 4097.405876147972, 4118.238125946679, 4149.958500414988, 4184.832606695729, 4189.120284740177, 5783.334916484616, 5791.478766910956, 5795.493726295615, 5808.92127172595, 5815.534757219454, 4255.212785634606, 4267.530571637118, 4274.294741367702, 4280.785960701953, 4281.828726850953, 4175.081482073939, 4348.391095294761, 4366.672499562545, 4367.978160109179, 4379.189849877783, 4827.493113223061, 4831.613470922318, 4841.782119804547, 4858.489858564871, 4871.683340582851, 5604.943950560524, 5606.859828504238, 5607.317804658586, 5609.298837645294, 5612.775488980476, 1379.4275375718964, 1431.2128329418779, 1441.5747354530438, 1447.5223176351778, 1448.6740483391363, 984.8128855517429, 999.550202408919, 1005.6731562242154, 1006.2453160129902, 1015.1777060580953, 5138.841686491683, 5177.275181474596, 5185.910958698715, 5186.6369354144845, 5186.688798672017, 5491.807786727445, 5508.724563771795, 5540.252065971123, 5582.18578961839, 5591.6365436246515, 5001.524855138756, 5172.327597412387, 5191.558717508979, 5204.42751297357, 5220.530152286313, 2909.6653884803095, 2924.502834518137, 2934.1930968983274, 2945.6612489563545, 2966.569847372119, 5565.38780734127, 5566.443355664401, 5610.298712660918, 5631.746571404296, 5671.432856714296, 5549.528290095306, 5625.831225063254, 5886.6173698709445, 5940.881182376328, 5946.583739138218, 5825.766969321265, 5901.645901245853, 5912.290525137011, 5915.733791979371, 5927.347991720907, 5599.692016938944, 5793.91309130355, 5796.3916237692365, 5805.680687562056, 5828.358880523054, 5738.626989245686, 5768.480836724715, 5771.2686194142425, 5798.652080875161, 5810.912836307374, 5850.970745146247, 5905.852353691193, 5917.230760001173, 5945.10823376497, 5955.553333500092, 4008.819603117925, 4135.669146468215, 4146.253674338648, 4152.335626299778, 4194.3498757692605, 5512.173174023928, 5635.549156067423, 5655.236543066633, 5780.0, 5820.185174075717, 5633.492985631313, 5640.323161220515, 5647.661140331593, 5658.405867383865, 5682.659040457585, 5549.214766672884, 5554.0, 5624.521915637053, 5637.3235211774845, 5643.419842444122, 5634.0, 5636.491761166241, 5648.548116150616, 5650.63270887391, 5667.773289068556, 5643.266375371176, 5644.407337229532, 5663.85840353978, 5664.518515926193, 5670.773169073191, 5416.918746218888, 5482.725863706719, 5520.337559492887, 5530.972345138249, 5555.444475546853], "value": 4302.3270596621, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.4044865229447, 800.539689678435, 805.5287656720815, 864.7232885476648, 895.3150839607697, 15262.694746105071, 16552.0, 17126.743098853527, 17258.913705431456, 17349.65300693987, 16483.752743708854, 16517.587060323498, 16671.08309043002, 16802.83197168028, 16899.324027038936, 859.025006617489, 877.1272583779116, 877.188600544497, 877.7630039889258, 878.3280790195505, 726.901868247785, 760.9581473018982, 848.9872651910226, 872.8123453457505, 878.4641368765048, 915.4004127296631, 917.7430319510514, 919.3886065766291, 919.797644518205, 920.1442658327752, 902.8465160922659, 906.9591868365907, 907.2605826251583, 913.2283220678516, 913.4610579757941, 670.1355251725269, 671.6943790575276, 672.4821887146869, 672.515788632184, 672.9596224226563, 15078.773818392732, 15113.471028514059, 15774.921125394414, 15798.526044218577, 15803.209839508094, 14183.858161418357, 14961.0, 15068.924655376763, 15127.168005759679, 15207.239638018054, 12182.086343524272, 12220.0, 12257.632271031884, 12338.568150114792, 12348.38258087101, 3789.5073640426845, 3795.411711184771, 3863.265979463893, 3863.3625451800417, 3868.3423817951016, 66113.0, 66330.3366966329, 67875.9999999995, 68061.0, 68083.0, 10532.15742740579, 10799.244052916221, 10946.124310055176, 10997.450127493594, 11018.50416731249, 20827.687584686242, 20901.477463063544, 20936.057877395553, 21003.159873604884, 21476.677849832264, 8158.143394943446, 8298.21166989135, 8378.41351105429, 8447.070822209675, 8520.062793092755, 4605.700629459075, 4643.303504474288, 4678.742669153229, 4750.192467280571, 4799.856004319876, 3477.826108694555, 3594.263176048904, 3595.227026189382, 3599.0, 3701.0932321580844, 572.6077636818709, 580.5210701171551, 582.4583137681911, 586.024269591126, 591.9023361145449, 779.7777633374461, 781.8358144789544, 791.5369508837395, 810.6190090657382, 820.3601191070974, 9752.21982241419, 9788.951055244679, 9818.410895346302, 9903.25725570585, 9950.502474876228, 708.6954148200714, 713.6717110129399, 737.6385571070138, 765.4182821056038, 821.7146247404307, 4788.490872655859, 4892.437369702529, 4907.60739140875, 4989.750512474435, 5000.424951130666, 80932.59533702294, 82626.0, 84696.57651711826, 85192.57403712942, 87914.56042719874, 42468.78765606152, 53957.0, 73860.63069684617, 75835.24164758282, 78089.609551953, 44250.55749442529, 46484.5351546487, 58040.70979645075, 59165.112523312186, 66163.0, 9974.650887218913, 10299.031531419016, 10587.523561439908, 10622.468876556295, 10663.57345706194, 33972.1506962318, 39130.21739565136, 43707.9073023177, 44712.552874470835, 45089.323660144466, 40085.0, 59417.0, 59709.0, 60545.0918236218, 61010.389896100474, 13015.47938082504, 13069.607911762663, 13240.271785051915, 13319.733605328032, 13324.533641322507, 14417.351219194952, 14613.707725845636, 14702.926485367505, 14839.10965342083, 15117.395304187708, 14048.719025619635, 14092.295385230902, 14144.858551414765, 14202.502912398017, 14325.140491570539, 13530.729385412433, 13538.0, 13613.455461781417, 13779.242141682304, 14317.928410357881, 13648.522301719393, 13859.099158554662, 13996.510122146083, 14262.786058209344, 14346.49787257441, 10955.945220273848, 11048.281861678965, 11090.889091108986, 11221.943890280496, 11225.550977961117, 11562.826557601811, 11735.882641173821, 11914.344711040629, 11922.940385298018, 12012.0], "value": 7390.67976361369, "unit": "score"}], "name": "dromaeo_css", "value": 7306.362984231237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 110.0, 111.0, 113.0, 112.0, 112.0, 111.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 116.0, 156.0, 117.0, 123.0, 116.0, 118.0, 149.0, 118.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 104.0, 75.0, 75.0, 75.0, 77.0, 98.0, 75.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 124.0, 82.0, 82.0, 82.0, 97.0, 82.0, 81.0, 119.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 147.0, 145.0, 145.0, 146.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 49.0, 50.0, 50.0, 55.0, 49.0, 50.0, 49.0, 49.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 76.0, 79.0, 75.0, 75.0, 75.0, 76.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 131.0, 124.0, 121.0, 127.0, 120.0, 135.0, 154.0, 126.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 153.0, 158.0, 157.0, 160.0, 156.0, 163.0, 156.0, 158.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 61.0, 64.0, 63.0, 61.0, 64.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1452.8, "alertThreshold": 2.0}]} 13:59:40 INFO - Return code: 0 13:59:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:59:40 INFO - # TBPL SUCCESS # 13:59:40 INFO - Running post-action listener: _resource_record_post_action 13:59:40 INFO - [mozharness: 2017-01-30 21:59:40.638147Z] Finished run-tests step (success) 13:59:40 INFO - Running post-run listener: _resource_record_post_run 13:59:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320073728; Read time: 12; Write time: 178300 13:59:40 INFO - TinderboxPrint: CPU usage
12.9% 13:59:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:59:40 INFO - TinderboxPrint: I/O write bytes / time
320,073,728 / 178,300 13:59:40 INFO - TinderboxPrint: CPU idle
8,250.6 (87.1%) 13:59:40 INFO - TinderboxPrint: CPU user
1,182.9 (12.5%) 13:59:40 INFO - TinderboxPrint: Swap in / out
0 / 0 13:59:40 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101027840; Read time: 0; Write time: 72708 13:59:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219045888; Read time: 12; Write time: 105592 13:59:41 INFO - Running post-run listener: _upload_blobber_files 13:59:41 INFO - Blob upload gear active. 13:59:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:59:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:59:41 INFO - (blobuploader) - INFO - Open directory for files ... 13:59:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:59:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:44 INFO - (blobuploader) - INFO - Done attempting. 13:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:45 INFO - (blobuploader) - INFO - Done attempting. 13:59:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:59:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:59:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:59:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:59:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:59:46 INFO - (blobuploader) - INFO - Done attempting. 13:59:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:59:46 INFO - Return code: 0 13:59:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:59:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:59:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4721bf507cb6c099d000ce9f685a40ab2d24a32d9803690daef10cd3e06243093e3890614a93a63bd55981709e6331d4586ccb3df17ecd658f4f1e7f65f9163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be1ead201bbef5f5a369cb735e2ebc4358c1421c83323a3fbdbcdd394b301874bb72ae645a1ce383387f43aeaac11e37c03e668c49b6c01d76116b6ed76ad67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5ddf1b5b954b5fa1cccb98c761de70b9c5c4d574322a2dd4c6e76e827458d1fae906dbb78e087d9315bbc9d100a4119eb1b592a38e36b6ceb3d251db7b863ef"} 13:59:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:59:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:59:46 INFO - Contents: 13:59:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c4721bf507cb6c099d000ce9f685a40ab2d24a32d9803690daef10cd3e06243093e3890614a93a63bd55981709e6331d4586ccb3df17ecd658f4f1e7f65f9163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be1ead201bbef5f5a369cb735e2ebc4358c1421c83323a3fbdbcdd394b301874bb72ae645a1ce383387f43aeaac11e37c03e668c49b6c01d76116b6ed76ad67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5ddf1b5b954b5fa1cccb98c761de70b9c5c4d574322a2dd4c6e76e827458d1fae906dbb78e087d9315bbc9d100a4119eb1b592a38e36b6ceb3d251db7b863ef"} 13:59:46 INFO - Running post-run listener: copy_logs_to_upload_dir 13:59:46 INFO - Copying logs to upload dir... 13:59:46 INFO - mkdir: /builds/slave/test/build/upload/logs 13:59:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.485508 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-30 13:59:46.215178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:59:46.218454) ========= 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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 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/c4721bf507cb6c099d000ce9f685a40ab2d24a32d9803690daef10cd3e06243093e3890614a93a63bd55981709e6331d4586ccb3df17ecd658f4f1e7f65f9163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be1ead201bbef5f5a369cb735e2ebc4358c1421c83323a3fbdbcdd394b301874bb72ae645a1ce383387f43aeaac11e37c03e668c49b6c01d76116b6ed76ad67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5ddf1b5b954b5fa1cccb98c761de70b9c5c4d574322a2dd4c6e76e827458d1fae906dbb78e087d9315bbc9d100a4119eb1b592a38e36b6ceb3d251db7b863ef"} build_url:https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/EBmIsuDRQIC6BpkroWDTuw/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/c4721bf507cb6c099d000ce9f685a40ab2d24a32d9803690daef10cd3e06243093e3890614a93a63bd55981709e6331d4586ccb3df17ecd658f4f1e7f65f9163", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be1ead201bbef5f5a369cb735e2ebc4358c1421c83323a3fbdbcdd394b301874bb72ae645a1ce383387f43aeaac11e37c03e668c49b6c01d76116b6ed76ad67a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5ddf1b5b954b5fa1cccb98c761de70b9c5c4d574322a2dd4c6e76e827458d1fae906dbb78e087d9315bbc9d100a4119eb1b592a38e36b6ceb3d251db7b863ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:59:46.243811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:59:46.244423) ========= 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=41a7e32711b8e08598a63237000001d6-1485812354.73937-1057586766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:59:46.326263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:59:46.326570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:59:46.326907) ========= ========= Total master_lag: 0.17 =========