builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1484852742.17 results: success (0) buildid: 20170119091728 builduid: d31c299ea7324cf9bb71ce25658afefc revision: 998f11970867282c85b89385a08bc172ce5b02d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.169006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.169544) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.169916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.184689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.185062) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-19 11:05:42-- 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% 224M=0s 2017-01-19 11:05:42 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.327970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.328318) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014434 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.378116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:42.378532) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 998f11970867282c85b89385a08bc172ce5b02d2 --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-aurora --rev 998f11970867282c85b89385a08bc172ce5b02d2 --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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-19 11:05:42,661 truncating revision to first 12 chars 2017-01-19 11:05:42,661 Setting DEBUG logging. 2017-01-19 11:05:42,661 attempt 1/10 2017-01-19 11:05:42,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/998f11970867?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 11:05:43,041 unpacking tar archive at: mozilla-aurora-998f11970867/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691407 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:43.083610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:43.083980) ========= script_repo_revision: 998f11970867282c85b89385a08bc172ce5b02d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:43.084382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:43.084649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 11:05:43.094495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-19 11:05:43.094848) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:43 INFO - MultiFileLogger online at 20170119 11:05:43 in /builds/slave/test 11:05:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:05:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:43 INFO - {'append_to_log': False, 11:05:43 INFO - 'base_work_dir': '/builds/slave/test', 11:05:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:05:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:43 INFO - 'branch': 'Mozilla-Aurora', 11:05:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:43 INFO - 'config_files': ('talos/linux_config.py',), 11:05:43 INFO - 'default_actions': ('clobber', 11:05:43 INFO - 'read-buildbot-config', 11:05:43 INFO - 'download-and-extract', 11:05:43 INFO - 'populate-webroot', 11:05:43 INFO - 'create-virtualenv', 11:05:43 INFO - 'install', 11:05:43 INFO - 'run-tests'), 11:05:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:43 INFO - 'download_minidump_stackwalk': True, 11:05:43 INFO - 'download_symbols': 'ondemand', 11:05:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:43 INFO - 'installer_path': 'installer.exe', 11:05:43 INFO - 'log_level': 'info', 11:05:43 INFO - 'log_name': 'talos', 11:05:43 INFO - 'log_to_console': True, 11:05:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:43 INFO - 'opt_config_files': (), 11:05:43 INFO - 'pip_index': False, 11:05:43 INFO - 'sps_profile': False, 11:05:43 INFO - 'sps_profile_interval': 0, 11:05:43 INFO - 'suite': 'dromaeojs', 11:05:43 INFO - 'system_bits': '32', 11:05:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:43 INFO - 'title': 'talos-linux64-ix-063', 11:05:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:43 INFO - 'use_talos_json': True, 11:05:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:43 INFO - 'work_dir': 'build'} 11:05:43 INFO - [mozharness: 2017-01-19 19:05:43.472266Z] Running clobber step. 11:05:43 INFO - Running pre-action listener: _resource_record_pre_action 11:05:43 INFO - Running main action method: clobber 11:05:43 INFO - rmtree: /builds/slave/test/build 11:05:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:43 INFO - Running post-action listener: _resource_record_post_action 11:05:43 INFO - [mozharness: 2017-01-19 19:05:43.932771Z] Finished clobber step (success) 11:05:43 INFO - [mozharness: 2017-01-19 19:05:43.932872Z] Running read-buildbot-config step. 11:05:43 INFO - Running pre-action listener: _resource_record_pre_action 11:05:43 INFO - Running main action method: read_buildbot_config 11:05:43 INFO - Using buildbot properties: 11:05:43 INFO - { 11:05:43 INFO - "project": "", 11:05:43 INFO - "product": "firefox", 11:05:43 INFO - "script_repo_revision": "production", 11:05:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:05:43 INFO - "repository": "", 11:05:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:05:43 INFO - "buildid": "20170119091728", 11:05:43 INFO - "pgo_build": "True", 11:05:43 INFO - "basedir": "/builds/slave/test", 11:05:43 INFO - "buildnumber": 746, 11:05:43 INFO - "slavename": "talos-linux64-ix-063", 11:05:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:05:43 INFO - "platform": "ubuntu64_hw", 11:05:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:05:43 INFO - "branch": "mozilla-aurora", 11:05:43 INFO - "repo_path": "releases/mozilla-aurora", 11:05:43 INFO - "revision": "998f11970867282c85b89385a08bc172ce5b02d2", 11:05:43 INFO - "stage_platform": "linux64-pgo", 11:05:43 INFO - "builduid": "d31c299ea7324cf9bb71ce25658afefc", 11:05:43 INFO - "slavebuilddir": "test" 11:05:43 INFO - } 11:05:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:05:43 INFO - Running post-action listener: _resource_record_post_action 11:05:43 INFO - [mozharness: 2017-01-19 19:05:43.935300Z] Finished read-buildbot-config step (success) 11:05:43 INFO - [mozharness: 2017-01-19 19:05:43.935390Z] Running download-and-extract step. 11:05:43 INFO - Running pre-action listener: _resource_record_pre_action 11:05:43 INFO - Running main action method: download_and_extract 11:05:43 INFO - mkdir: /builds/slave/test/build/tests 11:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:43 INFO - trying https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:05:44 INFO - Downloaded 1361 bytes. 11:05:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:05:44 INFO - Using the following test package requirements: 11:05:44 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:05:44 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:05:44 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:05:44 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'jsshell-linux-x86_64.zip'], 11:05:44 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:05:44 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:05:44 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:05:44 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:05:44 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:05:44 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:05:44 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:05:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:05:45 INFO - Http code: 200 11:05:45 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 11:05:45 INFO - x-amz-cf-id: fxMGYhMlren15A9NzslbeWARzhMUzUswwA1ZYb8Mx0GmrnEXQVp-Mw== 11:05:45 INFO - x-amz-version-id: saUheN17KbHnbQGtjByLdofg9YEsDasY 11:05:47 INFO - Expected file size: 21949518 11:05:47 INFO - Obtained file size: 21949518 11:05:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:05:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:05:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:05:51 INFO - Fetch https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:05:52 INFO - Http code: 200 11:05:52 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 11:05:52 INFO - x-amz-cf-id: zJ7TNaP__hoK24hXL3FtsyKvPwSV1S1qCJbKdp14Ma0zdx1LVXVxCw== 11:05:52 INFO - x-amz-version-id: saUheN17KbHnbQGtjByLdofg9YEsDasY 11:05:53 INFO - Expected file size: 21949518 11:05:53 INFO - Obtained file size: 21949518 11:05:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:05:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:05:58 INFO - Fetch https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:05:58 INFO - Http code: 200 11:05:58 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 11:05:58 INFO - x-amz-cf-id: bopZwFK5-32j8l6HTNb90v7S5PuR8CFxmLWRgm3eSboSz9l08KPRnw== 11:05:58 INFO - x-amz-version-id: w8CvC_gVENCoPgj1ZtCXDf1ejXjnyTcC 11:06:00 INFO - Expected file size: 14409038 11:06:00 INFO - Obtained file size: 14409038 11:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:00 INFO - trying https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:06:00 INFO - Downloading https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:06:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:06:03 INFO - Downloaded 64190795 bytes. 11:06:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:06:03 INFO - mkdir: /builds/slave/test/properties 11:06:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:03 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:03 INFO - Contents: 11:06:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:06:04 INFO - Running post-action listener: _resource_record_post_action 11:06:04 INFO - Running post-action listener: set_extra_try_arguments 11:06:04 INFO - [mozharness: 2017-01-19 19:06:04.079701Z] Finished download-and-extract step (success) 11:06:04 INFO - [mozharness: 2017-01-19 19:06:04.079966Z] Running populate-webroot step. 11:06:04 INFO - Running pre-action listener: _resource_record_pre_action 11:06:04 INFO - Running main action method: populate_webroot 11:06:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:04 INFO - '--tppagecycles', 11:06:04 INFO - '7'], 11:06:04 INFO - 'tests': ['tsvgm']}}, 11:06:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['damp', 'tps']}, 11:06:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'tests': ['damp', 'tps']}, 11:06:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['dromaeo_dom']}, 11:06:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['basic_compositor_video']}, 11:06:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['a11yr', 11:06:04 INFO - 'ts_paint', 11:06:04 INFO - 'tpaint', 11:06:04 INFO - 'sessionrestore', 11:06:04 INFO - 'sessionrestore_no_auto_restore', 11:06:04 INFO - 'tabpaint']}, 11:06:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['tsvgx', 11:06:04 INFO - 'tsvgr_opacity', 11:06:04 INFO - 'tart', 11:06:04 INFO - 'tscrollx', 11:06:04 INFO - 'cart']}, 11:06:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:04 INFO - 'tsvgr_opacity', 11:06:04 INFO - 'tart', 11:06:04 INFO - 'tscrollx', 11:06:04 INFO - 'cart']}, 11:06:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'talos_options': ['--disable-e10s'], 11:06:04 INFO - 'tests': ['tp5o']}, 11:06:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'tests': ['tp5o']}, 11:06:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'talos_options': ['--disable-e10s', 11:06:04 INFO - '--xperf_path', 11:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:04 INFO - 'tests': ['tp5n']}, 11:06:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:04 INFO - 'talos_options': ['--xperf_path', 11:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:04 INFO - 'tests': ['tp5n']}}, 11:06:04 INFO - 'talos.zip': {'path': '', 11:06:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:04 INFO - Running post-action listener: _resource_record_post_action 11:06:04 INFO - [mozharness: 2017-01-19 19:06:04.095666Z] Finished populate-webroot step (success) 11:06:04 INFO - [mozharness: 2017-01-19 19:06:04.095754Z] Running create-virtualenv step. 11:06:04 INFO - Running pre-action listener: _resource_record_pre_action 11:06:04 INFO - Running main action method: create_virtualenv 11:06:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:04 INFO - Using real prefix '/usr' 11:06:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:06 INFO - Installing pip.................done. 11:06:06 INFO - Return code: 0 11:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:06:06 INFO - Reading from file tmpfile_stdout 11:06:06 INFO - Output received: 11:06:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:06:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:06 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:06:06 INFO - Using env: {'DISPLAY': ':0', 11:06:06 INFO - 'HOME': '/home/cltbld', 11:06:06 INFO - 'LANG': 'en_US.UTF-8', 11:06:06 INFO - 'LANGUAGE': 'en_US:en', 11:06:06 INFO - 'LOGNAME': 'cltbld', 11:06:06 INFO - 'MAIL': '/var/mail/cltbld', 11:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:06 INFO - 'MOZ_NO_REMOTE': '1', 11:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:06 INFO - 'NO_EM_RESTART': '1', 11:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:06 INFO - 'PWD': '/builds/slave/test', 11:06:06 INFO - 'SHELL': '/bin/bash', 11:06:06 INFO - 'SHLVL': '1', 11:06:06 INFO - 'TERM': 'linux', 11:06:06 INFO - 'TMOUT': '86400', 11:06:06 INFO - 'USER': 'cltbld', 11:06:06 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:06 INFO - '_': '/tools/buildbot/bin/python'} 11:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:06:07 INFO - Cleaning up... 11:06:07 INFO - Return code: 0 11:06:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:07 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:06:07 INFO - Using env: {'DISPLAY': ':0', 11:06:07 INFO - 'HOME': '/home/cltbld', 11:06:07 INFO - 'LANG': 'en_US.UTF-8', 11:06:07 INFO - 'LANGUAGE': 'en_US:en', 11:06:07 INFO - 'LOGNAME': 'cltbld', 11:06:07 INFO - 'MAIL': '/var/mail/cltbld', 11:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:07 INFO - 'MOZ_NO_REMOTE': '1', 11:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:07 INFO - 'NO_EM_RESTART': '1', 11:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:07 INFO - 'PWD': '/builds/slave/test', 11:06:07 INFO - 'SHELL': '/bin/bash', 11:06:07 INFO - 'SHLVL': '1', 11:06:07 INFO - 'TERM': 'linux', 11:06:07 INFO - 'TMOUT': '86400', 11:06:07 INFO - 'USER': 'cltbld', 11:06:07 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:07 INFO - '_': '/tools/buildbot/bin/python'} 11:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:07 INFO - Downloading/unpacking psutil>=3.1.1 11:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:09 INFO - Installing collected packages: psutil 11:06:09 INFO - Running setup.py install for psutil 11:06:09 INFO - building 'psutil._psutil_linux' extension 11:06:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:06:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:06:09 INFO - building 'psutil._psutil_posix' extension 11:06:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:06:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:09 INFO - Successfully installed psutil 11:06:09 INFO - Cleaning up... 11:06:09 INFO - Return code: 0 11:06:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:10 INFO - Using env: {'DISPLAY': ':0', 11:06:10 INFO - 'HOME': '/home/cltbld', 11:06:10 INFO - 'LANG': 'en_US.UTF-8', 11:06:10 INFO - 'LANGUAGE': 'en_US:en', 11:06:10 INFO - 'LOGNAME': 'cltbld', 11:06:10 INFO - 'MAIL': '/var/mail/cltbld', 11:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:10 INFO - 'MOZ_NO_REMOTE': '1', 11:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:10 INFO - 'NO_EM_RESTART': '1', 11:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:10 INFO - 'PWD': '/builds/slave/test', 11:06:10 INFO - 'SHELL': '/bin/bash', 11:06:10 INFO - 'SHLVL': '1', 11:06:10 INFO - 'TERM': 'linux', 11:06:10 INFO - 'TMOUT': '86400', 11:06:10 INFO - 'USER': 'cltbld', 11:06:10 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:10 INFO - '_': '/tools/buildbot/bin/python'} 11:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:12 INFO - Installing collected packages: mozsystemmonitor 11:06:12 INFO - Running setup.py install for mozsystemmonitor 11:06:12 INFO - Successfully installed mozsystemmonitor 11:06:12 INFO - Cleaning up... 11:06:12 INFO - Return code: 0 11:06:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:12 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:06:12 INFO - Using env: {'DISPLAY': ':0', 11:06:12 INFO - 'HOME': '/home/cltbld', 11:06:12 INFO - 'LANG': 'en_US.UTF-8', 11:06:12 INFO - 'LANGUAGE': 'en_US:en', 11:06:12 INFO - 'LOGNAME': 'cltbld', 11:06:12 INFO - 'MAIL': '/var/mail/cltbld', 11:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:12 INFO - 'MOZ_NO_REMOTE': '1', 11:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:12 INFO - 'NO_EM_RESTART': '1', 11:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:12 INFO - 'PWD': '/builds/slave/test', 11:06:12 INFO - 'SHELL': '/bin/bash', 11:06:12 INFO - 'SHLVL': '1', 11:06:12 INFO - 'TERM': 'linux', 11:06:12 INFO - 'TMOUT': '86400', 11:06:12 INFO - 'USER': 'cltbld', 11:06:12 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:12 INFO - '_': '/tools/buildbot/bin/python'} 11:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:12 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:14 INFO - warning: no files found matching '*.txt' 11:06:14 INFO - no previously-included directories found matching 'build' 11:06:14 INFO - no previously-included directories found matching 'dist' 11:06:14 INFO - no previously-included directories found matching '.git*' 11:06:14 INFO - Installing collected packages: jsonschema, functools32 11:06:14 INFO - Running setup.py install for functools32 11:06:15 INFO - warning: no files found matching '*.txt' 11:06:15 INFO - no previously-included directories found matching 'build' 11:06:15 INFO - no previously-included directories found matching 'dist' 11:06:15 INFO - no previously-included directories found matching '.git*' 11:06:15 INFO - Successfully installed jsonschema functools32 11:06:15 INFO - Cleaning up... 11:06:15 INFO - Return code: 0 11:06:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:15 INFO - Using env: {'DISPLAY': ':0', 11:06:15 INFO - 'HOME': '/home/cltbld', 11:06:15 INFO - 'LANG': 'en_US.UTF-8', 11:06:15 INFO - 'LANGUAGE': 'en_US:en', 11:06:15 INFO - 'LOGNAME': 'cltbld', 11:06:15 INFO - 'MAIL': '/var/mail/cltbld', 11:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:15 INFO - 'MOZ_NO_REMOTE': '1', 11:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:15 INFO - 'NO_EM_RESTART': '1', 11:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:15 INFO - 'PWD': '/builds/slave/test', 11:06:15 INFO - 'SHELL': '/bin/bash', 11:06:15 INFO - 'SHLVL': '1', 11:06:15 INFO - 'TERM': 'linux', 11:06:15 INFO - 'TMOUT': '86400', 11:06:15 INFO - 'USER': 'cltbld', 11:06:15 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:15 INFO - '_': '/tools/buildbot/bin/python'} 11:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:15 INFO - Cleaning up... 11:06:15 INFO - Return code: 0 11:06:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:15 INFO - Using env: {'DISPLAY': ':0', 11:06:15 INFO - 'HOME': '/home/cltbld', 11:06:15 INFO - 'LANG': 'en_US.UTF-8', 11:06:15 INFO - 'LANGUAGE': 'en_US:en', 11:06:15 INFO - 'LOGNAME': 'cltbld', 11:06:15 INFO - 'MAIL': '/var/mail/cltbld', 11:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:15 INFO - 'MOZ_NO_REMOTE': '1', 11:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:15 INFO - 'NO_EM_RESTART': '1', 11:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:15 INFO - 'PWD': '/builds/slave/test', 11:06:15 INFO - 'SHELL': '/bin/bash', 11:06:15 INFO - 'SHLVL': '1', 11:06:15 INFO - 'TERM': 'linux', 11:06:15 INFO - 'TMOUT': '86400', 11:06:15 INFO - 'USER': 'cltbld', 11:06:15 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:15 INFO - '_': '/tools/buildbot/bin/python'} 11:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:18 INFO - Downloading docopt-0.6.1.tar.gz 11:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:18 INFO - Running setup.py install for blobuploader 11:06:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:18 INFO - Running setup.py install for requests 11:06:18 INFO - Running setup.py install for docopt 11:06:18 INFO - Successfully installed blobuploader requests docopt 11:06:18 INFO - Cleaning up... 11:06:18 INFO - Return code: 0 11:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:18 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:18 INFO - Using env: {'DISPLAY': ':0', 11:06:18 INFO - 'HOME': '/home/cltbld', 11:06:18 INFO - 'LANG': 'en_US.UTF-8', 11:06:18 INFO - 'LANGUAGE': 'en_US:en', 11:06:18 INFO - 'LOGNAME': 'cltbld', 11:06:18 INFO - 'MAIL': '/var/mail/cltbld', 11:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:18 INFO - 'MOZ_NO_REMOTE': '1', 11:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:18 INFO - 'NO_EM_RESTART': '1', 11:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:18 INFO - 'PWD': '/builds/slave/test', 11:06:18 INFO - 'SHELL': '/bin/bash', 11:06:18 INFO - 'SHLVL': '1', 11:06:18 INFO - 'TERM': 'linux', 11:06:18 INFO - 'TMOUT': '86400', 11:06:18 INFO - 'USER': 'cltbld', 11:06:18 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:18 INFO - '_': '/tools/buildbot/bin/python'} 11:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:19 INFO - Running setup.py (path:/tmp/pip-g8sHEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:19 INFO - Running setup.py (path:/tmp/pip-xUUc5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:19 INFO - Running setup.py (path:/tmp/pip-oJvuDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:19 INFO - Running setup.py (path:/tmp/pip-5XrwPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:19 INFO - Running setup.py (path:/tmp/pip-0jYYcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:19 INFO - Running setup.py (path:/tmp/pip-qSSjww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:19 INFO - Running setup.py (path:/tmp/pip-sJQ5Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:19 INFO - Running setup.py (path:/tmp/pip-jPEov0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:19 INFO - Running setup.py (path:/tmp/pip-IGLJ49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:19 INFO - Running setup.py (path:/tmp/pip-dHGKdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:19 INFO - Running setup.py (path:/tmp/pip-NQlARd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:19 INFO - Running setup.py (path:/tmp/pip-cARiqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:20 INFO - Running setup.py (path:/tmp/pip-ZHBlMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:20 INFO - Running setup.py (path:/tmp/pip-T9LtjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:20 INFO - Running setup.py (path:/tmp/pip-66qNLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:20 INFO - Running setup.py (path:/tmp/pip-U_En17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:20 INFO - Running setup.py (path:/tmp/pip-SA8f5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:20 INFO - Running setup.py install for manifestparser 11:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:20 INFO - Running setup.py install for mozcrash 11:06:20 INFO - Running setup.py install for mozdebug 11:06:20 INFO - Running setup.py install for mozdevice 11:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:20 INFO - Running setup.py install for mozfile 11:06:20 INFO - Running setup.py install for mozhttpd 11:06:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozinfo 11:06:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozInstall 11:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozleak 11:06:21 INFO - Running setup.py install for mozlog 11:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for moznetwork 11:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozprocess 11:06:21 INFO - Running setup.py install for mozprofile 11:06:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozrunner 11:06:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:21 INFO - Running setup.py install for mozscreenshot 11:06:21 INFO - Running setup.py install for moztest 11:06:22 INFO - Running setup.py install for mozversion 11:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:22 INFO - Cleaning up... 11:06:22 INFO - Return code: 0 11:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:22 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:22 INFO - Using env: {'DISPLAY': ':0', 11:06:22 INFO - 'HOME': '/home/cltbld', 11:06:22 INFO - 'LANG': 'en_US.UTF-8', 11:06:22 INFO - 'LANGUAGE': 'en_US:en', 11:06:22 INFO - 'LOGNAME': 'cltbld', 11:06:22 INFO - 'MAIL': '/var/mail/cltbld', 11:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:22 INFO - 'MOZ_NO_REMOTE': '1', 11:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:22 INFO - 'NO_EM_RESTART': '1', 11:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:22 INFO - 'PWD': '/builds/slave/test', 11:06:22 INFO - 'SHELL': '/bin/bash', 11:06:22 INFO - 'SHLVL': '1', 11:06:22 INFO - 'TERM': 'linux', 11:06:22 INFO - 'TMOUT': '86400', 11:06:22 INFO - 'USER': 'cltbld', 11:06:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:22 INFO - '_': '/tools/buildbot/bin/python'} 11:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:22 INFO - Running setup.py (path:/tmp/pip-hQsrcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:22 INFO - Running setup.py (path:/tmp/pip-eCTNC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:22 INFO - Running setup.py (path:/tmp/pip-VZMixr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:22 INFO - Running setup.py (path:/tmp/pip-4vq9BT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:22 INFO - Running setup.py (path:/tmp/pip-VWGkPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:22 INFO - Running setup.py (path:/tmp/pip-gLAz08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:22 INFO - Running setup.py (path:/tmp/pip-A7YzRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:22 INFO - Running setup.py (path:/tmp/pip-JM3ABR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:23 INFO - Running setup.py (path:/tmp/pip-18yfij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:23 INFO - Running setup.py (path:/tmp/pip-n9IQov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:23 INFO - Running setup.py (path:/tmp/pip-ceDK8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:23 INFO - Running setup.py (path:/tmp/pip-wDiAu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:23 INFO - Running setup.py (path:/tmp/pip-xHT_K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:23 INFO - Running setup.py (path:/tmp/pip-ufPMUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:23 INFO - Running setup.py (path:/tmp/pip-GKp3Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:23 INFO - Running setup.py (path:/tmp/pip-W_UxJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:23 INFO - Running setup.py (path:/tmp/pip-QklMhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:25 INFO - Downloading blessings-1.6.tar.gz 11:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:25 INFO - Installing collected packages: blessings 11:06:25 INFO - Running setup.py install for blessings 11:06:25 INFO - Successfully installed blessings 11:06:25 INFO - Cleaning up... 11:06:25 INFO - Return code: 0 11:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:26 INFO - Reading from file tmpfile_stdout 11:06:26 INFO - Current package versions: 11:06:26 INFO - argparse == 1.2.1 11:06:26 INFO - blessings == 1.6 11:06:26 INFO - blobuploader == 1.2.4 11:06:26 INFO - docopt == 0.6.1 11:06:26 INFO - functools32 == 3.2.3-2 11:06:26 INFO - jsonschema == 2.5.1 11:06:26 INFO - manifestparser == 1.1 11:06:26 INFO - mozInstall == 1.12 11:06:26 INFO - mozcrash == 1.0 11:06:26 INFO - mozdebug == 0.1 11:06:26 INFO - mozdevice == 0.48 11:06:26 INFO - mozfile == 1.2 11:06:26 INFO - mozhttpd == 0.7 11:06:26 INFO - mozinfo == 0.9 11:06:26 INFO - mozleak == 0.1 11:06:26 INFO - mozlog == 3.4 11:06:26 INFO - moznetwork == 0.27 11:06:26 INFO - mozprocess == 0.23 11:06:26 INFO - mozprofile == 0.28 11:06:26 INFO - mozrunner == 6.13 11:06:26 INFO - mozscreenshot == 0.1 11:06:26 INFO - mozsystemmonitor == 0.3 11:06:26 INFO - moztest == 0.8 11:06:26 INFO - mozversion == 1.4 11:06:26 INFO - psutil == 3.1.1 11:06:26 INFO - requests == 1.2.3 11:06:26 INFO - wsgiref == 0.1.2 11:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:06:26 INFO - Using env: {'DISPLAY': ':0', 11:06:26 INFO - 'HOME': '/home/cltbld', 11:06:26 INFO - 'LANG': 'en_US.UTF-8', 11:06:26 INFO - 'LANGUAGE': 'en_US:en', 11:06:26 INFO - 'LOGNAME': 'cltbld', 11:06:26 INFO - 'MAIL': '/var/mail/cltbld', 11:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:26 INFO - 'MOZ_NO_REMOTE': '1', 11:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:26 INFO - 'NO_EM_RESTART': '1', 11:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:26 INFO - 'PWD': '/builds/slave/test', 11:06:26 INFO - 'SHELL': '/bin/bash', 11:06:26 INFO - 'SHLVL': '1', 11:06:26 INFO - 'TERM': 'linux', 11:06:26 INFO - 'TMOUT': '86400', 11:06:26 INFO - 'USER': 'cltbld', 11:06:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:26 INFO - '_': '/tools/buildbot/bin/python'} 11:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:06:26 INFO - Cleaning up... 11:06:26 INFO - Return code: 0 11:06:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 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 0x7f9d8e396f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef7ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:26 INFO - Using env: {'DISPLAY': ':0', 11:06:26 INFO - 'HOME': '/home/cltbld', 11:06:26 INFO - 'LANG': 'en_US.UTF-8', 11:06:26 INFO - 'LANGUAGE': 'en_US:en', 11:06:26 INFO - 'LOGNAME': 'cltbld', 11:06:26 INFO - 'MAIL': '/var/mail/cltbld', 11:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:26 INFO - 'MOZ_NO_REMOTE': '1', 11:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:26 INFO - 'NO_EM_RESTART': '1', 11:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:26 INFO - 'PWD': '/builds/slave/test', 11:06:26 INFO - 'SHELL': '/bin/bash', 11:06:26 INFO - 'SHLVL': '1', 11:06:26 INFO - 'TERM': 'linux', 11:06:26 INFO - 'TMOUT': '86400', 11:06:26 INFO - 'USER': 'cltbld', 11:06:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:26 INFO - '_': '/tools/buildbot/bin/python'} 11:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:26 INFO - Cleaning up... 11:06:26 INFO - Return code: 0 11:06:26 INFO - Running post-action listener: _resource_record_post_action 11:06:26 INFO - Running post-action listener: _start_resource_monitoring 11:06:26 INFO - Starting resource monitoring. 11:06:26 INFO - [mozharness: 2017-01-19 19:06:26.634653Z] Finished create-virtualenv step (success) 11:06:26 INFO - [mozharness: 2017-01-19 19:06:26.635103Z] Running install step. 11:06:26 INFO - Running pre-action listener: _resource_record_pre_action 11:06:26 INFO - Running main action method: install 11:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:26 INFO - Reading from file tmpfile_stdout 11:06:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:26 INFO - Reading from file tmpfile_stdout 11:06:26 INFO - Output received: 11:06:26 INFO - Usage: mozinstall [options] installer 11:06:26 INFO - Options: 11:06:26 INFO - -h, --help show this help message and exit 11:06:26 INFO - -d DEST, --destination=DEST 11:06:26 INFO - Directory to install application into. [default: 11:06:26 INFO - "/builds/slave/test"] 11:06:26 INFO - --app=APP Application being installed. [default: firefox] 11:06:26 INFO - mkdir: /builds/slave/test/build/application 11:06:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:06:43 INFO - Reading from file tmpfile_stdout 11:06:43 INFO - Output received: 11:06:43 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:43 INFO - Running post-action listener: _resource_record_post_action 11:06:43 INFO - [mozharness: 2017-01-19 19:06:43.447675Z] Finished install step (success) 11:06:43 INFO - [mozharness: 2017-01-19 19:06:43.448010Z] Running run-tests step. 11:06:43 INFO - Running pre-action listener: _resource_record_pre_action 11:06:43 INFO - Running main action method: run_tests 11:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:43 INFO - Python 2.7.3 11:06:43 INFO - Return code: 0 11:06:43 INFO - grabbing minidump binary from tooltool 11:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:43 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 0x1ef4f60>, '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 0x1ef5d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef61d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:06:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:06:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:06:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:43 INFO - Return code: 0 11:06:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:06:43 INFO - Using env: {'DISPLAY': ':0', 11:06:43 INFO - 'HOME': '/home/cltbld', 11:06:43 INFO - 'LANG': 'en_US.UTF-8', 11:06:43 INFO - 'LANGUAGE': 'en_US:en', 11:06:43 INFO - 'LOGNAME': 'cltbld', 11:06:43 INFO - 'MAIL': '/var/mail/cltbld', 11:06:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:43 INFO - 'MOZ_NO_REMOTE': '1', 11:06:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:43 INFO - 'NO_EM_RESTART': '1', 11:06:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:43 INFO - 'PWD': '/builds/slave/test', 11:06:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:43 INFO - 'SHELL': '/bin/bash', 11:06:43 INFO - 'SHLVL': '1', 11:06:43 INFO - 'TERM': 'linux', 11:06:43 INFO - 'TMOUT': '86400', 11:06:43 INFO - 'USER': 'cltbld', 11:06:43 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745', 11:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:43 INFO - '_': '/tools/buildbot/bin/python'} 11:06:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:06:43 INFO - mozversion application_buildid: 20170119091728 11:06:43 INFO - mozversion application_changeset: 998f11970867282c85b89385a08bc172ce5b02d2 11:06:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:06:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:43 INFO - mozversion application_name: Firefox 11:06:43 INFO - mozversion application_remotingname: firefox-dev 11:06:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:06:43 INFO - mozversion application_vendor: Mozilla 11:06:43 INFO - mozversion application_version: 52.0a2 11:06:43 INFO - mozversion platform_buildid: 20170119091728 11:06:43 INFO - mozversion platform_changeset: 998f11970867282c85b89385a08bc172ce5b02d2 11:06:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:06:43 INFO - mozversion platform_version: 52.0a2 11:06:43 INFO - using testdate: 1484852803 11:06:43 INFO - actual date: 1484852803 11:06:43 INFO - starting webserver on 'localhost:48937' 11:06:43 INFO - SUITE-START | Running 2 tests 11:06:43 INFO - TEST-START | dromaeo_css 11:06:43 INFO - operating with platform_type : linux_ 11:06:43 INFO - Initialising browser for dromaeo_css test... 11:06:43 INFO - TEST-INFO | started process 20289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Us4KU/profile http://localhost:48937/getInfo.html) 11:06:47 INFO - PROCESS | 20289 | __metrics Screen width/height:1600/1200 11:06:47 INFO - PROCESS | 20289 | colorDepth:24 11:06:47 INFO - PROCESS | 20289 | Browser inner width/height: 1024/697 11:06:47 INFO - PROCESS | 20289 | __metrics 11:06:48 INFO - PROCESS | 20289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:06:48 INFO - PROCESS | 20289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:49 INFO - PROCESS | 20289 | console.error: PushService: 11:06:49 INFO - PROCESS | 20289 | stateChangeProcessEnqueue: Error transitioning state 11:06:49 INFO - PROCESS | 20289 | UnknownError 11:06:49 INFO - TEST-INFO | 20289: exit 0 11:06:49 INFO - Browser initialized. 11:06:49 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:49 INFO - TEST-INFO | started process 20386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Us4KU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:01 INFO - PROCESS | 20386 | RSS: Main: 143646720 11:07:01 INFO - PROCESS | 20386 | 11:10:02 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48937/tests/dromaeo/cssquery-ext.html) 11:10:04 INFO - PROCESS | 20386 | RSS: Main: 304570368 11:10:04 INFO - PROCESS | 20386 | 11:13:06 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-ext.html (next: http://localhost:48937/tests/dromaeo/cssquery-jquery.html) 11:13:07 INFO - PROCESS | 20386 | RSS: Main: 239738880 11:13:07 INFO - PROCESS | 20386 | 11:16:09 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48937/tests/dromaeo/cssquery-mootools.html) 11:16:09 INFO - PROCESS | 20386 | RSS: Main: 206843904 11:16:09 INFO - PROCESS | 20386 | 11:19:11 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48937/tests/dromaeo/cssquery-prototype.html) 11:19:12 INFO - PROCESS | 20386 | RSS: Main: 215814144 11:19:12 INFO - PROCESS | 20386 | 11:22:15 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48937/tests/dromaeo/cssquery-yui.html) 11:22:15 INFO - PROCESS | 20386 | RSS: Main: 174780416 11:22:15 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | Cycle 1(1): loaded http://localhost:48937/tests/dromaeo/cssquery-yui.html (next: http://localhost:48937/tests/dromaeo/cssquery-dojo.html) 11:25:18 INFO - PROCESS | 20386 | RSS: Main: 266878976 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | __start_tp_report 11:25:18 INFO - PROCESS | 20386 | _x_x_mozilla_page_load 11:25:18 INFO - PROCESS | 20386 | _x_x_mozilla_page_load_details 11:25:18 INFO - PROCESS | 20386 | |i|pagename|runs| 11:25:18 INFO - PROCESS | 20386 | |0;dojo.html;3248.23666438387;3279.852406641701;3300.059483047332;3309.6359400465944;3321.4519604265297;5545.306836645419;5631.436856314366;5632.183333416662;5635.464630860072;5644.435556444353;5558.221848941142;5605.243292155557;5605.579581531381;5611.831645050655;5635.098384258519;5052.772625231855;5070.163423035195;5102.464241254671;5148.150555158413;5148.819791307305;4967.726775027372;4979.352684151056;5144.768485418146;5164.612654050942;5182.248573956793;5009.524095210949;5051.570616497602;5074.340335756365;5075.822346217883;5086.643934924557;5061.670991385548;5098.4136824265315;5109.2591574221715;5121.923171152435;5135.4094279158;5071.492850714936;5144.794208231666;5157.638965272433;5159.22611608258;5188.481151884819;5379.704116273603;5423.837284881421;5455.208994695747;5584.664920104807;5593.552515798767;5904.202932604129;5904.380040095814;5905.4685078343155;5909.497692696126;5918.822435326947;6014.699265036731;6017.338092809788;6018.097285407181;6018.699065046774;6030.185924900126;5512.862178445571;5559.11054231321;5570.3315602128005;5606.187102870102;5615.157726341041;6090.878182436327;6142.04798256271;6159.291681456601;6169.84575385619;6173.567850250529;5953.077273022602;5954.791582294599;5955.196048533393;5961.940380596138;5978;5804.738786754606;5852.209951656472;5911.379305172981;6011.879762404727;6020.69896505173;5941.1088336749835;5954.404559544011;5964.403559644001;5998.9100163496705;6000.879982400327;5903.616264942765;5972.522198224132;5972.790952316648;5974.9402505974385;6000.459958603747;4545.954540454619;4580.061087477059;4635.049814787961;4635.3278774578175;4646.883827904329;4089.2434899543678;4101.876943691694;4129.463169787909;4136.31750761127;4140.544540100586;5682.090865461589;5719.7140142992685;5731.312242530839;5732.111522713986;5751.884962300731;5817.418258174233;5931.851703707442;5972.701364931736;5997.610155339889;6002.129691194752;5637.098064309773;5660.745266462936;5668.914966275509;5673.290838645169;5795.826125216166;5169.948300517022;5173.611979101583;5178.378594568676;5179.896402071938;5186.6369354144845;6186.721597528212;6267.62394256346;6272.341404152498;6281.246250449975;6281.96859015702;5838.153467747068;5917.142014407973;5927.792527261698;5930.406959304035;5982.102684597346;6371.299157092623;6374.58565193261;6378.872422551616;6383.744650213939;6389;5916.585838991229;5922.230110085661;5926.407359264039;5927.347991720993;5943.613665111754;5824.534037276923;5832.504237139721;5931.673757943355;5984.1921340618455;6048.58404521491;5910.290765108214;5915.201447804663;5937.168796368598;5945.672987985702;5946.316173640087;5824.854378640568;5880.117982302689;5883.441073098049;5883.588148829541;5887.293524777054;5694.515966142924;5720.2849643794525;5790.334111577054;5839.678817664899;5856.326522449973;5880.26496687914;5885.823425297248;5897.882042359214;5904.0553511437965;5916.911246331222;5561.5272701820795;5581.860453488695;5612.831615051555;5660.575456840836;5679.261695979661 11:25:18 INFO - PROCESS | 20386 | |1;ext.html;584.7105682687071;609.0772479693264;640.5420124610904;660.3891400454578;675.4360109308727;34092.318153636916;36770.26459470809;36806.26387472252;36871;36967.445488317666;45379.31931021029;46802;46922.53077469224;51097.233541496906;51125.744371278095;8860.20258176764;9017.77455563613;9022.639094436248;9024.097590240988;9037.231835293975;8406;8832.249258812977;8918.152775486318;8926.196642302191;8932.419392739452;8419.873701894476;10478.161747060218;10735.087517560978;10740.462976851166;11017.283876548;10521.684349469528;10619.999999999962;10628.14974802014;10630.30902991303;10734.731631709192;10712.196585256137;10782.946085269601;10789.568417263301;10796.78406431867;10800.45997700112;43978.780106099584;44266.11467770659;44605.77697111526;44608.3308750369;44660.10679786419;3592.389293820057;3707.14735610811;3777.8677746279022;3790.6019867914024;4378.036831896978;32880;32999.50500742491;33076.338473230404;33225.6677433225;33486.832565837016;3959.5050618672667;3978.244133614633;4166.520850102247;4178.8537401191115;4184.309588917825;342817;343485;345462;345999;347427;64013;64275.35724642694;64502.677486612265;64509.67745161244;64518.35481645123;39000.60999390027;39959.80020099881;40130.799346003085;42543.7872810634;42595.787021064694;18680.439586812146;18691.345802897104;18913.14890829916;18939.715904261448;18955.052247387575;14005.089669171472;14161.221132837587;14172.433102675777;14175.362108704927;14199.290035498183;18204;18572;19681.803181968284;20473.692894606593;20733.481662958246;7052.647367631598;7340.743073992385;7360.153582337993;7360.595167265745;7486.401087912954;992.513668302541;1042.671558459083;1050.7898420315967;1055.9524821383056;1082.2317050122826;32231.838840806115;32335.51496727551;32546;32690.509642355384;32716.509252361233;1172.7713095946208;1189.2745425290566;1205.2286536616573;1210.8365370674846;1221.6396163131897;17302.22140003678;17544;17708.557286067953;17806.287748489915;17814;527686;530793;532563;533305;534969;55171;56673.71663141658;60357.698211508665;62250.68874655598;62412;1414.8938829587617;1424.750668632985;1439.4961763382942;1441.4234306277363;1442.8629280218363;31268.843655781577;32967.67032329646;33400.83299583486;33680.83159584186;33982.49026264658;55008.724956374965;55596.16605750998;55642;55662.721686391305;55696.16455753086;353441;353454;354786;355344;355486;30321.848390757907;30331.69668303377;30524;30538.389232214788;30732.385352292382;50150.49849501604;50732.74633626808;51113.744431277606;51253.231201532755;51346.71633209199;41482.1703565921;43178.78410608052;43295.350569742106;44219.115617686824;44676;41904.79047604743;42254.366184506645;42313.57686423096;43491;43946.34080488731;41702.95742606459;45363.77318113388;45945;46518.30222546732;46651;36133.45799813057;38139.23721525609;38815;39073;39239.41140882832;28645.981734475186;28828.42343153167;28844.238535292723;28985.7101428983;29135.85432072826 11:25:18 INFO - PROCESS | 20386 | |2;jquery.html;392.1216475095786;427.63725621799927;430.7092712419117;432.19395826783057;445.2786485892854;16091.356345746171;19935.999999999964;20316.89841550792;20809.895950520244;20902.790972090275;20017;20104.798952010475;20104.798952010475;20125.899370503164;20408.795912040874;5661.377248502661;5781.537477001841;5884.617499862496;5926.851828704273;5931.436513531207;5808.273965754281;5916.26046744157;5919.112133180014;5919.348871624118;5920.88158236835;5643.463870932255;5844.240248767675;5890;5899.528037756991;5907.763689452417;5772.278465191851;5796.101604251347;5806.44838740319;5873.882522349529;5898.8820223595285;5914.704264786744;5966.045432730785;5970.34326224115;5973.850653733648;5975.970120149372;15242.39030438781;23010.76989230103;23248.53502929932;23904.282871513882;24443.87778061116;2291.163725240292;2461.6061430171085;2514.094925826701;2531.6708827852262;2933.5159698649695;10509.387127224383;11012;11096.33421994683;11152.052075573505;11197.384143872085;2003.9799602004084;2031.5733695923873;2038;2054.5479994401358;2065.9380218593315;61712.69143654298;66655.70224621087;67772.32227677759;82993;86355.56822215911;10281.948590257001;10552.630657926935;10608.787824243473;11516.539338426537;11875.168738188244;14268.714625707635;14273.78589321161;14285.142891426547;14314.284285785669;14316.28418579067;8187.836243275101;8485.278751306085;8506.74479765608;8596.8710469343;8659.6103175356;7968.920310796818;8197.672093116209;8366.665333386596;8546.829063418696;8611.224989750952;4934.013197360542;5011.3986321640905;5012.072766538202;5018.24726291052;5173.094708426086;2068.524239424941;2076.6884967255032;2081.250749730096;2083.8853863037375;2184.4975655598982;876.2332958661171;933.477252738455;990.6334656177261;1010.2978429991233;1015.9034891685278;19301.61396772057;20235.898820505805;21183.258585949417;21396;21648.35054948354;999.2206079258191;1027.3271007490107;1038.8337865941412;1061.1669839176209;1074.570171931218;10428.478576071166;11253.718657033476;11269.323840569428;11272.041876440431;11304.830427543593;518456;523694;527891;540528;551770;71513.64243178855;77282;98284;99228;99769.50115249523;1032.442481060219;1067.1836045425257;1078.3314345106085;1107.883672214422;1113.6158025481195;17866.285348586433;18009.729854051937;18069.367572134914;18261.54346141357;18460.26158953627;43975.78012109919;44806.55193448024;45635;45667;45869.54130458653;60933.39066609454;61239;62090.68954655198;62111;62263;8867.423617465101;9171.312151588523;9175.541222938693;9246.398984066014;9341;11569.6529104127;13366.398512066786;13594.728105438033;13611.591652250449;14307.57077287683;7975.1227364988645;11537.711557211136;11797.941010294893;11833.467493962964;12126.393680316125;11044.889551104387;11251.662450126181;11707.473163707824;11895.583654572049;11993.280403175837;10699.465026748787;11624.593139240085;11646.417679116179;11892.940535297268;12356.876431235933;9081;9092;9182.17360437564;9403.294752893424;9439.19766819828;10902.836457453303;11613.76772464563;11648.650540483799;11817.995470385114;12194.329311887932 11:25:18 INFO - PROCESS | 20386 | |3;mootools.html;1519.4454024281138;1525.3745964154696;1693.094194605886;1764.6029643330244;1827.6162005978751;8500.744977650673;9105;9105.908940910589;9114.13415725505;9116.544172791359;7871.134175240719;8137.796555086125;8500.957495212531;8766.211041006309;8949.507777072258;2428.8056955443612;2464.987675061622;2467.2351571012955;2467.3091534370405;2468.160825319391;2463.716672582649;2539.00978618339;2543.211604402641;2551.757583029609;2556.0159338654657;2457.3979375053136;2463.3472129885595;2483.466054798218;2486.6021436570154;2493.800495960319;2392.222527678503;2405.278416475059;2420.3465064432594;2423.9272821815375;2431.878406079689;2392.808575313971;2397.9640305395433;2418.818588605844;2419.9836068851123;2462.729099799021;8633.438826476258;8700.26047785939;8713.825723485495;8789.340799440068;8802.823943521158;5333.306670132897;5460.590455715797;5469.316335458067;5470.835874923719;5473.8357849264185;3554.7867127972145;3554.8578056877695;3607.5670919489567;3623.3477973964677;3634.2368102698465;1135.1940122513026;1155.2664058322941;1185.5909711149638;1189.2210602055668;1194.778965891313;12422.56521021769;12440.626781196579;12492.812607810982;12496;12542.24746515212;4717.231038360615;4880.072786170616;4966.8261610844165;5000.924986125211;5064.645474816801;10349.068583827491;10511.684649460529;10550.103241224428;10555.894441055645;10573.682789516326;5591.07747221712;5592.133219351007;5599.160125981135;5625.324961004624;5630.465105814941;4548.886277843014;4622.168009758208;5040.7731652075745;5088.516590923857;5139.922901156486;3964.5044369453817;4086.3870419436726;4108.301588729923;4136.4415803866095;4193.790310484464;1321.3921596065725;1326.257295914291;1335.8730920562532;1346.4614154338342;1348.9797653035212;980.6518685866557;1002.4636819301785;1039.428314427062;1048.9895101049044;1051.8527406163143;6251.499880009588;6281.685915704196;6308.337624549448;6360.363963603602;6419.646919419477;475.60999980016055;494.75262368815595;497.4105684763567;497.7187888842792;500.3295583917495;3985.601439856049;3999.7400168988925;4009.0779120801794;4016.3373043448087;4050.10897602527;10609.098226650667;10956;11044.889551104547;11051.17116216287;11056.336619802676;10840.241183117107;10853.023227909369;10880.564777408816;10890.564377424973;10907.890921090688;7789.337906277917;8056.436049476481;8102.149274326111;8110.026796784424;8267.421280510427;6091;6170.753169873155;6276.215473065867;6324.17785687876;6412.61524308543;9630.614775409185;9937;9951.900480995097;10005.699829005142;10029.598816047277;9678.41929484205;9826.263030272901;9860.309778315735;9964.601415943282;10018.599256029676;7260.128784545888;7319.926800731924;7472;7643.503172293783;7769.8834517481155;7977.521348719096;8153.470024448392;8167.346612270885;8170.714025009096;8171.387145964195;7362.300581444754;7381.372583330477;7390.3718183952815;7537.6984920604755;7625.123110842324;7184.676689549087;7193.424526037799;7199.208087110518;7229.240929702306;7308.926910731037;6948.33990770876;7062.364387205176;7066.222715501188;7069.081019467436;7069.82325441868;5159.329287192641;5177.508136727005;5193.506616871391;5201.71390573507;5424.294841670558;5162.845114646567;5215.582753379645;5263.763130659053;5318.042752304622;5380.354357477127 11:25:18 INFO - PROCESS | 20386 | |4;prototype.html;328.38264063560507;340.81936573615985;348.01511721827234;350.8333541567754;357.9964200357996;5357.437469065746;5368.865778355543;5387.91918121228;5387.973060134704;5436.374816896058;5134.2286911015735;5187.273781670569;5229.3201883755055;5260.316158899338;5373.140297552392;4221.282381995061;4237.025484138635;4243.745375277478;4247.490301163864;4254.7021708480415;4244.660427165834;4257.489101307848;4260.659147268211;4275.315949448089;4282.464691913511;3936.783476908769;4020.3165461871554;4184.28867092595;4200.663946884242;4262.637675797561;4192.874213773561;4199.706020578561;4203.747775133502;4206.432131662217;4211.515675697304;3761.322961866863;3774.8490060397553;3785.3943369060817;3799.5820459749407;3814.256220037094;5041.79832806691;5203.271541984125;5206.479352064801;5289.312389389354;5326.227696983954;4792.137415265251;4795.520447955211;4822.445418776851;4828.855134345975;4839.588634966032;5513.8145298760555;5519.779208831642;5546.86132846678;5550;5590.832275031756;3882.844686212548;4062.7765472898977;4077.4087757275324;4104.630583247522;4113.424120623115;5766.452187042224;5799.21710569072;5827.125931110325;5834.5915785895;5846.50304724099;4179.2477354076555;4185.874423767292;4203;4216.198922204771;4217.641500472433;4114.7942602870335;4139.482564679415;4149.875503734893;4264.125854199881;4264.957350426518;4729.770259732425;4751.809927602857;4752.5485078917445;4760.690555113976;4763.785629646674;5596.440355964371;5603.8599035023635;5621.297337832771;5644.915326270109;5647.265855438849;1375.2642336350004;1393.2963853254244;1404.3329418526323;1404.7331007108821;1407.7817938219387;925.8889332800666;940.5814412586334;1000.8698869146964;1041.1930753665818;1048.6539441984128;5351.3578370595;5380.892382152335;5393.649412788156;5413.512783849473;5449.182622606561;5597.692126932976;5606.607537472338;5670.886582268414;5672.801451949162;5695.430456954271;5236.842894713089;5376.892462150813;5409.756560954688;5412.83761487156;5455.345358556999;2947.778916581265;2983.4928062229474;2984.716451937106;2991.38465228774;3011.48804703201;5567.860803479945;5763.308402991668;5861.296644402613;5873.295204575478;5882.588218824727;5593.692346920959;5596.888062238814;5607.887842243133;5618.129189975479;5646.745896434671;5777.19119323295;5806.825795226066;5816.447437493432;5848.2689663792025;5854.531637469077;5517.200005999188;5540.141278101901;5820.330661973758;5844.3571207168025;5844.620099693677;5774.509166720708;5780.173555081554;5784.537237021113;5795.39148389413;5805.854853628524;5908.822735317947;6090.132765693905;6094.51243900478;6171.667299658135;6181.752729890754;4151.214977559678;4216.524216524314;4216.71390225984;4221.810018549111;4234.38601402801;5845.678487683218;5854.531637468907;5867.061270196748;5884.264466941632;5919.556033297434;5471.890562188654;5715.942840571541;5723.5691077230695;5807.303123625192;5809.2738407699035;5659.434056594308;5668.688222147822;5679.290088738908;5697.886042279214;5702.743376547983;5430.565554755531;5566.415526369835;5686.332315656296;5741.971290143522;5757.100156948113;5480.534154596745;5660.632058916157;5662.57530685192;5674.396758058745;5682.516986056066;5406.540444062299;5433.510984011458;5434.782608695607;5507.4767897051315;5508.807191748269 11:25:18 INFO - PROCESS | 20386 | |5;yui.html;810.3638643664724;810.5420437452842;831.8710599857022;862.1938487514172;889.5863423508075;16419.58951026225;17004.149792510387;17300.394486193003;17566;17608.383706570272;15691.84308156918;16262.18689065545;16370.508884733446;16384.098874561896;16411.261493232803;736.823162441013;861.6079683743898;883.6951251818112;886.9334799890001;887.3788348156285;758.8027112950645;843.3084870406269;869.3306154261215;870.7126648206076;874.0254616103063;916.3402350307801;917.4816228830723;917.5091326140516;917.921976631987;918.4351623751378;760.9086909570887;907.6142639378238;907.9137481939205;908.1780988205685;908.4730856103478;579.4263678957843;652.4877970792952;668.1114118222752;670.9597424154566;671.3219648155349;14850.25748712571;14868.256587170707;14880.851191488055;14895.404183832634;14899.478518251917;13931.930340348335;14081.859181408157;14251.78622320666;14270.500532481417;14311.141331520143;11982;13067.673308167277;13146;13173.275469849155;13406.597802065953;3778.131029863147;3875.7286989910717;3900.2979463696524;3917.7453465524936;3965.4448377227213;50379.496205037845;50490.747546262035;50653.49346506524;50869.23696144561;63035.68482157651;10862.293950893167;11124.332540047622;11147;11346.546138154381;11365.488553015135;19376.515587110436;19918.60162796736;20226.089825957573;20537.48656283575;20543.794562054187;7949.165337639581;8453.746387608382;8466.915330846736;8482.448640838325;8667.4366166199;4835.419749629997;4864.294677271847;4880.804767809319;4995.175795993693;5006.6495345325475;3542.6988705959766;3636.127329440915;3652.470391793175;3657.3965295725907;3662.52387189669;637.5537124013117;641.9582727122722;652.1522021372197;652.7813182583793;662.0863208771864;653.7679123911038;707.904432901562;765.4297548326532;799.053856627474;814.2712272516065;9391.953040234892;9996.350237234556;10253.692389228336;10603.787924241473;10780.676579702622;667.1827011910468;725.176924191047;732.9131562374425;750.7447467860844;791.9881201781977;4709.128811169944;4732.337472753818;4875.146849301358;4925.40895092584;4951.257311403247;89017.10982890218;91695;93863.48561996038;94459.52770236242;96977.515112424;49662.75168624134;69676;76527;78753;86323;66967.33032669709;68778.65610672014;70998.2900171002;71053;74585.62707186538;10110.848337275094;10539.683809485728;10656.680299591024;11002.229843910849;11069.225154239448;33931;45858;45870.77064614656;48376.54870353895;48418.273725893436;43562.564374355854;46305.768471157426;59819;60564.69717651384;60789.69605152123;12127.878721212675;13018.414171362121;13066;13110.60668179918;14232.644183895485;14744.55766327012;15150.16674082936;15193.544193674208;16017.839821601634;16034;13487.32563371808;13653.522126725517;14128.152310861382;14144.717105658036;14459.13245205291;13309.80035299452;13790.931045344709;14428.495002674856;14445.210750947039;14655.706885862437;13825.30873456303;13900.443982240597;14036.78944815849;14155.64610884736;14174.220417876702;11054.115670746482;11084.944575277072;11232.382218978035;11324.547018119183;11751.76496470083;11318.377489238172;11454.82817757751;11480.311181329147;11733.35466549348;11737.35444550558 11:25:18 INFO - PROCESS | 20386 | __end_tp_report 11:25:18 INFO - PROCESS | 20386 | __start_cc_report 11:25:18 INFO - PROCESS | 20386 | _x_x_mozilla_cycle_collect,1476 11:25:18 INFO - PROCESS | 20386 | __end_cc_report 11:25:18 INFO - PROCESS | 20386 | __startTimestamp1484853918419__endTimestamp 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | ------- Summary: start ------- 11:25:18 INFO - PROCESS | 20386 | Number of tests: 6 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#0] dojo.html Cycles:165 Average:5567.74 Median:5795.83 stddev:625.93 (10.8%) stddev-sans-first:600.82 11:25:18 INFO - PROCESS | 20386 | Values: 3248.2 3279.9 3300.1 3309.6 3321.5 5545.3 5631.4 5632.2 5635.5 5644.4 5558.2 5605.2 5605.6 5611.8 5635.1 5052.8 5070.2 5102.5 5148.2 5148.8 4967.7 4979.4 5144.8 5164.6 5182.2 5009.5 5051.6 5074.3 5075.8 5086.6 5061.7 5098.4 5109.3 5121.9 5135.4 5071.5 5144.8 5157.6 5159.2 5188.5 5379.7 5423.8 5455.2 5584.7 5593.6 5904.2 5904.4 5905.5 5909.5 5918.8 6014.7 6017.3 6018.1 6018.7 6030.2 5512.9 5559.1 5570.3 5606.2 5615.2 6090.9 6142.0 6159.3 6169.8 6173.6 5953.1 5954.8 5955.2 5961.9 5978.0 5804.7 5852.2 5911.4 6011.9 6020.7 5941.1 5954.4 5964.4 5998.9 6000.9 5903.6 5972.5 5972.8 5974.9 6000.5 4546.0 4580.1 4635.0 4635.3 4646.9 4089.2 4101.9 4129.5 4136.3 4140.5 5682.1 5719.7 5731.3 5732.1 5751.9 5817.4 5931.9 5972.7 5997.6 6002.1 5637.1 5660.7 5668.9 5673.3 5795.8 5169.9 5173.6 5178.4 5179.9 5186.6 6186.7 6267.6 6272.3 6281.2 6282.0 5838.2 5917.1 5927.8 5930.4 5982.1 6371.3 6374.6 6378.9 6383.7 6389.0 5916.6 5922.2 5926.4 5927.3 5943.6 5824.5 5832.5 5931.7 5984.2 6048.6 5910.3 5915.2 5937.2 5945.7 5946.3 5824.9 5880.1 5883.4 5883.6 5887.3 5694.5 5720.3 5790.3 5839.7 5856.3 5880.3 5885.8 5897.9 5904.1 5916.9 5561.5 5581.9 5612.8 5660.6 5679.3 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#1] ext.html Cycles:180 Average:58287.77 Median:3742.51 stddev:110866.03 (2962.3%) stddev-sans-first:111092.39 11:25:18 INFO - PROCESS | 20386 | Values: 584.7 609.1 640.5 660.4 675.4 34092.3 36770.3 36806.3 36871.0 36967.4 45379.3 46802.0 46922.5 51097.2 51125.7 8860.2 9017.8 9022.6 9024.1 9037.2 8406.0 8832.2 8918.2 8926.2 8932.4 8419.9 10478.2 10735.1 10740.5 11017.3 10521.7 10620.0 10628.1 10630.3 10734.7 10712.2 10782.9 10789.6 10796.8 10800.5 43978.8 44266.1 44605.8 44608.3 44660.1 3592.4 3707.1 3777.9 3790.6 4378.0 32880.0 32999.5 33076.3 33225.7 33486.8 3959.5 3978.2 4166.5 4178.9 4184.3 342817.0 343485.0 345462.0 345999.0 347427.0 64013.0 64275.4 64502.7 64509.7 64518.4 39000.6 39959.8 40130.8 42543.8 42595.8 18680.4 18691.3 18913.1 18939.7 18955.1 14005.1 14161.2 14172.4 14175.4 14199.3 18204.0 18572.0 19681.8 20473.7 20733.5 7052.6 7340.7 7360.2 7360.6 7486.4 992.5 1042.7 1050.8 1056.0 1082.2 32231.8 32335.5 32546.0 32690.5 32716.5 1172.8 1189.3 1205.2 1210.8 1221.6 17302.2 17544.0 17708.6 17806.3 17814.0 527686.0 530793.0 532563.0 533305.0 534969.0 55171.0 56673.7 60357.7 62250.7 62412.0 1414.9 1424.8 1439.5 1441.4 1442.9 31268.8 32967.7 33400.8 33680.8 33982.5 55008.7 55596.2 55642.0 55662.7 55696.2 353441.0 353454.0 354786.0 355344.0 355486.0 30321.8 30331.7 30524.0 30538.4 30732.4 50150.5 50732.7 51113.7 51253.2 51346.7 41482.2 43178.8 43295.4 44219.1 44676.0 41904.8 42254.4 42313.6 43491.0 43946.3 41703.0 45363.8 45945.0 46518.3 46651.0 36133.5 38139.2 38815.0 39073.0 39239.4 28646.0 28828.4 28844.2 28985.7 29135.9 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#2] jquery.html Cycles:180 Average:30241.40 Median:13452.74 stddev:87484.71 (650.3%) stddev-sans-first:87701.42 11:25:18 INFO - PROCESS | 20386 | Values: 392.1 427.6 430.7 432.2 445.3 16091.4 19936.0 20316.9 20809.9 20902.8 20017.0 20104.8 20104.8 20125.9 20408.8 5661.4 5781.5 5884.6 5926.9 5931.4 5808.3 5916.3 5919.1 5919.3 5920.9 5643.5 5844.2 5890.0 5899.5 5907.8 5772.3 5796.1 5806.4 5873.9 5898.9 5914.7 5966.0 5970.3 5973.9 5976.0 15242.4 23010.8 23248.5 23904.3 24443.9 2291.2 2461.6 2514.1 2531.7 2933.5 10509.4 11012.0 11096.3 11152.1 11197.4 2004.0 2031.6 2038.0 2054.5 2065.9 61712.7 66655.7 67772.3 82993.0 86355.6 10281.9 10552.6 10608.8 11516.5 11875.2 14268.7 14273.8 14285.1 14314.3 14316.3 8187.8 8485.3 8506.7 8596.9 8659.6 7968.9 8197.7 8366.7 8546.8 8611.2 4934.0 5011.4 5012.1 5018.2 5173.1 2068.5 2076.7 2081.3 2083.9 2184.5 876.2 933.5 990.6 1010.3 1015.9 19301.6 20235.9 21183.3 21396.0 21648.4 999.2 1027.3 1038.8 1061.2 1074.6 10428.5 11253.7 11269.3 11272.0 11304.8 518456.0 523694.0 527891.0 540528.0 551770.0 71513.6 77282.0 98284.0 99228.0 99769.5 1032.4 1067.2 1078.3 1107.9 1113.6 17866.3 18009.7 18069.4 18261.5 18460.3 43975.8 44806.6 45635.0 45667.0 45869.5 60933.4 61239.0 62090.7 62111.0 62263.0 8867.4 9171.3 9175.5 9246.4 9341.0 11569.7 13366.4 13594.7 13611.6 14307.6 7975.1 11537.7 11797.9 11833.5 12126.4 11044.9 11251.7 11707.5 11895.6 11993.3 10699.5 11624.6 11646.4 11892.9 12356.9 9081.0 9092.0 9182.2 9403.3 9439.2 10902.8 11613.8 11648.7 11818.0 12194.3 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#3] mootools.html Cycles:180 Average:5827.71 Median:499.02 stddev:3246.82 (650.6%) stddev-sans-first:3239.79 11:25:18 INFO - PROCESS | 20386 | Values: 1519.4 1525.4 1693.1 1764.6 1827.6 8500.7 9105.0 9105.9 9114.1 9116.5 7871.1 8137.8 8501.0 8766.2 8949.5 2428.8 2465.0 2467.2 2467.3 2468.2 2463.7 2539.0 2543.2 2551.8 2556.0 2457.4 2463.3 2483.5 2486.6 2493.8 2392.2 2405.3 2420.3 2423.9 2431.9 2392.8 2398.0 2418.8 2420.0 2462.7 8633.4 8700.3 8713.8 8789.3 8802.8 5333.3 5460.6 5469.3 5470.8 5473.8 3554.8 3554.9 3607.6 3623.3 3634.2 1135.2 1155.3 1185.6 1189.2 1194.8 12422.6 12440.6 12492.8 12496.0 12542.2 4717.2 4880.1 4966.8 5000.9 5064.6 10349.1 10511.7 10550.1 10555.9 10573.7 5591.1 5592.1 5599.2 5625.3 5630.5 4548.9 4622.2 5040.8 5088.5 5139.9 3964.5 4086.4 4108.3 4136.4 4193.8 1321.4 1326.3 1335.9 1346.5 1349.0 980.7 1002.5 1039.4 1049.0 1051.9 6251.5 6281.7 6308.3 6360.4 6419.6 475.6 494.8 497.4 497.7 500.3 3985.6 3999.7 4009.1 4016.3 4050.1 10609.1 10956.0 11044.9 11051.2 11056.3 10840.2 10853.0 10880.6 10890.6 10907.9 7789.3 8056.4 8102.1 8110.0 8267.4 6091.0 6170.8 6276.2 6324.2 6412.6 9630.6 9937.0 9951.9 10005.7 10029.6 9678.4 9826.3 9860.3 9964.6 10018.6 7260.1 7319.9 7472.0 7643.5 7769.9 7977.5 8153.5 8167.3 8170.7 8171.4 7362.3 7381.4 7390.4 7537.7 7625.1 7184.7 7193.4 7199.2 7229.2 7308.9 6948.3 7062.4 7066.2 7069.1 7069.8 5159.3 5177.5 5193.5 5201.7 5424.3 5162.8 5215.6 5263.8 5318.0 5380.4 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#4] prototype.html Cycles:180 Average:4738.63 Median:5390.81 stddev:1382.73 (25.6%) stddev-sans-first:1346.40 11:25:18 INFO - PROCESS | 20386 | Values: 328.4 340.8 348.0 350.8 358.0 5357.4 5368.9 5387.9 5388.0 5436.4 5134.2 5187.3 5229.3 5260.3 5373.1 4221.3 4237.0 4243.7 4247.5 4254.7 4244.7 4257.5 4260.7 4275.3 4282.5 3936.8 4020.3 4184.3 4200.7 4262.6 4192.9 4199.7 4203.7 4206.4 4211.5 3761.3 3774.8 3785.4 3799.6 3814.3 5041.8 5203.3 5206.5 5289.3 5326.2 4792.1 4795.5 4822.4 4828.9 4839.6 5513.8 5519.8 5546.9 5550.0 5590.8 3882.8 4062.8 4077.4 4104.6 4113.4 5766.5 5799.2 5827.1 5834.6 5846.5 4179.2 4185.9 4203.0 4216.2 4217.6 4114.8 4139.5 4149.9 4264.1 4265.0 4729.8 4751.8 4752.5 4760.7 4763.8 5596.4 5603.9 5621.3 5644.9 5647.3 1375.3 1393.3 1404.3 1404.7 1407.8 925.9 940.6 1000.9 1041.2 1048.7 5351.4 5380.9 5393.6 5413.5 5449.2 5597.7 5606.6 5670.9 5672.8 5695.4 5236.8 5376.9 5409.8 5412.8 5455.3 2947.8 2983.5 2984.7 2991.4 3011.5 5567.9 5763.3 5861.3 5873.3 5882.6 5593.7 5596.9 5607.9 5618.1 5646.7 5777.2 5806.8 5816.4 5848.3 5854.5 5517.2 5540.1 5820.3 5844.4 5844.6 5774.5 5780.2 5784.5 5795.4 5805.9 5908.8 6090.1 6094.5 6171.7 6181.8 4151.2 4216.5 4216.7 4221.8 4234.4 5845.7 5854.5 5867.1 5884.3 5919.6 5471.9 5715.9 5723.6 5807.3 5809.3 5659.4 5668.7 5679.3 5697.9 5702.7 5430.6 5566.4 5686.3 5742.0 5757.1 5480.5 5660.6 5662.6 5674.4 5682.5 5406.5 5433.5 5434.8 5507.5 5508.8 11:25:18 INFO - PROCESS | 20386 | 11:25:18 INFO - PROCESS | 20386 | [#5] yui.html Cycles:180 Average:17819.74 Median:45864.39 stddev:22893.36 (49.9%) stddev-sans-first:22921.95 11:25:18 INFO - PROCESS | 20386 | Values: 810.4 810.5 831.9 862.2 889.6 16419.6 17004.1 17300.4 17566.0 17608.4 15691.8 16262.2 16370.5 16384.1 16411.3 736.8 861.6 883.7 886.9 887.4 758.8 843.3 869.3 870.7 874.0 916.3 917.5 917.5 917.9 918.4 760.9 907.6 907.9 908.2 908.5 579.4 652.5 668.1 671.0 671.3 14850.3 14868.3 14880.9 14895.4 14899.5 13931.9 14081.9 14251.8 14270.5 14311.1 11982.0 13067.7 13146.0 13173.3 13406.6 3778.1 3875.7 3900.3 3917.7 3965.4 50379.5 50490.7 50653.5 50869.2 63035.7 10862.3 11124.3 11147.0 11346.5 11365.5 19376.5 19918.6 20226.1 20537.5 20543.8 7949.2 8453.7 8466.9 8482.4 8667.4 4835.4 4864.3 4880.8 4995.2 5006.6 3542.7 3636.1 3652.5 3657.4 3662.5 637.6 642.0 652.2 652.8 662.1 653.8 707.9 765.4 799.1 814.3 9392.0 9996.4 10253.7 10603.8 10780.7 667.2 725.2 732.9 750.7 792.0 4709.1 4732.3 4875.1 4925.4 4951.3 89017.1 91695.0 93863.5 94459.5 96977.5 49662.8 69676.0 76527.0 78753.0 86323.0 66967.3 68778.7 70998.3 71053.0 74585.6 10110.8 10539.7 10656.7 11002.2 11069.2 33931.0 45858.0 45870.8 48376.5 48418.3 43562.6 46305.8 59819.0 60564.7 60789.7 12127.9 13018.4 13066.0 13110.6 14232.6 14744.6 15150.2 15193.5 16017.8 16034.0 13487.3 13653.5 14128.2 14144.7 14459.1 13309.8 13790.9 14428.5 14445.2 14655.7 13825.3 13900.4 14036.8 14155.6 14174.2 11054.1 11084.9 11232.4 11324.5 11751.8 11318.4 11454.8 11480.3 11733.4 11737.4 11:25:18 INFO - PROCESS | 20386 | -------- Summary: end -------- 11:25:18 INFO - PROCESS | 20386 | 11:25:19 INFO - TEST-INFO | 20386: exit 0 11:25:19 INFO - TEST-OK | dromaeo_css | took 1115433ms 11:25:19 INFO - TEST-START | kraken 11:25:19 INFO - operating with platform_type : linux_ 11:25:19 INFO - Initialising browser for kraken test... 11:25:19 INFO - TEST-INFO | started process 20702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdveWai/profile http://localhost:48937/getInfo.html) 11:25:23 INFO - PROCESS | 20702 | __metrics Screen width/height:1600/1200 11:25:23 INFO - PROCESS | 20702 | colorDepth:24 11:25:23 INFO - PROCESS | 20702 | Browser inner width/height: 1024/697 11:25:23 INFO - PROCESS | 20702 | __metrics 11:25:23 INFO - PROCESS | 20702 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:23 INFO - PROCESS | 20702 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:24 INFO - PROCESS | 20702 | console.error: PushService: 11:25:24 INFO - PROCESS | 20702 | stateChangeProcessEnqueue: Error transitioning state 11:25:24 INFO - PROCESS | 20702 | UnknownError 11:25:24 INFO - TEST-INFO | 20702: exit 0 11:25:24 INFO - Browser initialized. 11:25:24 INFO - Running cycle 1/1 for kraken test... 11:25:24 INFO - TEST-INFO | started process 20794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdveWai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:36 INFO - PROCESS | 20794 | RSS: Main: 147542016 11:25:36 INFO - PROCESS | 20794 | 11:25:38 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48937/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:39 INFO - PROCESS | 20794 | RSS: Main: 189140992 11:25:39 INFO - PROCESS | 20794 | 11:25:42 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48937/tests/kraken/driver.html?testName=audio-dft) 11:25:42 INFO - PROCESS | 20794 | RSS: Main: 178765824 11:25:42 INFO - PROCESS | 20794 | 11:25:45 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48937/tests/kraken/driver.html?testName=audio-fft) 11:25:46 INFO - PROCESS | 20794 | RSS: Main: 270323712 11:25:46 INFO - PROCESS | 20794 | 11:25:48 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48937/tests/kraken/driver.html?testName=audio-oscillator) 11:25:49 INFO - PROCESS | 20794 | RSS: Main: 176492544 11:25:49 INFO - PROCESS | 20794 | 11:25:51 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:51 INFO - PROCESS | 20794 | RSS: Main: 178663424 11:25:51 INFO - PROCESS | 20794 | 11:25:54 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48937/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:55 INFO - PROCESS | 20794 | RSS: Main: 217886720 11:25:55 INFO - PROCESS | 20794 | 11:25:58 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48937/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:59 INFO - PROCESS | 20794 | RSS: Main: 216555520 11:25:59 INFO - PROCESS | 20794 | 11:26:01 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48937/tests/kraken/driver.html?testName=json-parse-financial) 11:26:02 INFO - PROCESS | 20794 | RSS: Main: 214986752 11:26:02 INFO - PROCESS | 20794 | 11:26:03 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:04 INFO - PROCESS | 20794 | RSS: Main: 177025024 11:26:04 INFO - PROCESS | 20794 | 11:26:06 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:06 INFO - PROCESS | 20794 | RSS: Main: 184086528 11:26:06 INFO - PROCESS | 20794 | 11:26:08 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:09 INFO - PROCESS | 20794 | RSS: Main: 189935616 11:26:09 INFO - PROCESS | 20794 | 11:26:11 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:12 INFO - PROCESS | 20794 | RSS: Main: 199512064 11:26:12 INFO - PROCESS | 20794 | 11:26:15 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:15 INFO - PROCESS | 20794 | RSS: Main: 195043328 11:26:15 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | Cycle 1(1): loaded http://localhost:48937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48937/tests/kraken/driver.html?testName=ai-astar) 11:26:17 INFO - PROCESS | 20794 | RSS: Main: 246714368 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | __start_tp_report 11:26:17 INFO - PROCESS | 20794 | _x_x_mozilla_page_load 11:26:17 INFO - PROCESS | 20794 | _x_x_mozilla_page_load_details 11:26:17 INFO - PROCESS | 20794 | |i|pagename|runs| 11:26:17 INFO - PROCESS | 20794 | |0;ai-astar;105;113;111;111;111;112;111;111;112;111 11:26:17 INFO - PROCESS | 20794 | |1;audio-beat-detection;141;119;118;163;118;126;124;116;164;123 11:26:17 INFO - PROCESS | 20794 | |2;audio-dft;161;162;161;160;160;162;162;161;162;160 11:26:17 INFO - PROCESS | 20794 | |3;audio-fft;75;75;83;111;76;75;76;77;98;75 11:26:17 INFO - PROCESS | 20794 | |4;audio-oscillator;83;82;112;82;83;82;97;82;82;113 11:26:17 INFO - PROCESS | 20794 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;116;117;117 11:26:17 INFO - PROCESS | 20794 | |6;imaging-darkroom;146;146;146;146;146;145;145;146;146;145 11:26:17 INFO - PROCESS | 20794 | |7;imaging-desaturate;86;84;85;85;84;85;85;85;85;85 11:26:17 INFO - PROCESS | 20794 | |8;json-parse-financial;53;52;53;51;52;52;52;52;50;51 11:26:17 INFO - PROCESS | 20794 | |9;json-stringify-tinderbox;58;59;58;58;59;59;58;58;58;59 11:26:17 INFO - PROCESS | 20794 | |10;stanford-crypto-aes;75;75;75;75;76;79;76;75;80;77 11:26:17 INFO - PROCESS | 20794 | |11;stanford-crypto-ccm;134;132;123;130;125;122;120;119;159;122 11:26:17 INFO - PROCESS | 20794 | |12;stanford-crypto-pbkdf2;162;155;153;157;155;160;158;160;152;156 11:26:17 INFO - PROCESS | 20794 | |13;stanford-crypto-sha256-iterative;62;63;61;62;61;65;68;62;61;62 11:26:17 INFO - PROCESS | 20794 | __end_tp_report 11:26:17 INFO - PROCESS | 20794 | __start_cc_report 11:26:17 INFO - PROCESS | 20794 | _x_x_mozilla_cycle_collect,1553 11:26:17 INFO - PROCESS | 20794 | __end_cc_report 11:26:17 INFO - PROCESS | 20794 | __startTimestamp1484853977715__endTimestamp 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | ------- Summary: start ------- 11:26:17 INFO - PROCESS | 20794 | Number of tests: 14 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.15 (1.9%) stddev-sans-first:0.73 11:26:17 INFO - PROCESS | 20794 | Values: 105.0 113.0 111.0 111.0 111.0 112.0 111.0 111.0 112.0 111.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:125.00 stddev:18.43 (14.7%) stddev-sans-first:19.21 11:26:17 INFO - PROCESS | 20794 | Values: 141.0 119.0 118.0 163.0 118.0 126.0 124.0 116.0 164.0 123.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 11:26:17 INFO - PROCESS | 20794 | Values: 161.0 162.0 161.0 160.0 160.0 162.0 162.0 161.0 162.0 160.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.43 (16.4%) stddev-sans-first:12.92 11:26:17 INFO - PROCESS | 20794 | Values: 75.0 75.0 83.0 111.0 76.0 75.0 76.0 77.0 98.0 75.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:82.00 stddev:12.82 (15.6%) stddev-sans-first:13.36 11:26:17 INFO - PROCESS | 20794 | Values: 83.0 82.0 112.0 82.0 83.0 82.0 97.0 82.0 82.0 113.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:26:17 INFO - PROCESS | 20794 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:26:17 INFO - PROCESS | 20794 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.44 11:26:17 INFO - PROCESS | 20794 | Values: 86.0 84.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.92 (1.8%) stddev-sans-first:0.87 11:26:17 INFO - PROCESS | 20794 | Values: 53.0 52.0 53.0 51.0 52.0 52.0 52.0 52.0 50.0 51.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 11:26:17 INFO - PROCESS | 20794 | Values: 58.0 59.0 58.0 58.0 59.0 59.0 58.0 58.0 58.0 59.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.83 (2.4%) stddev-sans-first:1.88 11:26:17 INFO - PROCESS | 20794 | Values: 75.0 75.0 75.0 75.0 76.0 79.0 76.0 75.0 80.0 77.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.50 stddev:11.85 (9.3%) stddev-sans-first:12.41 11:26:17 INFO - PROCESS | 20794 | Values: 134.0 132.0 123.0 130.0 125.0 122.0 120.0 119.0 159.0 122.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:3.22 (2.0%) stddev-sans-first:2.82 11:26:17 INFO - PROCESS | 20794 | Values: 162.0 155.0 153.0 157.0 155.0 160.0 158.0 160.0 152.0 156.0 11:26:17 INFO - PROCESS | 20794 | 11:26:17 INFO - PROCESS | 20794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.21 (3.6%) stddev-sans-first:2.33 11:26:17 INFO - PROCESS | 20794 | Values: 62.0 63.0 61.0 62.0 61.0 65.0 68.0 62.0 61.0 62.0 11:26:17 INFO - PROCESS | 20794 | -------- Summary: end -------- 11:26:17 INFO - PROCESS | 20794 | 11:26:18 INFO - TEST-INFO | 20794: exit 0 11:26:18 INFO - TEST-OK | kraken | took 59577ms 11:26:18 INFO - SUITE-END | took 1175s 11:26:18 INFO - Completed test suite (00:19:35) 11:26:18 INFO - javascript benchmark 11:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.23666438387, 3279.852406641701, 3300.059483047332, 3309.6359400465944, 3321.4519604265297, 5545.306836645419, 5631.436856314366, 5632.183333416662, 5635.464630860072, 5644.435556444353, 5558.221848941142, 5605.243292155557, 5605.579581531381, 5611.831645050655, 5635.098384258519, 5052.772625231855, 5070.163423035195, 5102.464241254671, 5148.150555158413, 5148.819791307305, 4967.726775027372, 4979.352684151056, 5144.768485418146, 5164.612654050942, 5182.248573956793, 5009.524095210949, 5051.570616497602, 5074.340335756365, 5075.822346217883, 5086.643934924557, 5061.670991385548, 5098.4136824265315, 5109.2591574221715, 5121.923171152435, 5135.4094279158, 5071.492850714936, 5144.794208231666, 5157.638965272433, 5159.22611608258, 5188.481151884819, 5379.704116273603, 5423.837284881421, 5455.208994695747, 5584.664920104807, 5593.552515798767, 5904.202932604129, 5904.380040095814, 5905.4685078343155, 5909.497692696126, 5918.822435326947, 6014.699265036731, 6017.338092809788, 6018.097285407181, 6018.699065046774, 6030.185924900126, 5512.862178445571, 5559.11054231321, 5570.3315602128005, 5606.187102870102, 5615.157726341041, 6090.878182436327, 6142.04798256271, 6159.291681456601, 6169.84575385619, 6173.567850250529, 5953.077273022602, 5954.791582294599, 5955.196048533393, 5961.940380596138, 5978.0, 5804.738786754606, 5852.209951656472, 5911.379305172981, 6011.879762404727, 6020.69896505173, 5941.1088336749835, 5954.404559544011, 5964.403559644001, 5998.9100163496705, 6000.879982400327, 5903.616264942765, 5972.522198224132, 5972.790952316648, 5974.9402505974385, 6000.459958603747, 4545.954540454619, 4580.061087477059, 4635.049814787961, 4635.3278774578175, 4646.883827904329, 4089.2434899543678, 4101.876943691694, 4129.463169787909, 4136.31750761127, 4140.544540100586, 5682.090865461589, 5719.7140142992685, 5731.312242530839, 5732.111522713986, 5751.884962300731, 5817.418258174233, 5931.851703707442, 5972.701364931736, 5997.610155339889, 6002.129691194752, 5637.098064309773, 5660.745266462936, 5668.914966275509, 5673.290838645169, 5795.826125216166, 5169.948300517022, 5173.611979101583, 5178.378594568676, 5179.896402071938, 5186.6369354144845, 6186.721597528212, 6267.62394256346, 6272.341404152498, 6281.246250449975, 6281.96859015702, 5838.153467747068, 5917.142014407973, 5927.792527261698, 5930.406959304035, 5982.102684597346, 6371.299157092623, 6374.58565193261, 6378.872422551616, 6383.744650213939, 6389.0, 5916.585838991229, 5922.230110085661, 5926.407359264039, 5927.347991720993, 5943.613665111754, 5824.534037276923, 5832.504237139721, 5931.673757943355, 5984.1921340618455, 6048.58404521491, 5910.290765108214, 5915.201447804663, 5937.168796368598, 5945.672987985702, 5946.316173640087, 5824.854378640568, 5880.117982302689, 5883.441073098049, 5883.588148829541, 5887.293524777054, 5694.515966142924, 5720.2849643794525, 5790.334111577054, 5839.678817664899, 5856.326522449973, 5880.26496687914, 5885.823425297248, 5897.882042359214, 5904.0553511437965, 5916.911246331222, 5561.5272701820795, 5581.860453488695, 5612.831615051555, 5660.575456840836, 5679.261695979661], "value": 5526.261678794193, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.7105682687071, 609.0772479693264, 640.5420124610904, 660.3891400454578, 675.4360109308727, 34092.318153636916, 36770.26459470809, 36806.26387472252, 36871.0, 36967.445488317666, 45379.31931021029, 46802.0, 46922.53077469224, 51097.233541496906, 51125.744371278095, 8860.20258176764, 9017.77455563613, 9022.639094436248, 9024.097590240988, 9037.231835293975, 8406.0, 8832.249258812977, 8918.152775486318, 8926.196642302191, 8932.419392739452, 8419.873701894476, 10478.161747060218, 10735.087517560978, 10740.462976851166, 11017.283876548, 10521.684349469528, 10619.999999999962, 10628.14974802014, 10630.30902991303, 10734.731631709192, 10712.196585256137, 10782.946085269601, 10789.568417263301, 10796.78406431867, 10800.45997700112, 43978.780106099584, 44266.11467770659, 44605.77697111526, 44608.3308750369, 44660.10679786419, 3592.389293820057, 3707.14735610811, 3777.8677746279022, 3790.6019867914024, 4378.036831896978, 32880.0, 32999.50500742491, 33076.338473230404, 33225.6677433225, 33486.832565837016, 3959.5050618672667, 3978.244133614633, 4166.520850102247, 4178.8537401191115, 4184.309588917825, 342817.0, 343485.0, 345462.0, 345999.0, 347427.0, 64013.0, 64275.35724642694, 64502.677486612265, 64509.67745161244, 64518.35481645123, 39000.60999390027, 39959.80020099881, 40130.799346003085, 42543.7872810634, 42595.787021064694, 18680.439586812146, 18691.345802897104, 18913.14890829916, 18939.715904261448, 18955.052247387575, 14005.089669171472, 14161.221132837587, 14172.433102675777, 14175.362108704927, 14199.290035498183, 18204.0, 18572.0, 19681.803181968284, 20473.692894606593, 20733.481662958246, 7052.647367631598, 7340.743073992385, 7360.153582337993, 7360.595167265745, 7486.401087912954, 992.513668302541, 1042.671558459083, 1050.7898420315967, 1055.9524821383056, 1082.2317050122826, 32231.838840806115, 32335.51496727551, 32546.0, 32690.509642355384, 32716.509252361233, 1172.7713095946208, 1189.2745425290566, 1205.2286536616573, 1210.8365370674846, 1221.6396163131897, 17302.22140003678, 17544.0, 17708.557286067953, 17806.287748489915, 17814.0, 527686.0, 530793.0, 532563.0, 533305.0, 534969.0, 55171.0, 56673.71663141658, 60357.698211508665, 62250.68874655598, 62412.0, 1414.8938829587617, 1424.750668632985, 1439.4961763382942, 1441.4234306277363, 1442.8629280218363, 31268.843655781577, 32967.67032329646, 33400.83299583486, 33680.83159584186, 33982.49026264658, 55008.724956374965, 55596.16605750998, 55642.0, 55662.721686391305, 55696.16455753086, 353441.0, 353454.0, 354786.0, 355344.0, 355486.0, 30321.848390757907, 30331.69668303377, 30524.0, 30538.389232214788, 30732.385352292382, 50150.49849501604, 50732.74633626808, 51113.744431277606, 51253.231201532755, 51346.71633209199, 41482.1703565921, 43178.78410608052, 43295.350569742106, 44219.115617686824, 44676.0, 41904.79047604743, 42254.366184506645, 42313.57686423096, 43491.0, 43946.34080488731, 41702.95742606459, 45363.77318113388, 45945.0, 46518.30222546732, 46651.0, 36133.45799813057, 38139.23721525609, 38815.0, 39073.0, 39239.41140882832, 28645.981734475186, 28828.42343153167, 28844.238535292723, 28985.7101428983, 29135.85432072826], "value": 20739.445881924377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.1216475095786, 427.63725621799927, 430.7092712419117, 432.19395826783057, 445.2786485892854, 16091.356345746171, 19935.999999999964, 20316.89841550792, 20809.895950520244, 20902.790972090275, 20017.0, 20104.798952010475, 20104.798952010475, 20125.899370503164, 20408.795912040874, 5661.377248502661, 5781.537477001841, 5884.617499862496, 5926.851828704273, 5931.436513531207, 5808.273965754281, 5916.26046744157, 5919.112133180014, 5919.348871624118, 5920.88158236835, 5643.463870932255, 5844.240248767675, 5890.0, 5899.528037756991, 5907.763689452417, 5772.278465191851, 5796.101604251347, 5806.44838740319, 5873.882522349529, 5898.8820223595285, 5914.704264786744, 5966.045432730785, 5970.34326224115, 5973.850653733648, 5975.970120149372, 15242.39030438781, 23010.76989230103, 23248.53502929932, 23904.282871513882, 24443.87778061116, 2291.163725240292, 2461.6061430171085, 2514.094925826701, 2531.6708827852262, 2933.5159698649695, 10509.387127224383, 11012.0, 11096.33421994683, 11152.052075573505, 11197.384143872085, 2003.9799602004084, 2031.5733695923873, 2038.0, 2054.5479994401358, 2065.9380218593315, 61712.69143654298, 66655.70224621087, 67772.32227677759, 82993.0, 86355.56822215911, 10281.948590257001, 10552.630657926935, 10608.787824243473, 11516.539338426537, 11875.168738188244, 14268.714625707635, 14273.78589321161, 14285.142891426547, 14314.284285785669, 14316.28418579067, 8187.836243275101, 8485.278751306085, 8506.74479765608, 8596.8710469343, 8659.6103175356, 7968.920310796818, 8197.672093116209, 8366.665333386596, 8546.829063418696, 8611.224989750952, 4934.013197360542, 5011.3986321640905, 5012.072766538202, 5018.24726291052, 5173.094708426086, 2068.524239424941, 2076.6884967255032, 2081.250749730096, 2083.8853863037375, 2184.4975655598982, 876.2332958661171, 933.477252738455, 990.6334656177261, 1010.2978429991233, 1015.9034891685278, 19301.61396772057, 20235.898820505805, 21183.258585949417, 21396.0, 21648.35054948354, 999.2206079258191, 1027.3271007490107, 1038.8337865941412, 1061.1669839176209, 1074.570171931218, 10428.478576071166, 11253.718657033476, 11269.323840569428, 11272.041876440431, 11304.830427543593, 518456.0, 523694.0, 527891.0, 540528.0, 551770.0, 71513.64243178855, 77282.0, 98284.0, 99228.0, 99769.50115249523, 1032.442481060219, 1067.1836045425257, 1078.3314345106085, 1107.883672214422, 1113.6158025481195, 17866.285348586433, 18009.729854051937, 18069.367572134914, 18261.54346141357, 18460.26158953627, 43975.78012109919, 44806.55193448024, 45635.0, 45667.0, 45869.54130458653, 60933.39066609454, 61239.0, 62090.68954655198, 62111.0, 62263.0, 8867.423617465101, 9171.312151588523, 9175.541222938693, 9246.398984066014, 9341.0, 11569.6529104127, 13366.398512066786, 13594.728105438033, 13611.591652250449, 14307.57077287683, 7975.1227364988645, 11537.711557211136, 11797.941010294893, 11833.467493962964, 12126.393680316125, 11044.889551104387, 11251.662450126181, 11707.473163707824, 11895.583654572049, 11993.280403175837, 10699.465026748787, 11624.593139240085, 11646.417679116179, 11892.940535297268, 12356.876431235933, 9081.0, 9092.0, 9182.17360437564, 9403.294752893424, 9439.19766819828, 10902.836457453303, 11613.76772464563, 11648.650540483799, 11817.995470385114, 12194.329311887932], "value": 9483.887328886434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.4454024281138, 1525.3745964154696, 1693.094194605886, 1764.6029643330244, 1827.6162005978751, 8500.744977650673, 9105.0, 9105.908940910589, 9114.13415725505, 9116.544172791359, 7871.134175240719, 8137.796555086125, 8500.957495212531, 8766.211041006309, 8949.507777072258, 2428.8056955443612, 2464.987675061622, 2467.2351571012955, 2467.3091534370405, 2468.160825319391, 2463.716672582649, 2539.00978618339, 2543.211604402641, 2551.757583029609, 2556.0159338654657, 2457.3979375053136, 2463.3472129885595, 2483.466054798218, 2486.6021436570154, 2493.800495960319, 2392.222527678503, 2405.278416475059, 2420.3465064432594, 2423.9272821815375, 2431.878406079689, 2392.808575313971, 2397.9640305395433, 2418.818588605844, 2419.9836068851123, 2462.729099799021, 8633.438826476258, 8700.26047785939, 8713.825723485495, 8789.340799440068, 8802.823943521158, 5333.306670132897, 5460.590455715797, 5469.316335458067, 5470.835874923719, 5473.8357849264185, 3554.7867127972145, 3554.8578056877695, 3607.5670919489567, 3623.3477973964677, 3634.2368102698465, 1135.1940122513026, 1155.2664058322941, 1185.5909711149638, 1189.2210602055668, 1194.778965891313, 12422.56521021769, 12440.626781196579, 12492.812607810982, 12496.0, 12542.24746515212, 4717.231038360615, 4880.072786170616, 4966.8261610844165, 5000.924986125211, 5064.645474816801, 10349.068583827491, 10511.684649460529, 10550.103241224428, 10555.894441055645, 10573.682789516326, 5591.07747221712, 5592.133219351007, 5599.160125981135, 5625.324961004624, 5630.465105814941, 4548.886277843014, 4622.168009758208, 5040.7731652075745, 5088.516590923857, 5139.922901156486, 3964.5044369453817, 4086.3870419436726, 4108.301588729923, 4136.4415803866095, 4193.790310484464, 1321.3921596065725, 1326.257295914291, 1335.8730920562532, 1346.4614154338342, 1348.9797653035212, 980.6518685866557, 1002.4636819301785, 1039.428314427062, 1048.9895101049044, 1051.8527406163143, 6251.499880009588, 6281.685915704196, 6308.337624549448, 6360.363963603602, 6419.646919419477, 475.60999980016055, 494.75262368815595, 497.4105684763567, 497.7187888842792, 500.3295583917495, 3985.601439856049, 3999.7400168988925, 4009.0779120801794, 4016.3373043448087, 4050.10897602527, 10609.098226650667, 10956.0, 11044.889551104547, 11051.17116216287, 11056.336619802676, 10840.241183117107, 10853.023227909369, 10880.564777408816, 10890.564377424973, 10907.890921090688, 7789.337906277917, 8056.436049476481, 8102.149274326111, 8110.026796784424, 8267.421280510427, 6091.0, 6170.753169873155, 6276.215473065867, 6324.17785687876, 6412.61524308543, 9630.614775409185, 9937.0, 9951.900480995097, 10005.699829005142, 10029.598816047277, 9678.41929484205, 9826.263030272901, 9860.309778315735, 9964.601415943282, 10018.599256029676, 7260.128784545888, 7319.926800731924, 7472.0, 7643.503172293783, 7769.8834517481155, 7977.521348719096, 8153.470024448392, 8167.346612270885, 8170.714025009096, 8171.387145964195, 7362.300581444754, 7381.372583330477, 7390.3718183952815, 7537.6984920604755, 7625.123110842324, 7184.676689549087, 7193.424526037799, 7199.208087110518, 7229.240929702306, 7308.926910731037, 6948.33990770876, 7062.364387205176, 7066.222715501188, 7069.081019467436, 7069.82325441868, 5159.329287192641, 5177.508136727005, 5193.506616871391, 5201.71390573507, 5424.294841670558, 5162.845114646567, 5215.582753379645, 5263.763130659053, 5318.042752304622, 5380.354357477127], "value": 4649.432317381258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.38264063560507, 340.81936573615985, 348.01511721827234, 350.8333541567754, 357.9964200357996, 5357.437469065746, 5368.865778355543, 5387.91918121228, 5387.973060134704, 5436.374816896058, 5134.2286911015735, 5187.273781670569, 5229.3201883755055, 5260.316158899338, 5373.140297552392, 4221.282381995061, 4237.025484138635, 4243.745375277478, 4247.490301163864, 4254.7021708480415, 4244.660427165834, 4257.489101307848, 4260.659147268211, 4275.315949448089, 4282.464691913511, 3936.783476908769, 4020.3165461871554, 4184.28867092595, 4200.663946884242, 4262.637675797561, 4192.874213773561, 4199.706020578561, 4203.747775133502, 4206.432131662217, 4211.515675697304, 3761.322961866863, 3774.8490060397553, 3785.3943369060817, 3799.5820459749407, 3814.256220037094, 5041.79832806691, 5203.271541984125, 5206.479352064801, 5289.312389389354, 5326.227696983954, 4792.137415265251, 4795.520447955211, 4822.445418776851, 4828.855134345975, 4839.588634966032, 5513.8145298760555, 5519.779208831642, 5546.86132846678, 5550.0, 5590.832275031756, 3882.844686212548, 4062.7765472898977, 4077.4087757275324, 4104.630583247522, 4113.424120623115, 5766.452187042224, 5799.21710569072, 5827.125931110325, 5834.5915785895, 5846.50304724099, 4179.2477354076555, 4185.874423767292, 4203.0, 4216.198922204771, 4217.641500472433, 4114.7942602870335, 4139.482564679415, 4149.875503734893, 4264.125854199881, 4264.957350426518, 4729.770259732425, 4751.809927602857, 4752.5485078917445, 4760.690555113976, 4763.785629646674, 5596.440355964371, 5603.8599035023635, 5621.297337832771, 5644.915326270109, 5647.265855438849, 1375.2642336350004, 1393.2963853254244, 1404.3329418526323, 1404.7331007108821, 1407.7817938219387, 925.8889332800666, 940.5814412586334, 1000.8698869146964, 1041.1930753665818, 1048.6539441984128, 5351.3578370595, 5380.892382152335, 5393.649412788156, 5413.512783849473, 5449.182622606561, 5597.692126932976, 5606.607537472338, 5670.886582268414, 5672.801451949162, 5695.430456954271, 5236.842894713089, 5376.892462150813, 5409.756560954688, 5412.83761487156, 5455.345358556999, 2947.778916581265, 2983.4928062229474, 2984.716451937106, 2991.38465228774, 3011.48804703201, 5567.860803479945, 5763.308402991668, 5861.296644402613, 5873.295204575478, 5882.588218824727, 5593.692346920959, 5596.888062238814, 5607.887842243133, 5618.129189975479, 5646.745896434671, 5777.19119323295, 5806.825795226066, 5816.447437493432, 5848.2689663792025, 5854.531637469077, 5517.200005999188, 5540.141278101901, 5820.330661973758, 5844.3571207168025, 5844.620099693677, 5774.509166720708, 5780.173555081554, 5784.537237021113, 5795.39148389413, 5805.854853628524, 5908.822735317947, 6090.132765693905, 6094.51243900478, 6171.667299658135, 6181.752729890754, 4151.214977559678, 4216.524216524314, 4216.71390225984, 4221.810018549111, 4234.38601402801, 5845.678487683218, 5854.531637468907, 5867.061270196748, 5884.264466941632, 5919.556033297434, 5471.890562188654, 5715.942840571541, 5723.5691077230695, 5807.303123625192, 5809.2738407699035, 5659.434056594308, 5668.688222147822, 5679.290088738908, 5697.886042279214, 5702.743376547983, 5430.565554755531, 5566.415526369835, 5686.332315656296, 5741.971290143522, 5757.100156948113, 5480.534154596745, 5660.632058916157, 5662.57530685192, 5674.396758058745, 5682.516986056066, 5406.540444062299, 5433.510984011458, 5434.782608695607, 5507.4767897051315, 5508.807191748269], "value": 4300.236653132498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.3638643664724, 810.5420437452842, 831.8710599857022, 862.1938487514172, 889.5863423508075, 16419.58951026225, 17004.149792510387, 17300.394486193003, 17566.0, 17608.383706570272, 15691.84308156918, 16262.18689065545, 16370.508884733446, 16384.098874561896, 16411.261493232803, 736.823162441013, 861.6079683743898, 883.6951251818112, 886.9334799890001, 887.3788348156285, 758.8027112950645, 843.3084870406269, 869.3306154261215, 870.7126648206076, 874.0254616103063, 916.3402350307801, 917.4816228830723, 917.5091326140516, 917.921976631987, 918.4351623751378, 760.9086909570887, 907.6142639378238, 907.9137481939205, 908.1780988205685, 908.4730856103478, 579.4263678957843, 652.4877970792952, 668.1114118222752, 670.9597424154566, 671.3219648155349, 14850.25748712571, 14868.256587170707, 14880.851191488055, 14895.404183832634, 14899.478518251917, 13931.930340348335, 14081.859181408157, 14251.78622320666, 14270.500532481417, 14311.141331520143, 11982.0, 13067.673308167277, 13146.0, 13173.275469849155, 13406.597802065953, 3778.131029863147, 3875.7286989910717, 3900.2979463696524, 3917.7453465524936, 3965.4448377227213, 50379.496205037845, 50490.747546262035, 50653.49346506524, 50869.23696144561, 63035.68482157651, 10862.293950893167, 11124.332540047622, 11147.0, 11346.546138154381, 11365.488553015135, 19376.515587110436, 19918.60162796736, 20226.089825957573, 20537.48656283575, 20543.794562054187, 7949.165337639581, 8453.746387608382, 8466.915330846736, 8482.448640838325, 8667.4366166199, 4835.419749629997, 4864.294677271847, 4880.804767809319, 4995.175795993693, 5006.6495345325475, 3542.6988705959766, 3636.127329440915, 3652.470391793175, 3657.3965295725907, 3662.52387189669, 637.5537124013117, 641.9582727122722, 652.1522021372197, 652.7813182583793, 662.0863208771864, 653.7679123911038, 707.904432901562, 765.4297548326532, 799.053856627474, 814.2712272516065, 9391.953040234892, 9996.350237234556, 10253.692389228336, 10603.787924241473, 10780.676579702622, 667.1827011910468, 725.176924191047, 732.9131562374425, 750.7447467860844, 791.9881201781977, 4709.128811169944, 4732.337472753818, 4875.146849301358, 4925.40895092584, 4951.257311403247, 89017.10982890218, 91695.0, 93863.48561996038, 94459.52770236242, 96977.515112424, 49662.75168624134, 69676.0, 76527.0, 78753.0, 86323.0, 66967.33032669709, 68778.65610672014, 70998.2900171002, 71053.0, 74585.62707186538, 10110.848337275094, 10539.683809485728, 10656.680299591024, 11002.229843910849, 11069.225154239448, 33931.0, 45858.0, 45870.77064614656, 48376.54870353895, 48418.273725893436, 43562.564374355854, 46305.768471157426, 59819.0, 60564.69717651384, 60789.69605152123, 12127.878721212675, 13018.414171362121, 13066.0, 13110.60668179918, 14232.644183895485, 14744.55766327012, 15150.16674082936, 15193.544193674208, 16017.839821601634, 16034.0, 13487.32563371808, 13653.522126725517, 14128.152310861382, 14144.717105658036, 14459.13245205291, 13309.80035299452, 13790.931045344709, 14428.495002674856, 14445.210750947039, 14655.706885862437, 13825.30873456303, 13900.443982240597, 14036.78944815849, 14155.64610884736, 14174.220417876702, 11054.115670746482, 11084.944575277072, 11232.382218978035, 11324.547018119183, 11751.76496470083, 11318.377489238172, 11454.82817757751, 11480.311181329147, 11733.35466549348, 11737.35444550558], "value": 7461.67125025624, "unit": "score"}], "name": "dromaeo_css", "value": 7384.675309679193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 119.0, 118.0, 163.0, 118.0, 126.0, 124.0, 116.0, 164.0, 123.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 111.0, 76.0, 75.0, 76.0, 77.0, 98.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 112.0, 82.0, 83.0, 82.0, 97.0, 82.0, 82.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 52.0, 52.0, 52.0, 52.0, 50.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 76.0, 79.0, 76.0, 75.0, 80.0, 77.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 123.0, 130.0, 125.0, 122.0, 120.0, 119.0, 159.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 155.0, 153.0, 157.0, 155.0, 160.0, 158.0, 160.0, 152.0, 156.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 61.0, 65.0, 68.0, 62.0, 61.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1457.0999999999997, "alertThreshold": 2.0}]} 11:26:18 INFO - Return code: 0 11:26:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:19 INFO - # TBPL SUCCESS # 11:26:19 INFO - Running post-action listener: _resource_record_post_action 11:26:19 INFO - [mozharness: 2017-01-19 19:26:19.042651Z] Finished run-tests step (success) 11:26:19 INFO - Running post-run listener: _resource_record_post_run 11:26:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357416960; Read time: 28; Write time: 198000 11:26:19 INFO - TinderboxPrint: CPU usage
13.0% 11:26:19 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 11:26:19 INFO - TinderboxPrint: I/O write bytes / time
357,416,960 / 198,000 11:26:19 INFO - TinderboxPrint: CPU idle
8,279.4 (87.0%) 11:26:19 INFO - TinderboxPrint: CPU user
1,190.0 (12.5%) 11:26:19 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108261376; Read time: 0; Write time: 73424 11:26:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249155584; Read time: 28; Write time: 124576 11:26:19 INFO - Running post-run listener: _upload_blobber_files 11:26:19 INFO - Blob upload gear active. 11:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:26:19 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:19 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:20 INFO - (blobuploader) - INFO - Done attempting. 11:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:21 INFO - (blobuploader) - INFO - Done attempting. 11:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:24 INFO - (blobuploader) - INFO - Done attempting. 11:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:24 INFO - Return code: 0 11:26:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e35b397a1a943d2b2d11a924d21c0ccab233028f9a5eb728538bdaaabbf6a2e7b3989d2244b36ae4cdb2e7e03d6ec1b7a959562dff004ef8ff84acab97185c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a16997c287a431c07e834bb7aab0bdd35ea242543a794a8833076f5ac46389d91f9444e572984d9144b04fa1085a91e7234d74222d835e14c9d6f32dd155dbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb40b663acbfd9c4574f69b774fea76ba1deafb01854d93143a73b947b15a67d16403f8285e6099e2d5a5064fcc7c7b0feceaf7be2abfca2d8c80e048cc73348"} 11:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:24 INFO - Contents: 11:26:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e35b397a1a943d2b2d11a924d21c0ccab233028f9a5eb728538bdaaabbf6a2e7b3989d2244b36ae4cdb2e7e03d6ec1b7a959562dff004ef8ff84acab97185c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a16997c287a431c07e834bb7aab0bdd35ea242543a794a8833076f5ac46389d91f9444e572984d9144b04fa1085a91e7234d74222d835e14c9d6f32dd155dbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb40b663acbfd9c4574f69b774fea76ba1deafb01854d93143a73b947b15a67d16403f8285e6099e2d5a5064fcc7c7b0feceaf7be2abfca2d8c80e048cc73348"} 11:26:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:24 INFO - Copying logs to upload dir... 11:26:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.450434 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-01-19 11:26:24.552355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 11:26:24.556567) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 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-Aurora/sha512/97e35b397a1a943d2b2d11a924d21c0ccab233028f9a5eb728538bdaaabbf6a2e7b3989d2244b36ae4cdb2e7e03d6ec1b7a959562dff004ef8ff84acab97185c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a16997c287a431c07e834bb7aab0bdd35ea242543a794a8833076f5ac46389d91f9444e572984d9144b04fa1085a91e7234d74222d835e14c9d6f32dd155dbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb40b663acbfd9c4574f69b774fea76ba1deafb01854d93143a73b947b15a67d16403f8285e6099e2d5a5064fcc7c7b0feceaf7be2abfca2d8c80e048cc73348"} build_url:https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/CMyLKFECTXeM-lzKs_kDcQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/97e35b397a1a943d2b2d11a924d21c0ccab233028f9a5eb728538bdaaabbf6a2e7b3989d2244b36ae4cdb2e7e03d6ec1b7a959562dff004ef8ff84acab97185c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a16997c287a431c07e834bb7aab0bdd35ea242543a794a8833076f5ac46389d91f9444e572984d9144b04fa1085a91e7234d74222d835e14c9d6f32dd155dbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb40b663acbfd9c4574f69b774fea76ba1deafb01854d93143a73b947b15a67d16403f8285e6099e2d5a5064fcc7c7b0feceaf7be2abfca2d8c80e048cc73348"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 11:26:24.582570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:26:24.582902) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1484852741.715661-380378745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 11:26:24.669373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 11:26:24.669705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 11:26:24.670016) ========= ========= Total master_lag: 0.17 =========