builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1484778894.91 results: success (0) buildid: 20170118123627 builduid: d5373cf167444fe8b2680f95a336b94a revision: 20159d1481827415258184fb689253639f93d705 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:54.911540) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:54.911998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:54.912268) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:54.926660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:54.926921) ========= 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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-18 14:34:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2017-01-18 14:34:55 (66.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.040523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.040853) ========= 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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.090620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.090966) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 20159d1481827415258184fb689253639f93d705 --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 20159d1481827415258184fb689253639f93d705 --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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-18 14:34:55,703 truncating revision to first 12 chars 2017-01-18 14:34:55,703 Setting DEBUG logging. 2017-01-18 14:34:55,704 attempt 1/10 2017-01-18 14:34:55,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/20159d148182?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 14:34:56,034 unpacking tar archive at: mozilla-aurora-20159d148182/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709519 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.813788) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.814103) ========= script_repo_revision: 20159d1481827415258184fb689253639f93d705 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.814484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.814759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 14:34:55.822727) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 14:34:55.822989) ========= /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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:34:56 INFO - MultiFileLogger online at 20170118 14:34:56 in /builds/slave/test 14:34:56 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 14:34:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:56 INFO - {'append_to_log': False, 14:34:56 INFO - 'base_work_dir': '/builds/slave/test', 14:34:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:34:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:56 INFO - 'branch': 'Mozilla-Aurora', 14:34:56 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:56 INFO - 'config_files': ('talos/linux_config.py',), 14:34:56 INFO - 'default_actions': ('clobber', 14:34:56 INFO - 'read-buildbot-config', 14:34:56 INFO - 'download-and-extract', 14:34:56 INFO - 'populate-webroot', 14:34:56 INFO - 'create-virtualenv', 14:34:56 INFO - 'install', 14:34:56 INFO - 'run-tests'), 14:34:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:56 INFO - 'download_minidump_stackwalk': True, 14:34:56 INFO - 'download_symbols': 'ondemand', 14:34:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:56 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:56 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:56 INFO - 'installer_path': 'installer.exe', 14:34:56 INFO - 'log_level': 'info', 14:34:56 INFO - 'log_name': 'talos', 14:34:56 INFO - 'log_to_console': True, 14:34:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:34:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:34:56 INFO - 'opt_config_files': (), 14:34:56 INFO - 'pip_index': False, 14:34:56 INFO - 'sps_profile': False, 14:34:56 INFO - 'sps_profile_interval': 0, 14:34:56 INFO - 'suite': 'dromaeojs', 14:34:56 INFO - 'system_bits': '32', 14:34:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:56 INFO - 'title': 'talos-linux64-ix-028', 14:34:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:56 INFO - 'use_talos_json': True, 14:34:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:56 INFO - 'work_dir': 'build'} 14:34:56 INFO - [mozharness: 2017-01-18 22:34:56.529250Z] Running clobber step. 14:34:56 INFO - Running pre-action listener: _resource_record_pre_action 14:34:56 INFO - Running main action method: clobber 14:34:56 INFO - rmtree: /builds/slave/test/build 14:34:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:56 INFO - Running post-action listener: _resource_record_post_action 14:34:56 INFO - [mozharness: 2017-01-18 22:34:56.979142Z] Finished clobber step (success) 14:34:56 INFO - [mozharness: 2017-01-18 22:34:56.979243Z] Running read-buildbot-config step. 14:34:56 INFO - Running pre-action listener: _resource_record_pre_action 14:34:56 INFO - Running main action method: read_buildbot_config 14:34:56 INFO - Using buildbot properties: 14:34:56 INFO - { 14:34:56 INFO - "project": "", 14:34:56 INFO - "product": "firefox", 14:34:56 INFO - "script_repo_revision": "production", 14:34:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:34:56 INFO - "repository": "", 14:34:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:34:56 INFO - "buildid": "20170118123627", 14:34:56 INFO - "pgo_build": "True", 14:34:56 INFO - "basedir": "/builds/slave/test", 14:34:56 INFO - "buildnumber": 1011, 14:34:56 INFO - "slavename": "talos-linux64-ix-028", 14:34:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:34:56 INFO - "platform": "ubuntu64_hw", 14:34:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:34:56 INFO - "branch": "mozilla-aurora", 14:34:56 INFO - "repo_path": "releases/mozilla-aurora", 14:34:56 INFO - "revision": "20159d1481827415258184fb689253639f93d705", 14:34:56 INFO - "stage_platform": "linux64-pgo", 14:34:56 INFO - "builduid": "d5373cf167444fe8b2680f95a336b94a", 14:34:56 INFO - "slavebuilddir": "test" 14:34:56 INFO - } 14:34:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:34:56 INFO - Running post-action listener: _resource_record_post_action 14:34:56 INFO - [mozharness: 2017-01-18 22:34:56.981675Z] Finished read-buildbot-config step (success) 14:34:56 INFO - [mozharness: 2017-01-18 22:34:56.981761Z] Running download-and-extract step. 14:34:56 INFO - Running pre-action listener: _resource_record_pre_action 14:34:56 INFO - Running main action method: download_and_extract 14:34:56 INFO - mkdir: /builds/slave/test/build/tests 14:34:56 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')]} 14:34:56 INFO - trying https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/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 14:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/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 14:34:57 INFO - Downloaded 1361 bytes. 14:34:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:34:57 INFO - Using the following test package requirements: 14:34:57 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:34:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:34:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:34:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'jsshell-linux-x86_64.zip'], 14:34:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:34:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:34:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:34:57 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:34:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:34:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:34:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:34:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:34:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:57 INFO - Fetch https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:34:58 INFO - Http code: 200 14:34:58 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 14:34:58 INFO - x-amz-cf-id: cX1cl4m20_GWZwSQEGk3oBtf0Y7oyyxigsl_sC29D2vDdCt7oD90mw== 14:34:58 INFO - x-amz-version-id: yneFIeDAmPGgXXg25LupxeKGHZwerufY 14:34:58 INFO - Expected file size: 21949011 14:34:58 INFO - Obtained file size: 21949011 14:35:02 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 14:35:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:35:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:35:02 INFO - Fetch https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:35:03 INFO - Http code: 200 14:35:03 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 14:35:03 INFO - x-amz-cf-id: GpRta6N6Xf29z24MrrkLtRyAuk7MUGsJl-ZJ32wzE4KSKmoYUNfZxg== 14:35:03 INFO - x-amz-version-id: yneFIeDAmPGgXXg25LupxeKGHZwerufY 14:35:03 INFO - Expected file size: 21949011 14:35:03 INFO - Obtained file size: 21949011 14:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:35:07 INFO - Fetch https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:35:08 INFO - Http code: 200 14:35:08 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 14:35:08 INFO - x-amz-cf-id: K0rZyKv7R-vTKjCcf2az5tsEHoHoa7A1noA5NiyNrYQ-mGZmzhYqRA== 14:35:08 INFO - x-amz-version-id: Z8GxbHaJsa.V49017wIKOSZx2MiQ3LaI 14:35:08 INFO - Expected file size: 14409038 14:35:08 INFO - Obtained file size: 14409038 14:35:08 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')]} 14:35:08 INFO - trying https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:35:08 INFO - Downloading https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/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 14:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/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 14:35:09 INFO - Downloaded 64164228 bytes. 14:35:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:35:09 INFO - mkdir: /builds/slave/test/properties 14:35:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:35:09 INFO - Writing to file /builds/slave/test/properties/build_url 14:35:09 INFO - Contents: 14:35:09 INFO - build_url:https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:35:10 INFO - Running post-action listener: _resource_record_post_action 14:35:10 INFO - Running post-action listener: set_extra_try_arguments 14:35:10 INFO - [mozharness: 2017-01-18 22:35:10.584523Z] Finished download-and-extract step (success) 14:35:10 INFO - [mozharness: 2017-01-18 22:35:10.584749Z] Running populate-webroot step. 14:35:10 INFO - Running pre-action listener: _resource_record_pre_action 14:35:10 INFO - Running main action method: populate_webroot 14:35:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:35:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:35:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:35:10 INFO - '--tppagecycles', 14:35:10 INFO - '7'], 14:35:10 INFO - 'tests': ['tsvgm']}}, 14:35:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:35:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:35:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:35:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:35:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:35:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['damp', 'tps']}, 14:35:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'tests': ['damp', 'tps']}, 14:35:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['dromaeo_dom']}, 14:35:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:35:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['basic_compositor_video']}, 14:35:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:35:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['a11yr', 14:35:10 INFO - 'ts_paint', 14:35:10 INFO - 'tpaint', 14:35:10 INFO - 'sessionrestore', 14:35:10 INFO - 'sessionrestore_no_auto_restore', 14:35:10 INFO - 'tabpaint']}, 14:35:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['tsvgx', 14:35:10 INFO - 'tsvgr_opacity', 14:35:10 INFO - 'tart', 14:35:10 INFO - 'tscrollx', 14:35:10 INFO - 'cart']}, 14:35:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:35:10 INFO - 'tsvgr_opacity', 14:35:10 INFO - 'tart', 14:35:10 INFO - 'tscrollx', 14:35:10 INFO - 'cart']}, 14:35:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'talos_options': ['--disable-e10s'], 14:35:10 INFO - 'tests': ['tp5o']}, 14:35:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'tests': ['tp5o']}, 14:35:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'talos_options': ['--disable-e10s', 14:35:10 INFO - '--xperf_path', 14:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:10 INFO - 'tests': ['tp5n']}, 14:35:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:35:10 INFO - 'talos_options': ['--xperf_path', 14:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:35:10 INFO - 'tests': ['tp5n']}}, 14:35:10 INFO - 'talos.zip': {'path': '', 14:35:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:35:10 INFO - Running post-action listener: _resource_record_post_action 14:35:10 INFO - [mozharness: 2017-01-18 22:35:10.600688Z] Finished populate-webroot step (success) 14:35:10 INFO - [mozharness: 2017-01-18 22:35:10.600776Z] Running create-virtualenv step. 14:35:10 INFO - Running pre-action listener: _resource_record_pre_action 14:35:10 INFO - Running main action method: create_virtualenv 14:35:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:35:10 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 14:35:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:35:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:35:10 INFO - Using real prefix '/usr' 14:35:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:35:11 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:13 INFO - Installing pip.................done. 14:35:13 INFO - Return code: 0 14:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:35:13 INFO - Reading from file tmpfile_stdout 14:35:13 INFO - Output received: 14:35:13 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) 14:35:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:13 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')]} 14:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:13 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')]} 14:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:13 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:13 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 14:35:13 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 14:35:13 INFO - Using env: {'DISPLAY': ':0', 14:35:13 INFO - 'HOME': '/home/cltbld', 14:35:13 INFO - 'LANG': 'en_US.UTF-8', 14:35:13 INFO - 'LANGUAGE': 'en_US:en', 14:35:13 INFO - 'LOGNAME': 'cltbld', 14:35:13 INFO - 'MAIL': '/var/mail/cltbld', 14:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:13 INFO - 'MOZ_NO_REMOTE': '1', 14:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:13 INFO - 'NO_EM_RESTART': '1', 14:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:13 INFO - 'PWD': '/builds/slave/test', 14:35:13 INFO - 'SHELL': '/bin/bash', 14:35:13 INFO - 'SHLVL': '1', 14:35:13 INFO - 'TERM': 'linux', 14:35:13 INFO - 'TMOUT': '86400', 14:35:13 INFO - 'USER': 'cltbld', 14:35:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:13 INFO - '_': '/tools/buildbot/bin/python'} 14:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:13 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 14:35:13 INFO - Cleaning up... 14:35:13 INFO - Return code: 0 14:35:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:35:13 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')]} 14:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:13 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')]} 14:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:13 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:13 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 14:35:13 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 14:35:13 INFO - Using env: {'DISPLAY': ':0', 14:35:13 INFO - 'HOME': '/home/cltbld', 14:35:13 INFO - 'LANG': 'en_US.UTF-8', 14:35:13 INFO - 'LANGUAGE': 'en_US:en', 14:35:13 INFO - 'LOGNAME': 'cltbld', 14:35:13 INFO - 'MAIL': '/var/mail/cltbld', 14:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:13 INFO - 'MOZ_NO_REMOTE': '1', 14:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:13 INFO - 'NO_EM_RESTART': '1', 14:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:13 INFO - 'PWD': '/builds/slave/test', 14:35:13 INFO - 'SHELL': '/bin/bash', 14:35:13 INFO - 'SHLVL': '1', 14:35:13 INFO - 'TERM': 'linux', 14:35:13 INFO - 'TMOUT': '86400', 14:35:13 INFO - 'USER': 'cltbld', 14:35:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:13 INFO - '_': '/tools/buildbot/bin/python'} 14:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:13 INFO - Downloading/unpacking psutil>=3.1.1 14:35:13 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 14:35:13 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 14:35:13 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 14:35:13 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 14:35:13 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 14:35:13 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 14:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:15 INFO - Installing collected packages: psutil 14:35:15 INFO - Running setup.py install for psutil 14:35:16 INFO - building 'psutil._psutil_linux' extension 14:35:16 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 14:35:16 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 14:35:16 INFO - building 'psutil._psutil_posix' extension 14:35:16 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 14:35:16 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 14:35:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:16 INFO - Successfully installed psutil 14:35:16 INFO - Cleaning up... 14:35:16 INFO - Return code: 0 14:35:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:16 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:16 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 14:35:16 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 14:35:16 INFO - Using env: {'DISPLAY': ':0', 14:35:16 INFO - 'HOME': '/home/cltbld', 14:35:16 INFO - 'LANG': 'en_US.UTF-8', 14:35:16 INFO - 'LANGUAGE': 'en_US:en', 14:35:16 INFO - 'LOGNAME': 'cltbld', 14:35:16 INFO - 'MAIL': '/var/mail/cltbld', 14:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:16 INFO - 'MOZ_NO_REMOTE': '1', 14:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:16 INFO - 'NO_EM_RESTART': '1', 14:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:16 INFO - 'PWD': '/builds/slave/test', 14:35:16 INFO - 'SHELL': '/bin/bash', 14:35:16 INFO - 'SHLVL': '1', 14:35:16 INFO - 'TERM': 'linux', 14:35:16 INFO - 'TMOUT': '86400', 14:35:16 INFO - 'USER': 'cltbld', 14:35:16 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:16 INFO - '_': '/tools/buildbot/bin/python'} 14:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:35:18 INFO - Installing collected packages: mozsystemmonitor 14:35:18 INFO - Running setup.py install for mozsystemmonitor 14:35:18 INFO - Successfully installed mozsystemmonitor 14:35:18 INFO - Cleaning up... 14:35:18 INFO - Return code: 0 14:35:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:35:18 INFO - Using env: {'DISPLAY': ':0', 14:35:18 INFO - 'HOME': '/home/cltbld', 14:35:18 INFO - 'LANG': 'en_US.UTF-8', 14:35:18 INFO - 'LANGUAGE': 'en_US:en', 14:35:18 INFO - 'LOGNAME': 'cltbld', 14:35:18 INFO - 'MAIL': '/var/mail/cltbld', 14:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:18 INFO - 'MOZ_NO_REMOTE': '1', 14:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:18 INFO - 'NO_EM_RESTART': '1', 14:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:18 INFO - 'PWD': '/builds/slave/test', 14:35:18 INFO - 'SHELL': '/bin/bash', 14:35:18 INFO - 'SHLVL': '1', 14:35:18 INFO - 'TERM': 'linux', 14:35:18 INFO - 'TMOUT': '86400', 14:35:18 INFO - 'USER': 'cltbld', 14:35:18 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:18 INFO - '_': '/tools/buildbot/bin/python'} 14:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:19 INFO - Downloading/unpacking jsonschema==2.5.1 14:35:19 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 14:35:19 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 14:35:19 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 14:35:19 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 14:35:19 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 14:35:19 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 14:35:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:21 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:21 INFO - warning: no files found matching '*.txt' 14:35:21 INFO - no previously-included directories found matching 'build' 14:35:21 INFO - no previously-included directories found matching 'dist' 14:35:21 INFO - no previously-included directories found matching '.git*' 14:35:21 INFO - Installing collected packages: jsonschema, functools32 14:35:21 INFO - Running setup.py install for functools32 14:35:21 INFO - warning: no files found matching '*.txt' 14:35:21 INFO - no previously-included directories found matching 'build' 14:35:21 INFO - no previously-included directories found matching 'dist' 14:35:21 INFO - no previously-included directories found matching '.git*' 14:35:21 INFO - Successfully installed jsonschema functools32 14:35:21 INFO - Cleaning up... 14:35:21 INFO - Return code: 0 14:35:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:35:21 INFO - Using env: {'DISPLAY': ':0', 14:35:21 INFO - 'HOME': '/home/cltbld', 14:35:21 INFO - 'LANG': 'en_US.UTF-8', 14:35:21 INFO - 'LANGUAGE': 'en_US:en', 14:35:21 INFO - 'LOGNAME': 'cltbld', 14:35:21 INFO - 'MAIL': '/var/mail/cltbld', 14:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:21 INFO - 'MOZ_NO_REMOTE': '1', 14:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:21 INFO - 'NO_EM_RESTART': '1', 14:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:21 INFO - 'PWD': '/builds/slave/test', 14:35:21 INFO - 'SHELL': '/bin/bash', 14:35:21 INFO - 'SHLVL': '1', 14:35:21 INFO - 'TERM': 'linux', 14:35:21 INFO - 'TMOUT': '86400', 14:35:21 INFO - 'USER': 'cltbld', 14:35:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:21 INFO - '_': '/tools/buildbot/bin/python'} 14:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:35:21 INFO - Cleaning up... 14:35:21 INFO - Return code: 0 14:35:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:35:21 INFO - Using env: {'DISPLAY': ':0', 14:35:21 INFO - 'HOME': '/home/cltbld', 14:35:21 INFO - 'LANG': 'en_US.UTF-8', 14:35:21 INFO - 'LANGUAGE': 'en_US:en', 14:35:21 INFO - 'LOGNAME': 'cltbld', 14:35:21 INFO - 'MAIL': '/var/mail/cltbld', 14:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:21 INFO - 'MOZ_NO_REMOTE': '1', 14:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:21 INFO - 'NO_EM_RESTART': '1', 14:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:21 INFO - 'PWD': '/builds/slave/test', 14:35:21 INFO - 'SHELL': '/bin/bash', 14:35:21 INFO - 'SHLVL': '1', 14:35:21 INFO - 'TERM': 'linux', 14:35:21 INFO - 'TMOUT': '86400', 14:35:21 INFO - 'USER': 'cltbld', 14:35:21 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:21 INFO - '_': '/tools/buildbot/bin/python'} 14:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:22 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:22 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 14:35:22 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 14:35:22 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 14:35:22 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 14:35:22 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 14:35:22 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 14:35:24 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:24 INFO - Downloading docopt-0.6.1.tar.gz 14:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:24 INFO - Running setup.py install for blobuploader 14:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:25 INFO - Running setup.py install for requests 14:35:25 INFO - Running setup.py install for docopt 14:35:25 INFO - Successfully installed blobuploader requests docopt 14:35:25 INFO - Cleaning up... 14:35:25 INFO - Return code: 0 14:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:25 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')]} 14:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:25 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')]} 14:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:25 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:25 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 14:35:25 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 14:35:25 INFO - Using env: {'DISPLAY': ':0', 14:35:25 INFO - 'HOME': '/home/cltbld', 14:35:25 INFO - 'LANG': 'en_US.UTF-8', 14:35:25 INFO - 'LANGUAGE': 'en_US:en', 14:35:25 INFO - 'LOGNAME': 'cltbld', 14:35:25 INFO - 'MAIL': '/var/mail/cltbld', 14:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:25 INFO - 'MOZ_NO_REMOTE': '1', 14:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:25 INFO - 'NO_EM_RESTART': '1', 14:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:25 INFO - 'PWD': '/builds/slave/test', 14:35:25 INFO - 'SHELL': '/bin/bash', 14:35:25 INFO - 'SHLVL': '1', 14:35:25 INFO - 'TERM': 'linux', 14:35:25 INFO - 'TMOUT': '86400', 14:35:25 INFO - 'USER': 'cltbld', 14:35:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:25 INFO - '_': '/tools/buildbot/bin/python'} 14:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 INFO - Running setup.py (path:/tmp/pip-s9VCC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 INFO - Running setup.py (path:/tmp/pip-5yO2ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 INFO - Running setup.py (path:/tmp/pip-Nh_kN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:25 INFO - Running setup.py (path:/tmp/pip-7RFi6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:26 INFO - Running setup.py (path:/tmp/pip-YF8pnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 INFO - Running setup.py (path:/tmp/pip-qbDDQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 INFO - Running setup.py (path:/tmp/pip-fVC37C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 INFO - Running setup.py (path:/tmp/pip-Ink1zJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:26 INFO - Running setup.py (path:/tmp/pip-ijDcts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:26 INFO - Running setup.py (path:/tmp/pip-x3qF__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 INFO - Running setup.py (path:/tmp/pip-ickUN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 INFO - Running setup.py (path:/tmp/pip-_VRw4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:26 INFO - Running setup.py (path:/tmp/pip-Zk6i1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:26 INFO - Running setup.py (path:/tmp/pip-6zGxUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:26 INFO - Running setup.py (path:/tmp/pip-hnm3lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:26 INFO - Running setup.py (path:/tmp/pip-YkNIqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:26 INFO - Running setup.py (path:/tmp/pip-YR28Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:26 INFO - Running setup.py install for manifestparser 14:35:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozcrash 14:35:27 INFO - Running setup.py install for mozdebug 14:35:27 INFO - Running setup.py install for mozdevice 14:35:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozfile 14:35:27 INFO - Running setup.py install for mozhttpd 14:35:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozinfo 14:35:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozInstall 14:35:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:27 INFO - Running setup.py install for mozleak 14:35:27 INFO - Running setup.py install for mozlog 14:35:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for moznetwork 14:35:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozprocess 14:35:28 INFO - Running setup.py install for mozprofile 14:35:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozrunner 14:35:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Running setup.py install for mozscreenshot 14:35:28 INFO - Running setup.py install for moztest 14:35:28 INFO - Running setup.py install for mozversion 14:35:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:28 INFO - Cleaning up... 14:35:28 INFO - Return code: 0 14:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:28 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:28 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 14:35:28 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 14:35:28 INFO - Using env: {'DISPLAY': ':0', 14:35:28 INFO - 'HOME': '/home/cltbld', 14:35:28 INFO - 'LANG': 'en_US.UTF-8', 14:35:28 INFO - 'LANGUAGE': 'en_US:en', 14:35:28 INFO - 'LOGNAME': 'cltbld', 14:35:28 INFO - 'MAIL': '/var/mail/cltbld', 14:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:28 INFO - 'MOZ_NO_REMOTE': '1', 14:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:28 INFO - 'NO_EM_RESTART': '1', 14:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:28 INFO - 'PWD': '/builds/slave/test', 14:35:28 INFO - 'SHELL': '/bin/bash', 14:35:28 INFO - 'SHLVL': '1', 14:35:28 INFO - 'TERM': 'linux', 14:35:28 INFO - 'TMOUT': '86400', 14:35:28 INFO - 'USER': 'cltbld', 14:35:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:28 INFO - '_': '/tools/buildbot/bin/python'} 14:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:29 INFO - Running setup.py (path:/tmp/pip-u5rvTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:29 INFO - Running setup.py (path:/tmp/pip-Zkl2bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:29 INFO - Running setup.py (path:/tmp/pip-roARaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:29 INFO - Running setup.py (path:/tmp/pip-ViBZFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:29 INFO - Running setup.py (path:/tmp/pip-ftRroJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:29 INFO - Running setup.py (path:/tmp/pip-ib6DTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:29 INFO - Running setup.py (path:/tmp/pip-9RHlux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:29 INFO - Running setup.py (path:/tmp/pip-fKTxNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:29 INFO - Running setup.py (path:/tmp/pip-ugxWQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:29 INFO - Running setup.py (path:/tmp/pip-Yo0W5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:29 INFO - Running setup.py (path:/tmp/pip-t3u6Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:29 INFO - Running setup.py (path:/tmp/pip-yRuZQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:29 INFO - Running setup.py (path:/tmp/pip-N2B6fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:29 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)) 14:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:29 INFO - Running setup.py (path:/tmp/pip-g6Zxtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:30 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)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:30 INFO - Running setup.py (path:/tmp/pip-SJzlCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:30 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)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:30 INFO - Running setup.py (path:/tmp/pip-8n4vEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:30 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)) 14:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:30 INFO - Running setup.py (path:/tmp/pip-ppBRK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:30 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 14:35:30 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 14:35:30 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 14:35:30 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 14:35:30 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 14:35:30 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 14:35:32 INFO - Downloading blessings-1.6.tar.gz 14:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:32 INFO - Installing collected packages: blessings 14:35:32 INFO - Running setup.py install for blessings 14:35:32 INFO - Successfully installed blessings 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:32 INFO - Reading from file tmpfile_stdout 14:35:32 INFO - Current package versions: 14:35:32 INFO - argparse == 1.2.1 14:35:32 INFO - blessings == 1.6 14:35:32 INFO - blobuploader == 1.2.4 14:35:32 INFO - docopt == 0.6.1 14:35:32 INFO - functools32 == 3.2.3-2 14:35:32 INFO - jsonschema == 2.5.1 14:35:32 INFO - manifestparser == 1.1 14:35:32 INFO - mozInstall == 1.12 14:35:32 INFO - mozcrash == 1.0 14:35:32 INFO - mozdebug == 0.1 14:35:32 INFO - mozdevice == 0.48 14:35:32 INFO - mozfile == 1.2 14:35:32 INFO - mozhttpd == 0.7 14:35:32 INFO - mozinfo == 0.9 14:35:32 INFO - mozleak == 0.1 14:35:32 INFO - mozlog == 3.4 14:35:32 INFO - moznetwork == 0.27 14:35:32 INFO - mozprocess == 0.23 14:35:32 INFO - mozprofile == 0.28 14:35:32 INFO - mozrunner == 6.13 14:35:32 INFO - mozscreenshot == 0.1 14:35:32 INFO - mozsystemmonitor == 0.3 14:35:32 INFO - moztest == 0.8 14:35:32 INFO - mozversion == 1.4 14:35:32 INFO - psutil == 3.1.1 14:35:32 INFO - requests == 1.2.3 14:35:32 INFO - wsgiref == 0.1.2 14:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 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 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:32 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 14:35:32 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 14:35:32 INFO - Using env: {'DISPLAY': ':0', 14:35:32 INFO - 'HOME': '/home/cltbld', 14:35:32 INFO - 'LANG': 'en_US.UTF-8', 14:35:32 INFO - 'LANGUAGE': 'en_US:en', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MAIL': '/var/mail/cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SHLVL': '1', 14:35:32 INFO - 'TERM': 'linux', 14:35:32 INFO - 'TMOUT': '86400', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - '_': '/tools/buildbot/bin/python'} 14:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 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)) 14:35:32 INFO - Cleaning up... 14:35:32 INFO - Return code: 0 14:35:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd540a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, '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': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', '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 14:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:35:32 INFO - Using env: {'DISPLAY': ':0', 14:35:32 INFO - 'HOME': '/home/cltbld', 14:35:32 INFO - 'LANG': 'en_US.UTF-8', 14:35:32 INFO - 'LANGUAGE': 'en_US:en', 14:35:32 INFO - 'LOGNAME': 'cltbld', 14:35:32 INFO - 'MAIL': '/var/mail/cltbld', 14:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:32 INFO - 'MOZ_NO_REMOTE': '1', 14:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:32 INFO - 'NO_EM_RESTART': '1', 14:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:32 INFO - 'PWD': '/builds/slave/test', 14:35:32 INFO - 'SHELL': '/bin/bash', 14:35:32 INFO - 'SHLVL': '1', 14:35:32 INFO - 'TERM': 'linux', 14:35:32 INFO - 'TMOUT': '86400', 14:35:32 INFO - 'USER': 'cltbld', 14:35:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:32 INFO - '_': '/tools/buildbot/bin/python'} 14:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:35:33 INFO - Cleaning up... 14:35:33 INFO - Return code: 0 14:35:33 INFO - Running post-action listener: _resource_record_post_action 14:35:33 INFO - Running post-action listener: _start_resource_monitoring 14:35:33 INFO - Starting resource monitoring. 14:35:33 INFO - [mozharness: 2017-01-18 22:35:33.192508Z] Finished create-virtualenv step (success) 14:35:33 INFO - [mozharness: 2017-01-18 22:35:33.193012Z] Running install step. 14:35:33 INFO - Running pre-action listener: _resource_record_pre_action 14:35:33 INFO - Running main action method: install 14:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:33 INFO - Reading from file tmpfile_stdout 14:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:33 INFO - Reading from file tmpfile_stdout 14:35:33 INFO - Output received: 14:35:33 INFO - Usage: mozinstall [options] installer 14:35:33 INFO - Options: 14:35:33 INFO - -h, --help show this help message and exit 14:35:33 INFO - -d DEST, --destination=DEST 14:35:33 INFO - Directory to install application into. [default: 14:35:33 INFO - "/builds/slave/test"] 14:35:33 INFO - --app=APP Application being installed. [default: firefox] 14:35:33 INFO - mkdir: /builds/slave/test/build/application 14:35:33 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'] 14:35:33 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 14:35:49 INFO - Reading from file tmpfile_stdout 14:35:49 INFO - Output received: 14:35:49 INFO - /builds/slave/test/build/application/firefox/firefox 14:35:49 INFO - Running post-action listener: _resource_record_post_action 14:35:49 INFO - [mozharness: 2017-01-18 22:35:49.455576Z] Finished install step (success) 14:35:49 INFO - [mozharness: 2017-01-18 22:35:49.455906Z] Running run-tests step. 14:35:49 INFO - Running pre-action listener: _resource_record_pre_action 14:35:49 INFO - Running main action method: run_tests 14:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:49 INFO - Python 2.7.3 14:35:49 INFO - Return code: 0 14:35:49 INFO - grabbing minidump binary from tooltool 14:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:49 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebaf60>, '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 0x1ebbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:35:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:35:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:35:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:49 INFO - Return code: 0 14:35:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:35:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:35:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:49 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/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 14:35:49 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/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 14:35:49 INFO - Using env: {'DISPLAY': ':0', 14:35:49 INFO - 'HOME': '/home/cltbld', 14:35:49 INFO - 'LANG': 'en_US.UTF-8', 14:35:49 INFO - 'LANGUAGE': 'en_US:en', 14:35:49 INFO - 'LOGNAME': 'cltbld', 14:35:49 INFO - 'MAIL': '/var/mail/cltbld', 14:35:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:49 INFO - 'MOZ_NO_REMOTE': '1', 14:35:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:49 INFO - 'NO_EM_RESTART': '1', 14:35:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:49 INFO - 'PWD': '/builds/slave/test', 14:35:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:49 INFO - 'SHELL': '/bin/bash', 14:35:49 INFO - 'SHLVL': '1', 14:35:49 INFO - 'TERM': 'linux', 14:35:49 INFO - 'TMOUT': '86400', 14:35:49 INFO - 'USER': 'cltbld', 14:35:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923', 14:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:49 INFO - '_': '/tools/buildbot/bin/python'} 14:35:49 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/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 14:35:49 INFO - mozversion application_buildid: 20170118123627 14:35:49 INFO - mozversion application_changeset: 20159d1481827415258184fb689253639f93d705 14:35:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:35:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:49 INFO - mozversion application_name: Firefox 14:35:49 INFO - mozversion application_remotingname: firefox-dev 14:35:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:35:49 INFO - mozversion application_vendor: Mozilla 14:35:49 INFO - mozversion application_version: 52.0a2 14:35:49 INFO - mozversion platform_buildid: 20170118123627 14:35:49 INFO - mozversion platform_changeset: 20159d1481827415258184fb689253639f93d705 14:35:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:35:49 INFO - mozversion platform_version: 52.0a2 14:35:49 INFO - using testdate: 1484778949 14:35:49 INFO - actual date: 1484778949 14:35:49 INFO - starting webserver on 'localhost:37094' 14:35:49 INFO - SUITE-START | Running 2 tests 14:35:49 INFO - TEST-START | dromaeo_css 14:35:49 INFO - operating with platform_type : linux_ 14:35:49 INFO - Initialising browser for dromaeo_css test... 14:35:49 INFO - TEST-INFO | started process 6048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxpctqq/profile http://localhost:37094/getInfo.html) 14:35:53 INFO - PROCESS | 6048 | __metrics Screen width/height:1600/1200 14:35:53 INFO - PROCESS | 6048 | colorDepth:24 14:35:53 INFO - PROCESS | 6048 | Browser inner width/height: 1024/697 14:35:53 INFO - PROCESS | 6048 | __metrics 14:35:54 INFO - PROCESS | 6048 | 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" 14:35:54 INFO - PROCESS | 6048 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:35:54 INFO - PROCESS | 6048 | console.error: PushService: 14:35:54 INFO - PROCESS | 6048 | stateChangeProcessEnqueue: Error transitioning state 14:35:54 INFO - PROCESS | 6048 | UnknownError 14:35:55 INFO - TEST-INFO | 6048: exit 0 14:35:55 INFO - Browser initialized. 14:35:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:55 INFO - TEST-INFO | started process 6142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxpctqq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:07 INFO - PROCESS | 6142 | RSS: Main: 143335424 14:36:07 INFO - PROCESS | 6142 | 14:39:08 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37094/tests/dromaeo/cssquery-ext.html) 14:39:10 INFO - PROCESS | 6142 | RSS: Main: 225525760 14:39:10 INFO - PROCESS | 6142 | 14:42:12 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-ext.html (next: http://localhost:37094/tests/dromaeo/cssquery-jquery.html) 14:42:12 INFO - PROCESS | 6142 | RSS: Main: 230440960 14:42:12 INFO - PROCESS | 6142 | 14:45:15 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37094/tests/dromaeo/cssquery-mootools.html) 14:45:15 INFO - PROCESS | 6142 | RSS: Main: 174813184 14:45:15 INFO - PROCESS | 6142 | 14:48:17 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37094/tests/dromaeo/cssquery-prototype.html) 14:48:18 INFO - PROCESS | 6142 | RSS: Main: 173285376 14:48:18 INFO - PROCESS | 6142 | 14:51:20 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37094/tests/dromaeo/cssquery-yui.html) 14:51:21 INFO - PROCESS | 6142 | RSS: Main: 174596096 14:51:21 INFO - PROCESS | 6142 | 14:54:23 INFO - PROCESS | 6142 | Cycle 1(1): loaded http://localhost:37094/tests/dromaeo/cssquery-yui.html (next: http://localhost:37094/tests/dromaeo/cssquery-dojo.html) 14:54:24 INFO - PROCESS | 6142 | RSS: Main: 255807488 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | __start_tp_report 14:54:24 INFO - PROCESS | 6142 | _x_x_mozilla_page_load 14:54:24 INFO - PROCESS | 6142 | _x_x_mozilla_page_load_details 14:54:24 INFO - PROCESS | 6142 | |i|pagename|runs| 14:54:24 INFO - PROCESS | 6142 | |0;dojo.html;3236;3265.363254165439;3289.5723555937725;3294.1929227339306;3306.33873225355;5625.746841392137;5700.486956173943;5703.885922281552;5704.201411802351;5716.256886604746;5712.628679135853;5790.68151251681;5793.073108302672;5800;5823.883522329551;5190.143626301665;5228.398734145565;5249.580033597322;5258.421573626898;5298.284731561248;5062.848114556569;5067.163917953533;5303.575713942875;5319.521243088121;5340.092184328673;5037.59699224063;5042.949570504285;5084;5106.923396149061;5115.335006449175;5152.252923326134;5169.379674439073;5233.398159211702;5234.241035049935;5264.2893209416625;4935.235038569028;5054.7472626368535;5126.92309615356;5177.223416487519;5193.714345710984;5490.725463726798;5492.80775172867;5498.615096943216;5553.055980483327;5554.389017208104;5913.970430147821;5924.881502369972;6005.609635373687;6008.549358798107;6012.278526576839;6066.636001839904;6078.057901025348;6083.6349819011;6085.117657939618;6089.725962331706;5433.130699088167;5479;5632.887342253132;5638.774449022075;5681.857953551194;6210.4100110489435;6215.409536094064;6217.129601855744;6219.968900155471;6226.128342032119;5968.791092311835;5972.163897054415;5973.671448070311;5982.820515384546;6019.638821670714;5852.795152169653;5908.556858235649;5922.466977971917;5967.403259673998;6051.8487037823525;5992.610480318765;6008.068749343859;6010.2186715726675;6042.425969532887;6051.757929682852;5940.495057920039;5975.581709280309;6020.849478762978;6023.488003519662;6027.246594175728;4567.429071366079;4600.5169457207185;4663.067386522709;4685.4143232095985;4686.179918514246;4164;4164.292070348048;4203.306454435045;4205.201011807747;4222.59885310895;5795.8551036224435;5813.09896965971;5815.447532484492;5820.214271073351;5823.126531020296;6094.177286066413;6102.084687296941;6105.633661980295;6105.938940610537;6133.754649814046;5597.972010139923;5606.6916319602815;5739.110437882135;5784;5786.826395208151;5217.452167522431;5248.107821670325;5259.737013149327;5261.13191323435;5262.447443018505;6424.646644434601;6435.485161187;6437.2275326960125;6447.161868957006;6448.3229260927865;5895.380984996686;5895.4399332063385;6041.124037014521;6075.422834830684;6136.171616831671;6420.6789660517725;6436.259830119596;6438.517111216771;6444.999999999813;6446;6008.939910600838;6013.398660133952;6015.639061656315;6016.037434010537;6017.308009578955;5874.236349274567;5926.822195334147;6079.118527813531;6131.356207598138;6142.78500252489;5900.527957763455;5902.970485147547;5937.554683398676;5980.34216236205;6014.518838492822;5964.224650795369;5967.552433567586;5973.193618861572;5975.820725378246;5983.431574000463;5691.4877661010705;5874.471297583238;5930.436608522356;5941.7623295067715;5942.6731529766275;5801.332846722512;5802.361740208658;5817.5345972321265;5821.76712931478;5879.647221166743;5691.914621280601;5722.7710891563875;5733.655980641175;5737.856553586027;5745.2818397700285 14:54:24 INFO - PROCESS | 6142 | |1;ext.html;591.6243185577157;604.1270364323553;642.9260635026972;659.7031335898844;679.4021261290064;34363.4845477318;44039.33940990888;44730.552694473045;45071.77464112683;45127.54872451279;46518;46782.53217467833;46934;46972.765136174356;46975;8344.165583441669;8772.385932984693;8888.466691998468;8947.32895032875;8969.058248883872;8399.580020998925;10459.581616735359;10803.891961080406;10811.675649730521;11050.115990720724;10880.238383313172;10929.672109836718;10937.617183398583;10939.453027348602;10957.232993690404;10814.567417303298;10822.404767737771;10836;10836.67489975302;10851.565937362497;10702.678919632424;10757.623483178051;10778.407187604756;10782.406967616778;10785.245032847704;42039;42489;42520;42546.36180457295;42612.14775704499;3570.3037907608027;3572.589152247499;3589.192431702846;3651.1967367179177;4060.654844338235;32150;32157;32618.836905815555;32975.175620609436;34028.6597134028;4159.563245859172;4187.769672668002;4200.93133855149;4220.6412454941365;4241.554636763126;347745;348467;348771;348929;349940;63879.680601596694;64234;64235.678821605594;64329.678351608876;64330.678346607965;39851.40222896659;41352;41553.1689366211;43765.781171094575;67541.66229168823;19052;19269;19289.228430862608;19299.131539080776;19320.130594123297;12934.805977910339;13462.461501540025;13864.930675346559;14871.107733535806;14983.550493485212;20075.899620501805;20828.27101051456;20930.16279348809;21039.78960210409;21171.51799374029;7307.671154798047;7378.188399276075;7443.603387543987;7486.251374862471;7565.962170189114;956.4548207521646;1026.2149455666422;1044.5143008501084;1044.6918159143072;1083.978320433587;32380;32687;32790.67209327924;32855.34289314248;33005;1046.1839764983324;1082.6210826210763;1114.1031469666996;1178.6051672689746;1181.6218809980724;16393.262303196385;16771.329146834232;17083.145842707814;17085;17126.657466850593;567839;573308;573799;575676;577285;59126;59583.702081490184;59613.40386596078;59637.403625964056;59649;1303.0552849184267;1310.5151094095056;1379.3379177994618;1426.7217892511069;1447.6163816588612;31530.36939261156;33282.66717332796;34188.65811341855;34202.31595368128;34231.82884085563;53509.46490535045;54306.72846635742;54423.18365224446;54498;54507;415605;417950;418153;419383;499586;42558.787206063775;44495;44674;44961.07752996045;45803.54196457993;50775.6311167007;51015.489845101074;51339.48660513347;51558.48441515537;52265;42456;42594.361084583135;42987.140257194056;43510;44381;42757.35863962105;42831.57168428276;43411.34882976821;44256.11487770291;44615.77692111519;41743.1651366977;42128.78935605302;42682.359764604174;43225.13549729051;43312.350314744675;35060;36838.8158059208;37451;37542.624573753914;37993.43009854799;28217.858910705316;28292.43415131727;28426.43147137087;28506.42987140287;28644.856775715987 14:54:24 INFO - PROCESS | 6142 | |2;jquery.html;386.85492940147446;415.91057922546645;428.49865657181095;431.1140606054557;432.4594257178527;14540.56378308651;16126.113063781488;19625.116869740843;20246.89876550619;20558.897205513953;20252;20703.792962070376;20788.792112078874;20854.582908341825;20898.582028359422;5553.361363443195;5556.444355564452;5628.718564071801;5661.490465858072;5667.914981275264;4311.417958575599;4528.932066018996;5613.635113717616;5704.458076482728;5709.31488221414;5978.013627751416;6194.96902515489;6222.782202622909;6337.207849018872;6345.238571371442;6143.170671959273;6345.302016778151;6365.618062916216;6406.103145559626;6412;5745.2818397700285;5745.856353591152;5746.88506229873;5749.108888122348;5751.281089863767;22111.668324975137;22687.659685104736;23009.079636814506;23901.402464938343;24079.398015049588;2374.513224788914;2531.860747658878;2593.1831473085917;2647.033832651088;2906.578546110823;10657.893421065768;10680.305780124267;10765.19261055416;10815;10825.458727063695;1815.4553633909775;1864.2077117225126;1866.8226518480722;1893.8011508791517;1894.9715754263698;87051.56474217652;88408.55795721045;88720.11279887184;89658.5517072417;91115.99999999933;10874.510647020903;10917.454127293604;10979.28634638746;11091.168162387854;11296.717582060513;16683.582910427336;16695.582610434594;16708.49874503767;16760.832391676173;16767;8462.19609137131;8819;8881.777955551162;8975.596098175467;8981.865272020925;8493;8508.191721786421;8561.272291855137;8793;8814.471131732116;4795;5000.799968001312;5003.274525193827;5082.186850103965;5107.54032137102;1997.660397732389;2086.4158035750015;2112.3029400298174;2147.1411435425953;2163.0698799516044;883.4257732473943;952.3333666433385;1011.2718842433436;1016.1210552871713;1058.2010582010532;19081.61836763257;19774.40676779699;19847;20242.89878550598;20253;964.3297907953905;975.6926568131016;979.1041197304529;995.4922989275522;998.9900100999042;10695.572177112985;10792.406417646947;11287.435628218556;11572.47923843429;11798.646040618794;380369;383575;389548;537964;539228;55422.72288638612;75744;83095.16904830995;92031.53984230036;95979.52010239904;870.0951010948543;891.1350009718785;904.5341649050744;913.7761248494162;954.7565370830393;17642.470725878244;17889.642207156045;18242.72635910489;18287.725684114484;18373.54066148357;29790.255243618216;32315.51526727054;42777;44073;44729.32906006347;59216.40783592109;60039;60891;61489.385106148366;62839.371606283356;5569.10894256917;8670.26302764272;8848.646054157762;8903.510306933182;9180.081991800767;13011.414486347947;13079.41142648564;13146.539871104847;13174.538891138764;13480.123791953492;10610.946945265225;10640.574377024832;11022.118230541697;11562.30626162433;11631.127665424958;11346.432678366215;11455.59905403307;11675.35785531804;11749.29504229749;11856.110791690486;10969.341839489656;11235.101191904465;11554.537818487166;11699.122565807429;11922.52309907594;8676.566171691517;8776.824463510822;8886.60010299551;8918.554072296489;8979.910200897908;11063.059639930374;11117.22179447431;11231.15766317513;11349.205555611028;11621.941890290494 14:54:24 INFO - PROCESS | 6142 | |3;mootools.html;1502.1287653161169;1519.8404167562405;1672.7574501697254;1825.461488860786;1833.2666933226708;8377.916220837797;8968.820623587524;8970.865437018434;8981.461112333265;8985.775355616104;7610.277023682741;7829.92170078299;8298.128696486872;8587.484750914933;8764.8685269721;2278.692376529168;2293.4037150340946;2294.7705229477;2295.1393227539675;2304.677345171669;2429.7813196812285;2448.9510209795794;2510.7991360691194;2516.1570873757314;2518.1438310974263;2453.4479742057983;2465.926022219336;2473.50529894021;2494.4013436775135;2495.6506089147533;2356.2931120663734;2380.119355838342;2380.702412198475;2387.3434805428474;2421.878906054708;2365.101261520628;2396.209250947183;2421.067888862783;2422.6729391532094;2423.4547226873988;8642.611082501302;8674.783130421727;8729;8735.43219690718;8742.956285218534;5359.276497672803;5494.066008778477;5495.258140151069;5499.835004949858;5511.200875872976;3358.1101008232836;3370.5786776652917;3395.5585773849243;3424.417848965682;3457.2048428861253;1134.3647557367901;1139.8290256461514;1149.1209224942925;1167.912406569502;1176.6352430746497;12046.819297710541;12099.213551119148;12107.33409662477;12114.273143611412;12124;4589.770511474413;4711.1519926413575;4805.087033463631;4811.975940120277;4816.747645612096;10226.07965283128;10228.53971571281;10230.948845255725;10233.283670143019;10246.077852993118;5391.083515802323;5412.675239485643;5414.269073675004;5425.511703946664;5426.403095659474;4328.8268469260875;4463.419755431773;4880.731559764176;4946.653734238569;5010.974945125251;4143.30977333658;4148.502179738451;4174.4364510791265;4240.173166232555;4243.108947121077;1379.2552021908257;1397.7553928062753;1399.951001714935;1406.3038795795942;1407.4510940733123;664.7141729056552;818.7502811642506;829.8879651247125;935.4434111703525;939.8073394954018;5446.509814116748;5696;5724.084146536534;5736.110902810071;5769.88460230793;909.6088681866861;920.4615300049412;928.7074571509953;951.5813042261522;965.7971825916495;3665.8533658653355;3709.27669104522;3738.4953031340965;3790.7156963227867;3804.885853424402;10517.106045986024;11061.834072488919;11078.723031924266;11084.833727494093;11103.83344249837;10901.073408760345;10928.453577321261;10934.726631834108;10950.780984380268;10990.945045274882;7772.1450640428375;8200.343972482187;8365.456245344034;8379.49723016621;8386.916130838614;5626.578006649435;5728.828135155952;5731.684757338387;5779.133130030529;5779.942200578109;9867.457289849128;9915;9992.550335234786;10034.247431442525;10122;10040.347377420445;10096.646617368357;10291.588336466457;10368.377897326185;10371.377717336984;7832.412569057229;7868.527888326718;7967.760967170994;7976.122626511195;7978.162292959156;8352.665893364197;8373.539455329772;8426.578671066545;8435.746927592181;8437.282830959437;6285.717142728497;7352.595607241653;7421.2949769771785;7556.924430755842;7661.387089032753;7109.964450177716;7293.343599076109;7328.3770879473705;7332.266773322625;7339.119305683352;6526.967365163144;6665.900011499928;6667.599944003376;6670.533062685566;6678.298778628174;4997.975010125072;5056.949430505648;5085.288059671575;5211.218317252443;5271.235670827785;4983.900321993612;5133.255677926605;5170.2597623259735;5177.119889618699;5198.74006299676 14:54:24 INFO - PROCESS | 6142 | |4;prototype.html;355.5910702691904;360.17340204231294;360.50430657845465;361.6600395628111;363.4384875367559;5340;5406.91889621655;5423.2136340230645;5430.375506816712;5440.5375543078835;5295.735213239333;5309.41596424394;5319.654222475537;5334.546563542094;5336.9733151334185;3772.6604605585494;3992.7205095643317;4062.6952978526583;4093.69297302702;4241.194173107116;4226.175895700339;4229.936550951738;4232.873013809575;4241.34259189826;4262.424572682695;4231.1749208904275;4238.618524332809;4252.234597772415;4266.658667306623;4274.273373526493;4070.14526949341;4077.796110194508;4204.411382406465;4287.35689646554;4287.764172970486;3758.981205093957;3770.5098337215986;3784.4512545680723;3804.410316400962;3829.4447305140598;5190.273361729361;5222.3472065991755;5232.8691782705355;5240;5267.789288428458;4707.929381059287;4834.178189707723;4835.927461088087;4842.733649649268;4863.756812159413;5606.439356064402;5612.7754889804355;5619.117595605477;5628.43715628438;5633.549316054706;4186.91626167478;4187.320115126322;4189.581041895816;4194.951262184454;4203.684723645708;5613.680785015518;5789.594728369016;5798.826035218908;5892.410758924116;5898.705064746789;4232.724872883253;4246.8725938221905;4249.490061192615;4273.87178384649;4287.678424118204;4337.763737334844;4345.717528360647;4360.890977725582;4364.476262848479;4376.846810361622;4533.818647254073;4742.881427964328;4898.14282500561;4898.779554920037;4899.118158731462;5651.513334132968;5660.632058916157;5684.488396044293;5685.971570142206;5688.63023903445;1444.8874366737552;1456.63297142144;1459.9854001460062;1467.8238611366705;1467.8899082568637;962.5379817687549;992.4045572656493;1001.1690297053428;1014.4927536231884;1025.994870025645;5231.136862417735;5257.975679363472;5278.894422111536;5283.709395983258;5309.761045762082;5551.7779288828;5580.595836539707;5593.8321850344555;5594.944050559524;5623.297087864017;5053.9241911371355;5301.734913254399;5319.840404787863;5330.322077766329;5359.249705041298;2955.6600990886323;2957.955630665542;2967.896123635662;2969.7675464682347;2970.544433227703;5811.27359080115;5850.502707269845;5865.2961644602065;5867.452724138741;5872.58891877573;5621.426000719805;5713.371529131792;5870.882582348329;5962.701864906738;5981.461668449773;5905.970470147708;5923.822285331447;6083.908741368883;6096.908546371808;6118.60229085108;5844.94155058444;5856.882862342644;5859;5871.119332100219;5882.323532793613;5587.8882422352135;5730.197772311796;5747.396523365153;5778.451047150514;5802.245708057925;6048.576599638159;6051.3948605140895;6069.423404776539;6080.847978800565;6082.756689732538;4260.156764195542;4318.762468064161;4341.45731783527;4368.934465983077;4369.71596846204;5699;5723.713814309184;5728.283964504437;5733.197352370755;5736.254286942671;5582.525485333792;5591.832245032656;5621.156826476062;5626.156076588544;5697.088465845445;5406.512594546439;5493.423190564933;5553.305836770403;5607.607467477401;5615.438456154516;5484.2596249505805;5490.890182196414;5495.587830912617;5515.696636685021;5527.226188333717;5596.229866216249;5601.29983752031;5607.80372686954;5609.971950140223;5612.943870561242;5316.521513063843;5480.534154596904;5567.749451274622;5583.246261754611;5608.579356548194 14:54:24 INFO - PROCESS | 6142 | |5;yui.html;730.744239516169;752.4920678541982;756.852413779313;778.8091917480218;801.6512816924638;14588.051776634524;15317.234138293097;15422.460213892517;15465.922670386646;15483.225838708062;13981.580552583413;14077.366518506666;14081.225532595703;14086.929565352184;14129.152250864956;698.7589281697806;719.7912605344444;797.4577287444536;815.7511958852548;823.193270594816;845.3659755183612;847.0936098374741;847.5507980770171;847.9024912135121;848.3891598049395;884.054062153496;884.6196135661663;886.0386480668483;886.0873300500494;886.3175354976664;727.5998200989461;746.3283045259283;857.1471385970937;878.5168157513342;883.3242569434387;650.4211251985737;650.677914432359;652.0284775684244;652.2727159217486;652.2857471069171;13580.932095339558;13646.454141834314;13653;13664.795028074586;13679.384427700777;13290.949738512527;13291.468341266338;13353.465861365534;13394.19634821904;13590.59228223155;11462.369569673665;11470.082393408507;11577.142743229591;11645.12661550387;11770.2349347293;4263.445752052214;4275.743455392655;4288.935665965013;4305.806238719265;4326;63549.68225158891;63719.68140159316;64218.999999999534;64274;66196.66901665508;10650;10843;10929.453527323602;11102;11139.72150696239;20083.297084601967;20209.494762631053;20244.696329554772;20321.89839050795;20928.686069708965;7593.354564861938;8014.479058861155;8139.593020349077;8334.458260213067;8342;4589.770511474413;4646.767661616906;4647.419072615923;4701.177293973541;4743.407074115736;3171.777975541736;3252.577164968539;3277.0987978306157;3280.2127489402374;3281.097698132985;579.1978110317241;583.3087790967717;583.4428121144382;589.8053642298031;598.6201804839799;535.943725908774;547.3322546493351;627.244170774216;658.8188248231775;667.7529314153794;7833.060032796101;8266.958665206756;8566.785830354167;8708.085651006553;8873.689420870238;615.3047056825758;630.2940706408759;632.1434456311723;653.8463461086736;663.2836536540525;4125.422440858282;4239.42767726353;4284.821674039602;4368.759718215465;4445.355423463579;54104.72947635237;54980.72509637426;55094.449055509736;57273;89016;48381.27428088582;51723.74138129361;53847.46152538503;77398.22601774023;80664.19335806566;69344;70075.64962175259;70718.64640676866;71735.64132179305;72583;8323.292520135856;8513.31893448535;8513.31893448535;8563.143685631387;8774.824503510023;41218.79390603028;41432.58567414287;47946.280805788636;47948.52051479441;49205.507944921526;40795;41621.58378416177;42174.78912605417;58121.418785813294;60624.39375606187;11445.771084578095;11961.282323060645;12011.699707507381;12017.63947081589;12470.064745143969;11930.343831089373;11979.520819167485;12007.459664314953;13212.735745285232;14317.85682143207;12246.755064898474;12364.505419783109;12477.064220183704;12722.165601929251;12733.29966851832;13063;13365;13377.866221337663;13501.864981350061;13940.372683229481;12620.747585048064;13007;13041.282729449591;13073.803892941423;13148.934255328662;10049;10605.416702081151;10620.734481637712;10717.785644287227;10725.678229653124;11094.5022421972;11128.1653875958;11273.436328183394;11718.941405292919;11803.239696941358 14:54:24 INFO - PROCESS | 6142 | __end_tp_report 14:54:24 INFO - PROCESS | 6142 | __start_cc_report 14:54:24 INFO - PROCESS | 6142 | _x_x_mozilla_cycle_collect,1284 14:54:24 INFO - PROCESS | 6142 | __end_cc_report 14:54:24 INFO - PROCESS | 6142 | __startTimestamp1484780064201__endTimestamp 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | ------- Summary: start ------- 14:54:24 INFO - PROCESS | 6142 | Number of tests: 6 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#0] dojo.html Cycles:165 Average:5633.05 Median:5821.77 stddev:640.82 (11.0%) stddev-sans-first:614.58 14:54:24 INFO - PROCESS | 6142 | Values: 3236.0 3265.4 3289.6 3294.2 3306.3 5625.7 5700.5 5703.9 5704.2 5716.3 5712.6 5790.7 5793.1 5800.0 5823.9 5190.1 5228.4 5249.6 5258.4 5298.3 5062.8 5067.2 5303.6 5319.5 5340.1 5037.6 5042.9 5084.0 5106.9 5115.3 5152.3 5169.4 5233.4 5234.2 5264.3 4935.2 5054.7 5126.9 5177.2 5193.7 5490.7 5492.8 5498.6 5553.1 5554.4 5914.0 5924.9 6005.6 6008.5 6012.3 6066.6 6078.1 6083.6 6085.1 6089.7 5433.1 5479.0 5632.9 5638.8 5681.9 6210.4 6215.4 6217.1 6220.0 6226.1 5968.8 5972.2 5973.7 5982.8 6019.6 5852.8 5908.6 5922.5 5967.4 6051.8 5992.6 6008.1 6010.2 6042.4 6051.8 5940.5 5975.6 6020.8 6023.5 6027.2 4567.4 4600.5 4663.1 4685.4 4686.2 4164.0 4164.3 4203.3 4205.2 4222.6 5795.9 5813.1 5815.4 5820.2 5823.1 6094.2 6102.1 6105.6 6105.9 6133.8 5598.0 5606.7 5739.1 5784.0 5786.8 5217.5 5248.1 5259.7 5261.1 5262.4 6424.6 6435.5 6437.2 6447.2 6448.3 5895.4 5895.4 6041.1 6075.4 6136.2 6420.7 6436.3 6438.5 6445.0 6446.0 6008.9 6013.4 6015.6 6016.0 6017.3 5874.2 5926.8 6079.1 6131.4 6142.8 5900.5 5903.0 5937.6 5980.3 6014.5 5964.2 5967.6 5973.2 5975.8 5983.4 5691.5 5874.5 5930.4 5941.8 5942.7 5801.3 5802.4 5817.5 5821.8 5879.6 5691.9 5722.8 5733.7 5737.9 5745.3 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#1] ext.html Cycles:180 Average:62360.17 Median:41452.58 stddev:122417.71 (295.3%) stddev-sans-first:122673.28 14:54:24 INFO - PROCESS | 6142 | Values: 591.6 604.1 642.9 659.7 679.4 34363.5 44039.3 44730.6 45071.8 45127.5 46518.0 46782.5 46934.0 46972.8 46975.0 8344.2 8772.4 8888.5 8947.3 8969.1 8399.6 10459.6 10803.9 10811.7 11050.1 10880.2 10929.7 10937.6 10939.5 10957.2 10814.6 10822.4 10836.0 10836.7 10851.6 10702.7 10757.6 10778.4 10782.4 10785.2 42039.0 42489.0 42520.0 42546.4 42612.1 3570.3 3572.6 3589.2 3651.2 4060.7 32150.0 32157.0 32618.8 32975.2 34028.7 4159.6 4187.8 4200.9 4220.6 4241.6 347745.0 348467.0 348771.0 348929.0 349940.0 63879.7 64234.0 64235.7 64329.7 64330.7 39851.4 41352.0 41553.2 43765.8 67541.7 19052.0 19269.0 19289.2 19299.1 19320.1 12934.8 13462.5 13864.9 14871.1 14983.6 20075.9 20828.3 20930.2 21039.8 21171.5 7307.7 7378.2 7443.6 7486.3 7566.0 956.5 1026.2 1044.5 1044.7 1084.0 32380.0 32687.0 32790.7 32855.3 33005.0 1046.2 1082.6 1114.1 1178.6 1181.6 16393.3 16771.3 17083.1 17085.0 17126.7 567839.0 573308.0 573799.0 575676.0 577285.0 59126.0 59583.7 59613.4 59637.4 59649.0 1303.1 1310.5 1379.3 1426.7 1447.6 31530.4 33282.7 34188.7 34202.3 34231.8 53509.5 54306.7 54423.2 54498.0 54507.0 415605.0 417950.0 418153.0 419383.0 499586.0 42558.8 44495.0 44674.0 44961.1 45803.5 50775.6 51015.5 51339.5 51558.5 52265.0 42456.0 42594.4 42987.1 43510.0 44381.0 42757.4 42831.6 43411.3 44256.1 44615.8 41743.2 42128.8 42682.4 43225.1 43312.4 35060.0 36838.8 37451.0 37542.6 37993.4 28217.9 28292.4 28426.4 28506.4 28644.9 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#2] jquery.html Cycles:180 Average:27835.75 Median:381972.00 stddev:74850.90 (19.6%) stddev-sans-first:75032.50 14:54:24 INFO - PROCESS | 6142 | Values: 386.9 415.9 428.5 431.1 432.5 14540.6 16126.1 19625.1 20246.9 20558.9 20252.0 20703.8 20788.8 20854.6 20898.6 5553.4 5556.4 5628.7 5661.5 5667.9 4311.4 4528.9 5613.6 5704.5 5709.3 5978.0 6195.0 6222.8 6337.2 6345.2 6143.2 6345.3 6365.6 6406.1 6412.0 5745.3 5745.9 5746.9 5749.1 5751.3 22111.7 22687.7 23009.1 23901.4 24079.4 2374.5 2531.9 2593.2 2647.0 2906.6 10657.9 10680.3 10765.2 10815.0 10825.5 1815.5 1864.2 1866.8 1893.8 1895.0 87051.6 88408.6 88720.1 89658.6 91116.0 10874.5 10917.5 10979.3 11091.2 11296.7 16683.6 16695.6 16708.5 16760.8 16767.0 8462.2 8819.0 8881.8 8975.6 8981.9 8493.0 8508.2 8561.3 8793.0 8814.5 4795.0 5000.8 5003.3 5082.2 5107.5 1997.7 2086.4 2112.3 2147.1 2163.1 883.4 952.3 1011.3 1016.1 1058.2 19081.6 19774.4 19847.0 20242.9 20253.0 964.3 975.7 979.1 995.5 999.0 10695.6 10792.4 11287.4 11572.5 11798.6 380369.0 383575.0 389548.0 537964.0 539228.0 55422.7 75744.0 83095.2 92031.5 95979.5 870.1 891.1 904.5 913.8 954.8 17642.5 17889.6 18242.7 18287.7 18373.5 29790.3 32315.5 42777.0 44073.0 44729.3 59216.4 60039.0 60891.0 61489.4 62839.4 5569.1 8670.3 8848.6 8903.5 9180.1 13011.4 13079.4 13146.5 13174.5 13480.1 10610.9 10640.6 11022.1 11562.3 11631.1 11346.4 11455.6 11675.4 11749.3 11856.1 10969.3 11235.1 11554.5 11699.1 11922.5 8676.6 8776.8 8886.6 8918.6 8979.9 11063.1 11117.2 11231.2 11349.2 11621.9 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#3] mootools.html Cycles:180 Average:5760.12 Median:4965.28 stddev:3241.08 (65.3%) stddev-sans-first:3234.38 14:54:24 INFO - PROCESS | 6142 | Values: 1502.1 1519.8 1672.8 1825.5 1833.3 8377.9 8968.8 8970.9 8981.5 8985.8 7610.3 7829.9 8298.1 8587.5 8764.9 2278.7 2293.4 2294.8 2295.1 2304.7 2429.8 2449.0 2510.8 2516.2 2518.1 2453.4 2465.9 2473.5 2494.4 2495.7 2356.3 2380.1 2380.7 2387.3 2421.9 2365.1 2396.2 2421.1 2422.7 2423.5 8642.6 8674.8 8729.0 8735.4 8743.0 5359.3 5494.1 5495.3 5499.8 5511.2 3358.1 3370.6 3395.6 3424.4 3457.2 1134.4 1139.8 1149.1 1167.9 1176.6 12046.8 12099.2 12107.3 12114.3 12124.0 4589.8 4711.2 4805.1 4812.0 4816.7 10226.1 10228.5 10230.9 10233.3 10246.1 5391.1 5412.7 5414.3 5425.5 5426.4 4328.8 4463.4 4880.7 4946.7 5011.0 4143.3 4148.5 4174.4 4240.2 4243.1 1379.3 1397.8 1400.0 1406.3 1407.5 664.7 818.8 829.9 935.4 939.8 5446.5 5696.0 5724.1 5736.1 5769.9 909.6 920.5 928.7 951.6 965.8 3665.9 3709.3 3738.5 3790.7 3804.9 10517.1 11061.8 11078.7 11084.8 11103.8 10901.1 10928.5 10934.7 10950.8 10990.9 7772.1 8200.3 8365.5 8379.5 8386.9 5626.6 5728.8 5731.7 5779.1 5779.9 9867.5 9915.0 9992.6 10034.2 10122.0 10040.3 10096.6 10291.6 10368.4 10371.4 7832.4 7868.5 7967.8 7976.1 7978.2 8352.7 8373.5 8426.6 8435.7 8437.3 6285.7 7352.6 7421.3 7556.9 7661.4 7110.0 7293.3 7328.4 7332.3 7339.1 6527.0 6665.9 6667.6 6670.5 6678.3 4998.0 5056.9 5085.3 5211.2 5271.2 4983.9 5133.3 5170.3 5177.1 5198.7 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#4] prototype.html Cycles:180 Average:4752.48 Median:5332.43 stddev:1375.63 (25.8%) stddev-sans-first:1339.32 14:54:24 INFO - PROCESS | 6142 | Values: 355.6 360.2 360.5 361.7 363.4 5340.0 5406.9 5423.2 5430.4 5440.5 5295.7 5309.4 5319.7 5334.5 5337.0 3772.7 3992.7 4062.7 4093.7 4241.2 4226.2 4229.9 4232.9 4241.3 4262.4 4231.2 4238.6 4252.2 4266.7 4274.3 4070.1 4077.8 4204.4 4287.4 4287.8 3759.0 3770.5 3784.5 3804.4 3829.4 5190.3 5222.3 5232.9 5240.0 5267.8 4707.9 4834.2 4835.9 4842.7 4863.8 5606.4 5612.8 5619.1 5628.4 5633.5 4186.9 4187.3 4189.6 4195.0 4203.7 5613.7 5789.6 5798.8 5892.4 5898.7 4232.7 4246.9 4249.5 4273.9 4287.7 4337.8 4345.7 4360.9 4364.5 4376.8 4533.8 4742.9 4898.1 4898.8 4899.1 5651.5 5660.6 5684.5 5686.0 5688.6 1444.9 1456.6 1460.0 1467.8 1467.9 962.5 992.4 1001.2 1014.5 1026.0 5231.1 5258.0 5278.9 5283.7 5309.8 5551.8 5580.6 5593.8 5594.9 5623.3 5053.9 5301.7 5319.8 5330.3 5359.2 2955.7 2958.0 2967.9 2969.8 2970.5 5811.3 5850.5 5865.3 5867.5 5872.6 5621.4 5713.4 5870.9 5962.7 5981.5 5906.0 5923.8 6083.9 6096.9 6118.6 5844.9 5856.9 5859.0 5871.1 5882.3 5587.9 5730.2 5747.4 5778.5 5802.2 6048.6 6051.4 6069.4 6080.8 6082.8 4260.2 4318.8 4341.5 4368.9 4369.7 5699.0 5723.7 5728.3 5733.2 5736.3 5582.5 5591.8 5621.2 5626.2 5697.1 5406.5 5493.4 5553.3 5607.6 5615.4 5484.3 5490.9 5495.6 5515.7 5527.2 5596.2 5601.3 5607.8 5610.0 5612.9 5316.5 5480.5 5567.7 5583.2 5608.6 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - PROCESS | 6142 | [#5] yui.html Cycles:180 Average:16303.61 Median:4618.27 stddev:20509.98 (444.1%) stddev-sans-first:20534.18 14:54:24 INFO - PROCESS | 6142 | Values: 730.7 752.5 756.9 778.8 801.7 14588.1 15317.2 15422.5 15465.9 15483.2 13981.6 14077.4 14081.2 14086.9 14129.2 698.8 719.8 797.5 815.8 823.2 845.4 847.1 847.6 847.9 848.4 884.1 884.6 886.0 886.1 886.3 727.6 746.3 857.1 878.5 883.3 650.4 650.7 652.0 652.3 652.3 13580.9 13646.5 13653.0 13664.8 13679.4 13290.9 13291.5 13353.5 13394.2 13590.6 11462.4 11470.1 11577.1 11645.1 11770.2 4263.4 4275.7 4288.9 4305.8 4326.0 63549.7 63719.7 64219.0 64274.0 66196.7 10650.0 10843.0 10929.5 11102.0 11139.7 20083.3 20209.5 20244.7 20321.9 20928.7 7593.4 8014.5 8139.6 8334.5 8342.0 4589.8 4646.8 4647.4 4701.2 4743.4 3171.8 3252.6 3277.1 3280.2 3281.1 579.2 583.3 583.4 589.8 598.6 535.9 547.3 627.2 658.8 667.8 7833.1 8267.0 8566.8 8708.1 8873.7 615.3 630.3 632.1 653.8 663.3 4125.4 4239.4 4284.8 4368.8 4445.4 54104.7 54980.7 55094.4 57273.0 89016.0 48381.3 51723.7 53847.5 77398.2 80664.2 69344.0 70075.6 70718.6 71735.6 72583.0 8323.3 8513.3 8513.3 8563.1 8774.8 41218.8 41432.6 47946.3 47948.5 49205.5 40795.0 41621.6 42174.8 58121.4 60624.4 11445.8 11961.3 12011.7 12017.6 12470.1 11930.3 11979.5 12007.5 13212.7 14317.9 12246.8 12364.5 12477.1 12722.2 12733.3 13063.0 13365.0 13377.9 13501.9 13940.4 12620.7 13007.0 13041.3 13073.8 13148.9 10049.0 10605.4 10620.7 10717.8 10725.7 11094.5 11128.2 11273.4 11718.9 11803.2 14:54:24 INFO - PROCESS | 6142 | -------- Summary: end -------- 14:54:24 INFO - PROCESS | 6142 | 14:54:24 INFO - TEST-INFO | 6142: exit 0 14:54:24 INFO - TEST-OK | dromaeo_css | took 1115246ms 14:54:24 INFO - TEST-START | kraken 14:54:24 INFO - operating with platform_type : linux_ 14:54:24 INFO - Initialising browser for kraken test... 14:54:24 INFO - TEST-INFO | started process 6459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMQXEV/profile http://localhost:37094/getInfo.html) 14:54:29 INFO - PROCESS | 6459 | __metrics Screen width/height:1600/1200 14:54:29 INFO - PROCESS | 6459 | colorDepth:24 14:54:29 INFO - PROCESS | 6459 | Browser inner width/height: 1024/697 14:54:29 INFO - PROCESS | 6459 | __metrics 14:54:29 INFO - PROCESS | 6459 | 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" 14:54:29 INFO - PROCESS | 6459 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:54:30 INFO - PROCESS | 6459 | console.error: PushService: 14:54:30 INFO - PROCESS | 6459 | stateChangeProcessEnqueue: Error transitioning state 14:54:30 INFO - PROCESS | 6459 | UnknownError 14:54:30 INFO - TEST-INFO | 6459: exit 0 14:54:30 INFO - Browser initialized. 14:54:30 INFO - Running cycle 1/1 for kraken test... 14:54:30 INFO - TEST-INFO | started process 6553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMQXEV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:42 INFO - PROCESS | 6553 | RSS: Main: 143785984 14:54:42 INFO - PROCESS | 6553 | 14:54:45 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37094/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:45 INFO - PROCESS | 6553 | RSS: Main: 184930304 14:54:45 INFO - PROCESS | 6553 | 14:54:48 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37094/tests/kraken/driver.html?testName=audio-dft) 14:54:49 INFO - PROCESS | 6553 | RSS: Main: 175013888 14:54:49 INFO - PROCESS | 6553 | 14:54:51 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37094/tests/kraken/driver.html?testName=audio-fft) 14:54:52 INFO - PROCESS | 6553 | RSS: Main: 266129408 14:54:52 INFO - PROCESS | 6553 | 14:54:54 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37094/tests/kraken/driver.html?testName=audio-oscillator) 14:54:55 INFO - PROCESS | 6553 | RSS: Main: 173113344 14:54:55 INFO - PROCESS | 6553 | 14:54:57 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:57 INFO - PROCESS | 6553 | RSS: Main: 175284224 14:54:57 INFO - PROCESS | 6553 | 14:55:00 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37094/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:01 INFO - PROCESS | 6553 | RSS: Main: 214458368 14:55:01 INFO - PROCESS | 6553 | 14:55:04 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37094/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:05 INFO - PROCESS | 6553 | RSS: Main: 212590592 14:55:05 INFO - PROCESS | 6553 | 14:55:07 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37094/tests/kraken/driver.html?testName=json-parse-financial) 14:55:08 INFO - PROCESS | 6553 | RSS: Main: 211525632 14:55:08 INFO - PROCESS | 6553 | 14:55:10 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:10 INFO - PROCESS | 6553 | RSS: Main: 173957120 14:55:10 INFO - PROCESS | 6553 | 14:55:12 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:12 INFO - PROCESS | 6553 | RSS: Main: 180678656 14:55:12 INFO - PROCESS | 6553 | 14:55:14 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:15 INFO - PROCESS | 6553 | RSS: Main: 189800448 14:55:15 INFO - PROCESS | 6553 | 14:55:18 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:18 INFO - PROCESS | 6553 | RSS: Main: 197799936 14:55:18 INFO - PROCESS | 6553 | 14:55:21 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:22 INFO - PROCESS | 6553 | RSS: Main: 194166784 14:55:22 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:37094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37094/tests/kraken/driver.html?testName=ai-astar) 14:55:23 INFO - PROCESS | 6553 | RSS: Main: 246214656 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | __start_tp_report 14:55:23 INFO - PROCESS | 6553 | _x_x_mozilla_page_load 14:55:23 INFO - PROCESS | 6553 | _x_x_mozilla_page_load_details 14:55:23 INFO - PROCESS | 6553 | |i|pagename|runs| 14:55:23 INFO - PROCESS | 6553 | |0;ai-astar;103;109;111;110;110;110;109;110;110;109 14:55:23 INFO - PROCESS | 6553 | |1;audio-beat-detection;147;121;123;172;121;121;123;117;146;119 14:55:23 INFO - PROCESS | 6553 | |2;audio-dft;160;162;161;161;161;160;160;160;161;160 14:55:23 INFO - PROCESS | 6553 | |3;audio-fft;75;75;75;106;75;76;74;75;99;75 14:55:23 INFO - PROCESS | 6553 | |4;audio-oscillator;81;82;121;81;82;82;104;82;82;111 14:55:23 INFO - PROCESS | 6553 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 14:55:23 INFO - PROCESS | 6553 | |6;imaging-darkroom;146;147;148;146;145;146;147;147;146;145 14:55:23 INFO - PROCESS | 6553 | |7;imaging-desaturate;85;85;84;85;85;84;84;84;85;85 14:55:23 INFO - PROCESS | 6553 | |8;json-parse-financial;53;52;52;51;52;56;52;58;52;52 14:55:23 INFO - PROCESS | 6553 | |9;json-stringify-tinderbox;59;60;59;59;61;59;58;59;59;59 14:55:23 INFO - PROCESS | 6553 | |10;stanford-crypto-aes;73;75;74;74;75;74;94;80;73;82 14:55:23 INFO - PROCESS | 6553 | |11;stanford-crypto-ccm;131;122;134;124;130;120;120;119;155;121 14:55:23 INFO - PROCESS | 6553 | |12;stanford-crypto-pbkdf2;152;153;156;151;155;153;154;154;149;154 14:55:23 INFO - PROCESS | 6553 | |13;stanford-crypto-sha256-iterative;61;62;62;63;62;64;61;61;60;60 14:55:23 INFO - PROCESS | 6553 | __end_tp_report 14:55:23 INFO - PROCESS | 6553 | __start_cc_report 14:55:23 INFO - PROCESS | 6553 | _x_x_mozilla_cycle_collect,1612 14:55:23 INFO - PROCESS | 6553 | __end_cc_report 14:55:23 INFO - PROCESS | 6553 | __startTimestamp1484780123939__endTimestamp 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | ------- Summary: start ------- 14:55:23 INFO - PROCESS | 6553 | Number of tests: 14 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.23 (2.0%) stddev-sans-first:0.67 14:55:23 INFO - PROCESS | 6553 | Values: 103.0 109.0 111.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:123.00 stddev:18.04 (14.7%) stddev-sans-first:18.19 14:55:23 INFO - PROCESS | 6553 | Values: 147.0 121.0 123.0 172.0 121.0 121.0 123.0 117.0 146.0 119.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:55:23 INFO - PROCESS | 6553 | Values: 160.0 162.0 161.0 161.0 161.0 160.0 160.0 160.0 161.0 160.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.72 (15.6%) stddev-sans-first:12.26 14:55:23 INFO - PROCESS | 6553 | Values: 75.0 75.0 75.0 106.0 75.0 76.0 74.0 75.0 99.0 75.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:15.18 (18.5%) stddev-sans-first:15.68 14:55:23 INFO - PROCESS | 6553 | Values: 81.0 82.0 121.0 81.0 82.0 82.0 104.0 82.0 82.0 111.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:55:23 INFO - PROCESS | 6553 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 14:55:23 INFO - PROCESS | 6553 | Values: 146.0 147.0 148.0 146.0 145.0 146.0 147.0 147.0 146.0 145.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 14:55:23 INFO - PROCESS | 6553 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 85.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.00 stddev:2.21 (4.3%) stddev-sans-first:2.35 14:55:23 INFO - PROCESS | 6553 | Values: 53.0 52.0 52.0 51.0 52.0 56.0 52.0 58.0 52.0 52.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 14:55:23 INFO - PROCESS | 6553 | Values: 59.0 60.0 59.0 59.0 61.0 59.0 58.0 59.0 59.0 59.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:75.00 stddev:6.57 (8.8%) stddev-sans-first:6.77 14:55:23 INFO - PROCESS | 6553 | Values: 73.0 75.0 74.0 74.0 75.0 74.0 94.0 80.0 73.0 82.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.00 stddev:10.99 (8.7%) stddev-sans-first:11.58 14:55:23 INFO - PROCESS | 6553 | Values: 131.0 122.0 134.0 124.0 130.0 120.0 120.0 119.0 155.0 121.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:154.00 stddev:2.02 (1.3%) stddev-sans-first:2.11 14:55:23 INFO - PROCESS | 6553 | Values: 152.0 153.0 156.0 151.0 155.0 153.0 154.0 154.0 149.0 154.0 14:55:23 INFO - PROCESS | 6553 | 14:55:23 INFO - PROCESS | 6553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.26 (2.0%) stddev-sans-first:1.32 14:55:23 INFO - PROCESS | 6553 | Values: 61.0 62.0 62.0 63.0 62.0 64.0 61.0 61.0 60.0 60.0 14:55:23 INFO - PROCESS | 6553 | -------- Summary: end -------- 14:55:23 INFO - PROCESS | 6553 | 14:55:24 INFO - TEST-INFO | 6553: exit 0 14:55:25 INFO - TEST-OK | kraken | took 60077ms 14:55:25 INFO - SUITE-END | took 1175s 14:55:25 INFO - Completed test suite (00:19:35) 14:55:25 INFO - javascript benchmark 14:55:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.0, 3265.363254165439, 3289.5723555937725, 3294.1929227339306, 3306.33873225355, 5625.746841392137, 5700.486956173943, 5703.885922281552, 5704.201411802351, 5716.256886604746, 5712.628679135853, 5790.68151251681, 5793.073108302672, 5800.0, 5823.883522329551, 5190.143626301665, 5228.398734145565, 5249.580033597322, 5258.421573626898, 5298.284731561248, 5062.848114556569, 5067.163917953533, 5303.575713942875, 5319.521243088121, 5340.092184328673, 5037.59699224063, 5042.949570504285, 5084.0, 5106.923396149061, 5115.335006449175, 5152.252923326134, 5169.379674439073, 5233.398159211702, 5234.241035049935, 5264.2893209416625, 4935.235038569028, 5054.7472626368535, 5126.92309615356, 5177.223416487519, 5193.714345710984, 5490.725463726798, 5492.80775172867, 5498.615096943216, 5553.055980483327, 5554.389017208104, 5913.970430147821, 5924.881502369972, 6005.609635373687, 6008.549358798107, 6012.278526576839, 6066.636001839904, 6078.057901025348, 6083.6349819011, 6085.117657939618, 6089.725962331706, 5433.130699088167, 5479.0, 5632.887342253132, 5638.774449022075, 5681.857953551194, 6210.4100110489435, 6215.409536094064, 6217.129601855744, 6219.968900155471, 6226.128342032119, 5968.791092311835, 5972.163897054415, 5973.671448070311, 5982.820515384546, 6019.638821670714, 5852.795152169653, 5908.556858235649, 5922.466977971917, 5967.403259673998, 6051.8487037823525, 5992.610480318765, 6008.068749343859, 6010.2186715726675, 6042.425969532887, 6051.757929682852, 5940.495057920039, 5975.581709280309, 6020.849478762978, 6023.488003519662, 6027.246594175728, 4567.429071366079, 4600.5169457207185, 4663.067386522709, 4685.4143232095985, 4686.179918514246, 4164.0, 4164.292070348048, 4203.306454435045, 4205.201011807747, 4222.59885310895, 5795.8551036224435, 5813.09896965971, 5815.447532484492, 5820.214271073351, 5823.126531020296, 6094.177286066413, 6102.084687296941, 6105.633661980295, 6105.938940610537, 6133.754649814046, 5597.972010139923, 5606.6916319602815, 5739.110437882135, 5784.0, 5786.826395208151, 5217.452167522431, 5248.107821670325, 5259.737013149327, 5261.13191323435, 5262.447443018505, 6424.646644434601, 6435.485161187, 6437.2275326960125, 6447.161868957006, 6448.3229260927865, 5895.380984996686, 5895.4399332063385, 6041.124037014521, 6075.422834830684, 6136.171616831671, 6420.6789660517725, 6436.259830119596, 6438.517111216771, 6444.999999999813, 6446.0, 6008.939910600838, 6013.398660133952, 6015.639061656315, 6016.037434010537, 6017.308009578955, 5874.236349274567, 5926.822195334147, 6079.118527813531, 6131.356207598138, 6142.78500252489, 5900.527957763455, 5902.970485147547, 5937.554683398676, 5980.34216236205, 6014.518838492822, 5964.224650795369, 5967.552433567586, 5973.193618861572, 5975.820725378246, 5983.431574000463, 5691.4877661010705, 5874.471297583238, 5930.436608522356, 5941.7623295067715, 5942.6731529766275, 5801.332846722512, 5802.361740208658, 5817.5345972321265, 5821.76712931478, 5879.647221166743, 5691.914621280601, 5722.7710891563875, 5733.655980641175, 5737.856553586027, 5745.2818397700285], "value": 5589.940685717274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6243185577157, 604.1270364323553, 642.9260635026972, 659.7031335898844, 679.4021261290064, 34363.4845477318, 44039.33940990888, 44730.552694473045, 45071.77464112683, 45127.54872451279, 46518.0, 46782.53217467833, 46934.0, 46972.765136174356, 46975.0, 8344.165583441669, 8772.385932984693, 8888.466691998468, 8947.32895032875, 8969.058248883872, 8399.580020998925, 10459.581616735359, 10803.891961080406, 10811.675649730521, 11050.115990720724, 10880.238383313172, 10929.672109836718, 10937.617183398583, 10939.453027348602, 10957.232993690404, 10814.567417303298, 10822.404767737771, 10836.0, 10836.67489975302, 10851.565937362497, 10702.678919632424, 10757.623483178051, 10778.407187604756, 10782.406967616778, 10785.245032847704, 42039.0, 42489.0, 42520.0, 42546.36180457295, 42612.14775704499, 3570.3037907608027, 3572.589152247499, 3589.192431702846, 3651.1967367179177, 4060.654844338235, 32150.0, 32157.0, 32618.836905815555, 32975.175620609436, 34028.6597134028, 4159.563245859172, 4187.769672668002, 4200.93133855149, 4220.6412454941365, 4241.554636763126, 347745.0, 348467.0, 348771.0, 348929.0, 349940.0, 63879.680601596694, 64234.0, 64235.678821605594, 64329.678351608876, 64330.678346607965, 39851.40222896659, 41352.0, 41553.1689366211, 43765.781171094575, 67541.66229168823, 19052.0, 19269.0, 19289.228430862608, 19299.131539080776, 19320.130594123297, 12934.805977910339, 13462.461501540025, 13864.930675346559, 14871.107733535806, 14983.550493485212, 20075.899620501805, 20828.27101051456, 20930.16279348809, 21039.78960210409, 21171.51799374029, 7307.671154798047, 7378.188399276075, 7443.603387543987, 7486.251374862471, 7565.962170189114, 956.4548207521646, 1026.2149455666422, 1044.5143008501084, 1044.6918159143072, 1083.978320433587, 32380.0, 32687.0, 32790.67209327924, 32855.34289314248, 33005.0, 1046.1839764983324, 1082.6210826210763, 1114.1031469666996, 1178.6051672689746, 1181.6218809980724, 16393.262303196385, 16771.329146834232, 17083.145842707814, 17085.0, 17126.657466850593, 567839.0, 573308.0, 573799.0, 575676.0, 577285.0, 59126.0, 59583.702081490184, 59613.40386596078, 59637.403625964056, 59649.0, 1303.0552849184267, 1310.5151094095056, 1379.3379177994618, 1426.7217892511069, 1447.6163816588612, 31530.36939261156, 33282.66717332796, 34188.65811341855, 34202.31595368128, 34231.82884085563, 53509.46490535045, 54306.72846635742, 54423.18365224446, 54498.0, 54507.0, 415605.0, 417950.0, 418153.0, 419383.0, 499586.0, 42558.787206063775, 44495.0, 44674.0, 44961.07752996045, 45803.54196457993, 50775.6311167007, 51015.489845101074, 51339.48660513347, 51558.48441515537, 52265.0, 42456.0, 42594.361084583135, 42987.140257194056, 43510.0, 44381.0, 42757.35863962105, 42831.57168428276, 43411.34882976821, 44256.11487770291, 44615.77692111519, 41743.1651366977, 42128.78935605302, 42682.359764604174, 43225.13549729051, 43312.350314744675, 35060.0, 36838.8158059208, 37451.0, 37542.624573753914, 37993.43009854799, 28217.858910705316, 28292.43415131727, 28426.43147137087, 28506.42987140287, 28644.856775715987], "value": 21272.073897487524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.85492940147446, 415.91057922546645, 428.49865657181095, 431.1140606054557, 432.4594257178527, 14540.56378308651, 16126.113063781488, 19625.116869740843, 20246.89876550619, 20558.897205513953, 20252.0, 20703.792962070376, 20788.792112078874, 20854.582908341825, 20898.582028359422, 5553.361363443195, 5556.444355564452, 5628.718564071801, 5661.490465858072, 5667.914981275264, 4311.417958575599, 4528.932066018996, 5613.635113717616, 5704.458076482728, 5709.31488221414, 5978.013627751416, 6194.96902515489, 6222.782202622909, 6337.207849018872, 6345.238571371442, 6143.170671959273, 6345.302016778151, 6365.618062916216, 6406.103145559626, 6412.0, 5745.2818397700285, 5745.856353591152, 5746.88506229873, 5749.108888122348, 5751.281089863767, 22111.668324975137, 22687.659685104736, 23009.079636814506, 23901.402464938343, 24079.398015049588, 2374.513224788914, 2531.860747658878, 2593.1831473085917, 2647.033832651088, 2906.578546110823, 10657.893421065768, 10680.305780124267, 10765.19261055416, 10815.0, 10825.458727063695, 1815.4553633909775, 1864.2077117225126, 1866.8226518480722, 1893.8011508791517, 1894.9715754263698, 87051.56474217652, 88408.55795721045, 88720.11279887184, 89658.5517072417, 91115.99999999933, 10874.510647020903, 10917.454127293604, 10979.28634638746, 11091.168162387854, 11296.717582060513, 16683.582910427336, 16695.582610434594, 16708.49874503767, 16760.832391676173, 16767.0, 8462.19609137131, 8819.0, 8881.777955551162, 8975.596098175467, 8981.865272020925, 8493.0, 8508.191721786421, 8561.272291855137, 8793.0, 8814.471131732116, 4795.0, 5000.799968001312, 5003.274525193827, 5082.186850103965, 5107.54032137102, 1997.660397732389, 2086.4158035750015, 2112.3029400298174, 2147.1411435425953, 2163.0698799516044, 883.4257732473943, 952.3333666433385, 1011.2718842433436, 1016.1210552871713, 1058.2010582010532, 19081.61836763257, 19774.40676779699, 19847.0, 20242.89878550598, 20253.0, 964.3297907953905, 975.6926568131016, 979.1041197304529, 995.4922989275522, 998.9900100999042, 10695.572177112985, 10792.406417646947, 11287.435628218556, 11572.47923843429, 11798.646040618794, 380369.0, 383575.0, 389548.0, 537964.0, 539228.0, 55422.72288638612, 75744.0, 83095.16904830995, 92031.53984230036, 95979.52010239904, 870.0951010948543, 891.1350009718785, 904.5341649050744, 913.7761248494162, 954.7565370830393, 17642.470725878244, 17889.642207156045, 18242.72635910489, 18287.725684114484, 18373.54066148357, 29790.255243618216, 32315.51526727054, 42777.0, 44073.0, 44729.32906006347, 59216.40783592109, 60039.0, 60891.0, 61489.385106148366, 62839.371606283356, 5569.10894256917, 8670.26302764272, 8848.646054157762, 8903.510306933182, 9180.081991800767, 13011.414486347947, 13079.41142648564, 13146.539871104847, 13174.538891138764, 13480.123791953492, 10610.946945265225, 10640.574377024832, 11022.118230541697, 11562.30626162433, 11631.127665424958, 11346.432678366215, 11455.59905403307, 11675.35785531804, 11749.29504229749, 11856.110791690486, 10969.341839489656, 11235.101191904465, 11554.537818487166, 11699.122565807429, 11922.52309907594, 8676.566171691517, 8776.824463510822, 8886.60010299551, 8918.554072296489, 8979.910200897908, 11063.059639930374, 11117.22179447431, 11231.15766317513, 11349.205555611028, 11621.941890290494], "value": 9321.671910790286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.1287653161169, 1519.8404167562405, 1672.7574501697254, 1825.461488860786, 1833.2666933226708, 8377.916220837797, 8968.820623587524, 8970.865437018434, 8981.461112333265, 8985.775355616104, 7610.277023682741, 7829.92170078299, 8298.128696486872, 8587.484750914933, 8764.8685269721, 2278.692376529168, 2293.4037150340946, 2294.7705229477, 2295.1393227539675, 2304.677345171669, 2429.7813196812285, 2448.9510209795794, 2510.7991360691194, 2516.1570873757314, 2518.1438310974263, 2453.4479742057983, 2465.926022219336, 2473.50529894021, 2494.4013436775135, 2495.6506089147533, 2356.2931120663734, 2380.119355838342, 2380.702412198475, 2387.3434805428474, 2421.878906054708, 2365.101261520628, 2396.209250947183, 2421.067888862783, 2422.6729391532094, 2423.4547226873988, 8642.611082501302, 8674.783130421727, 8729.0, 8735.43219690718, 8742.956285218534, 5359.276497672803, 5494.066008778477, 5495.258140151069, 5499.835004949858, 5511.200875872976, 3358.1101008232836, 3370.5786776652917, 3395.5585773849243, 3424.417848965682, 3457.2048428861253, 1134.3647557367901, 1139.8290256461514, 1149.1209224942925, 1167.912406569502, 1176.6352430746497, 12046.819297710541, 12099.213551119148, 12107.33409662477, 12114.273143611412, 12124.0, 4589.770511474413, 4711.1519926413575, 4805.087033463631, 4811.975940120277, 4816.747645612096, 10226.07965283128, 10228.53971571281, 10230.948845255725, 10233.283670143019, 10246.077852993118, 5391.083515802323, 5412.675239485643, 5414.269073675004, 5425.511703946664, 5426.403095659474, 4328.8268469260875, 4463.419755431773, 4880.731559764176, 4946.653734238569, 5010.974945125251, 4143.30977333658, 4148.502179738451, 4174.4364510791265, 4240.173166232555, 4243.108947121077, 1379.2552021908257, 1397.7553928062753, 1399.951001714935, 1406.3038795795942, 1407.4510940733123, 664.7141729056552, 818.7502811642506, 829.8879651247125, 935.4434111703525, 939.8073394954018, 5446.509814116748, 5696.0, 5724.084146536534, 5736.110902810071, 5769.88460230793, 909.6088681866861, 920.4615300049412, 928.7074571509953, 951.5813042261522, 965.7971825916495, 3665.8533658653355, 3709.27669104522, 3738.4953031340965, 3790.7156963227867, 3804.885853424402, 10517.106045986024, 11061.834072488919, 11078.723031924266, 11084.833727494093, 11103.83344249837, 10901.073408760345, 10928.453577321261, 10934.726631834108, 10950.780984380268, 10990.945045274882, 7772.1450640428375, 8200.343972482187, 8365.456245344034, 8379.49723016621, 8386.916130838614, 5626.578006649435, 5728.828135155952, 5731.684757338387, 5779.133130030529, 5779.942200578109, 9867.457289849128, 9915.0, 9992.550335234786, 10034.247431442525, 10122.0, 10040.347377420445, 10096.646617368357, 10291.588336466457, 10368.377897326185, 10371.377717336984, 7832.412569057229, 7868.527888326718, 7967.760967170994, 7976.122626511195, 7978.162292959156, 8352.665893364197, 8373.539455329772, 8426.578671066545, 8435.746927592181, 8437.282830959437, 6285.717142728497, 7352.595607241653, 7421.2949769771785, 7556.924430755842, 7661.387089032753, 7109.964450177716, 7293.343599076109, 7328.3770879473705, 7332.266773322625, 7339.119305683352, 6526.967365163144, 6665.900011499928, 6667.599944003376, 6670.533062685566, 6678.298778628174, 4997.975010125072, 5056.949430505648, 5085.288059671575, 5211.218317252443, 5271.235670827785, 4983.900321993612, 5133.255677926605, 5170.2597623259735, 5177.119889618699, 5198.74006299676], "value": 4636.374098454406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.5910702691904, 360.17340204231294, 360.50430657845465, 361.6600395628111, 363.4384875367559, 5340.0, 5406.91889621655, 5423.2136340230645, 5430.375506816712, 5440.5375543078835, 5295.735213239333, 5309.41596424394, 5319.654222475537, 5334.546563542094, 5336.9733151334185, 3772.6604605585494, 3992.7205095643317, 4062.6952978526583, 4093.69297302702, 4241.194173107116, 4226.175895700339, 4229.936550951738, 4232.873013809575, 4241.34259189826, 4262.424572682695, 4231.1749208904275, 4238.618524332809, 4252.234597772415, 4266.658667306623, 4274.273373526493, 4070.14526949341, 4077.796110194508, 4204.411382406465, 4287.35689646554, 4287.764172970486, 3758.981205093957, 3770.5098337215986, 3784.4512545680723, 3804.410316400962, 3829.4447305140598, 5190.273361729361, 5222.3472065991755, 5232.8691782705355, 5240.0, 5267.789288428458, 4707.929381059287, 4834.178189707723, 4835.927461088087, 4842.733649649268, 4863.756812159413, 5606.439356064402, 5612.7754889804355, 5619.117595605477, 5628.43715628438, 5633.549316054706, 4186.91626167478, 4187.320115126322, 4189.581041895816, 4194.951262184454, 4203.684723645708, 5613.680785015518, 5789.594728369016, 5798.826035218908, 5892.410758924116, 5898.705064746789, 4232.724872883253, 4246.8725938221905, 4249.490061192615, 4273.87178384649, 4287.678424118204, 4337.763737334844, 4345.717528360647, 4360.890977725582, 4364.476262848479, 4376.846810361622, 4533.818647254073, 4742.881427964328, 4898.14282500561, 4898.779554920037, 4899.118158731462, 5651.513334132968, 5660.632058916157, 5684.488396044293, 5685.971570142206, 5688.63023903445, 1444.8874366737552, 1456.63297142144, 1459.9854001460062, 1467.8238611366705, 1467.8899082568637, 962.5379817687549, 992.4045572656493, 1001.1690297053428, 1014.4927536231884, 1025.994870025645, 5231.136862417735, 5257.975679363472, 5278.894422111536, 5283.709395983258, 5309.761045762082, 5551.7779288828, 5580.595836539707, 5593.8321850344555, 5594.944050559524, 5623.297087864017, 5053.9241911371355, 5301.734913254399, 5319.840404787863, 5330.322077766329, 5359.249705041298, 2955.6600990886323, 2957.955630665542, 2967.896123635662, 2969.7675464682347, 2970.544433227703, 5811.27359080115, 5850.502707269845, 5865.2961644602065, 5867.452724138741, 5872.58891877573, 5621.426000719805, 5713.371529131792, 5870.882582348329, 5962.701864906738, 5981.461668449773, 5905.970470147708, 5923.822285331447, 6083.908741368883, 6096.908546371808, 6118.60229085108, 5844.94155058444, 5856.882862342644, 5859.0, 5871.119332100219, 5882.323532793613, 5587.8882422352135, 5730.197772311796, 5747.396523365153, 5778.451047150514, 5802.245708057925, 6048.576599638159, 6051.3948605140895, 6069.423404776539, 6080.847978800565, 6082.756689732538, 4260.156764195542, 4318.762468064161, 4341.45731783527, 4368.934465983077, 4369.71596846204, 5699.0, 5723.713814309184, 5728.283964504437, 5733.197352370755, 5736.254286942671, 5582.525485333792, 5591.832245032656, 5621.156826476062, 5626.156076588544, 5697.088465845445, 5406.512594546439, 5493.423190564933, 5553.305836770403, 5607.607467477401, 5615.438456154516, 5484.2596249505805, 5490.890182196414, 5495.587830912617, 5515.696636685021, 5527.226188333717, 5596.229866216249, 5601.29983752031, 5607.80372686954, 5609.971950140223, 5612.943870561242, 5316.521513063843, 5480.534154596904, 5567.749451274622, 5583.246261754611, 5608.579356548194], "value": 4322.352911529001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.744239516169, 752.4920678541982, 756.852413779313, 778.8091917480218, 801.6512816924638, 14588.051776634524, 15317.234138293097, 15422.460213892517, 15465.922670386646, 15483.225838708062, 13981.580552583413, 14077.366518506666, 14081.225532595703, 14086.929565352184, 14129.152250864956, 698.7589281697806, 719.7912605344444, 797.4577287444536, 815.7511958852548, 823.193270594816, 845.3659755183612, 847.0936098374741, 847.5507980770171, 847.9024912135121, 848.3891598049395, 884.054062153496, 884.6196135661663, 886.0386480668483, 886.0873300500494, 886.3175354976664, 727.5998200989461, 746.3283045259283, 857.1471385970937, 878.5168157513342, 883.3242569434387, 650.4211251985737, 650.677914432359, 652.0284775684244, 652.2727159217486, 652.2857471069171, 13580.932095339558, 13646.454141834314, 13653.0, 13664.795028074586, 13679.384427700777, 13290.949738512527, 13291.468341266338, 13353.465861365534, 13394.19634821904, 13590.59228223155, 11462.369569673665, 11470.082393408507, 11577.142743229591, 11645.12661550387, 11770.2349347293, 4263.445752052214, 4275.743455392655, 4288.935665965013, 4305.806238719265, 4326.0, 63549.68225158891, 63719.68140159316, 64218.999999999534, 64274.0, 66196.66901665508, 10650.0, 10843.0, 10929.453527323602, 11102.0, 11139.72150696239, 20083.297084601967, 20209.494762631053, 20244.696329554772, 20321.89839050795, 20928.686069708965, 7593.354564861938, 8014.479058861155, 8139.593020349077, 8334.458260213067, 8342.0, 4589.770511474413, 4646.767661616906, 4647.419072615923, 4701.177293973541, 4743.407074115736, 3171.777975541736, 3252.577164968539, 3277.0987978306157, 3280.2127489402374, 3281.097698132985, 579.1978110317241, 583.3087790967717, 583.4428121144382, 589.8053642298031, 598.6201804839799, 535.943725908774, 547.3322546493351, 627.244170774216, 658.8188248231775, 667.7529314153794, 7833.060032796101, 8266.958665206756, 8566.785830354167, 8708.085651006553, 8873.689420870238, 615.3047056825758, 630.2940706408759, 632.1434456311723, 653.8463461086736, 663.2836536540525, 4125.422440858282, 4239.42767726353, 4284.821674039602, 4368.759718215465, 4445.355423463579, 54104.72947635237, 54980.72509637426, 55094.449055509736, 57273.0, 89016.0, 48381.27428088582, 51723.74138129361, 53847.46152538503, 77398.22601774023, 80664.19335806566, 69344.0, 70075.64962175259, 70718.64640676866, 71735.64132179305, 72583.0, 8323.292520135856, 8513.31893448535, 8513.31893448535, 8563.143685631387, 8774.824503510023, 41218.79390603028, 41432.58567414287, 47946.280805788636, 47948.52051479441, 49205.507944921526, 40795.0, 41621.58378416177, 42174.78912605417, 58121.418785813294, 60624.39375606187, 11445.771084578095, 11961.282323060645, 12011.699707507381, 12017.63947081589, 12470.064745143969, 11930.343831089373, 11979.520819167485, 12007.459664314953, 13212.735745285232, 14317.85682143207, 12246.755064898474, 12364.505419783109, 12477.064220183704, 12722.165601929251, 12733.29966851832, 13063.0, 13365.0, 13377.866221337663, 13501.864981350061, 13940.372683229481, 12620.747585048064, 13007.0, 13041.282729449591, 13073.803892941423, 13148.934255328662, 10049.0, 10605.416702081151, 10620.734481637712, 10717.785644287227, 10725.678229653124, 11094.5022421972, 11128.1653875958, 11273.436328183394, 11718.941405292919, 11803.239696941358], "value": 6876.741798511392, "unit": "score"}], "name": "dromaeo_css", "value": 7311.497045824871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 123.0, 172.0, 121.0, 121.0, 123.0, 117.0, 146.0, 119.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 75.0, 76.0, 74.0, 75.0, 99.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 81.0, 82.0, 82.0, 104.0, 82.0, 82.0, 111.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 52.0, 56.0, 52.0, 58.0, 52.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 61.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 74.0, 75.0, 74.0, 94.0, 80.0, 73.0, 82.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 122.0, 134.0, 124.0, 130.0, 120.0, 120.0, 119.0, 155.0, 121.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 156.0, 151.0, 155.0, 153.0, 154.0, 154.0, 149.0, 154.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 62.0, 64.0, 61.0, 61.0, 60.0, 60.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1451.5999999999997, "alertThreshold": 2.0}]} 14:55:25 INFO - Return code: 0 14:55:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:55:25 INFO - # TBPL SUCCESS # 14:55:25 INFO - Running post-action listener: _resource_record_post_action 14:55:25 INFO - [mozharness: 2017-01-18 22:55:25.256811Z] Finished run-tests step (success) 14:55:25 INFO - Running post-run listener: _resource_record_post_run 14:55:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 361156608; Read time: 28; Write time: 302444 14:55:25 INFO - TinderboxPrint: CPU usage
13.0% 14:55:25 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 14:55:25 INFO - TinderboxPrint: I/O write bytes / time
361,156,608 / 302,444 14:55:25 INFO - TinderboxPrint: CPU idle
8,279.6 (87.0%) 14:55:25 INFO - TinderboxPrint: CPU user
1,189.6 (12.5%) 14:55:25 INFO - TinderboxPrint: Swap in / out
0 / 0 14:55:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114450432; Read time: 0; Write time: 118860 14:55:25 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246706176; Read time: 16; Write time: 183584 14:55:25 INFO - Running post-run listener: _upload_blobber_files 14:55:25 INFO - Blob upload gear active. 14:55:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:25 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 14:55:25 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'] 14:55:25 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 14:55:26 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:55:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:55:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:27 INFO - (blobuploader) - INFO - Done attempting. 14:55:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:55:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:30 INFO - (blobuploader) - INFO - Done attempting. 14:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:31 INFO - (blobuploader) - INFO - Done attempting. 14:55:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:31 INFO - Return code: 0 14:55:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544dbe045cb53907be6163b1b229b4f49b7dd2187be26e32b8ecf0ea781a3ba22939673156be4710ac23c3e9b4572fbb3235accf34e01fd4243194e69d991cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ea2b07ebd88d8c67083daf43cdafe9362319214de1b745933bb924531d7d33caad3f9fbcc978c5b4fa8d05339696baaad7446a33bb85deeaa764569b4845af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cedcd214f4389e16e77c5b278a8243c12fde91a166e2a4aa8ae16d0745095a089f103a9b17f4ba97e5d7f318f0e194bd8d0668add098da93ec95522f6c572eb7"} 14:55:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:31 INFO - Contents: 14:55:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4544dbe045cb53907be6163b1b229b4f49b7dd2187be26e32b8ecf0ea781a3ba22939673156be4710ac23c3e9b4572fbb3235accf34e01fd4243194e69d991cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ea2b07ebd88d8c67083daf43cdafe9362319214de1b745933bb924531d7d33caad3f9fbcc978c5b4fa8d05339696baaad7446a33bb85deeaa764569b4845af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cedcd214f4389e16e77c5b278a8243c12fde91a166e2a4aa8ae16d0745095a089f103a9b17f4ba97e5d7f318f0e194bd8d0668add098da93ec95522f6c572eb7"} 14:55:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:31 INFO - Copying logs to upload dir... 14:55:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.186615 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 14:55:31.017341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 14:55:31.020907) ========= 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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 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/4544dbe045cb53907be6163b1b229b4f49b7dd2187be26e32b8ecf0ea781a3ba22939673156be4710ac23c3e9b4572fbb3235accf34e01fd4243194e69d991cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ea2b07ebd88d8c67083daf43cdafe9362319214de1b745933bb924531d7d33caad3f9fbcc978c5b4fa8d05339696baaad7446a33bb85deeaa764569b4845af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cedcd214f4389e16e77c5b278a8243c12fde91a166e2a4aa8ae16d0745095a089f103a9b17f4ba97e5d7f318f0e194bd8d0668add098da93ec95522f6c572eb7"} build_url:https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/A-Y1eCnCTLClCRSEpSSIfQ/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/4544dbe045cb53907be6163b1b229b4f49b7dd2187be26e32b8ecf0ea781a3ba22939673156be4710ac23c3e9b4572fbb3235accf34e01fd4243194e69d991cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73ea2b07ebd88d8c67083daf43cdafe9362319214de1b745933bb924531d7d33caad3f9fbcc978c5b4fa8d05339696baaad7446a33bb85deeaa764569b4845af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cedcd214f4389e16e77c5b278a8243c12fde91a166e2a4aa8ae16d0745095a089f103a9b17f4ba97e5d7f318f0e194bd8d0668add098da93ec95522f6c572eb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 14:55:31.045826) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:55:31.046107) ========= 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=836cfdc75598d54cb747368e000001a9-1484778894.761443-287962923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 14:55:31.130253) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 14:55:31.130565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 14:55:31.130852) ========= ========= Total master_lag: 0.16 =========