builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1486433333.41 results: success (0) buildid: 20170206162459 builduid: 3b5e821eacc543d2b022e37ab14f0cfa revision: feb1845bb0db8d50b9fea389700f70f1de1b628f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.409774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.410280) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.410607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.427192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.427617) ========= 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=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 18:08:53-- 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% 46.1M=0s 2017-02-06 18:08:53 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.522480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.522815) ========= 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=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016568 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.573189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:53.573549) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev feb1845bb0db8d50b9fea389700f70f1de1b628f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev feb1845bb0db8d50b9fea389700f70f1de1b628f --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=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 18:08:53,662 truncating revision to first 12 chars 2017-02-06 18:08:53,662 Setting DEBUG logging. 2017-02-06 18:08:53,662 attempt 1/10 2017-02-06 18:08:53,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/feb1845bb0db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 18:08:54,108 unpacking tar archive at: mozilla-beta-feb1845bb0db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:54.429162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:54.429484) ========= script_repo_revision: feb1845bb0db8d50b9fea389700f70f1de1b628f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:54.429896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:54.430161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 18:08:54.438667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 18:08:54.438948) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:08:54 INFO - MultiFileLogger online at 20170206 18:08:54 in /builds/slave/test 18:08:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:08:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:08:54 INFO - {'append_to_log': False, 18:08:54 INFO - 'base_work_dir': '/builds/slave/test', 18:08:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:08:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:08:54 INFO - 'branch': 'Mozilla-Beta', 18:08:54 INFO - 'buildbot_json_path': 'buildprops.json', 18:08:54 INFO - 'config_files': ('talos/linux_config.py',), 18:08:54 INFO - 'default_actions': ('clobber', 18:08:54 INFO - 'read-buildbot-config', 18:08:54 INFO - 'download-and-extract', 18:08:54 INFO - 'populate-webroot', 18:08:54 INFO - 'create-virtualenv', 18:08:54 INFO - 'install', 18:08:54 INFO - 'run-tests'), 18:08:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:08:54 INFO - 'download_minidump_stackwalk': True, 18:08:54 INFO - 'download_symbols': 'ondemand', 18:08:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:08:54 INFO - 'tooltool.py': '/tools/tooltool.py', 18:08:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:08:54 INFO - '/tools/misc-python/virtualenv.py')}, 18:08:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:08:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:08:54 INFO - 'installer_path': 'installer.exe', 18:08:54 INFO - 'log_level': 'info', 18:08:54 INFO - 'log_name': 'talos', 18:08:54 INFO - 'log_to_console': True, 18:08:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:08:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:08:54 INFO - 'opt_config_files': (), 18:08:54 INFO - 'pip_index': False, 18:08:54 INFO - 'sps_profile': False, 18:08:54 INFO - 'sps_profile_interval': 0, 18:08:54 INFO - 'suite': 'dromaeojs', 18:08:54 INFO - 'system_bits': '32', 18:08:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:08:54 INFO - 'title': 'talos-linux64-ix-014', 18:08:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:08:54 INFO - 'use_talos_json': True, 18:08:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:08:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:08:54 INFO - 'work_dir': 'build'} 18:08:54 INFO - [mozharness: 2017-02-07 02:08:54.626519Z] Running clobber step. 18:08:54 INFO - Running pre-action listener: _resource_record_pre_action 18:08:54 INFO - Running main action method: clobber 18:08:54 INFO - rmtree: /builds/slave/test/build 18:08:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:08:55 INFO - Running post-action listener: _resource_record_post_action 18:08:55 INFO - [mozharness: 2017-02-07 02:08:55.094111Z] Finished clobber step (success) 18:08:55 INFO - [mozharness: 2017-02-07 02:08:55.094211Z] Running read-buildbot-config step. 18:08:55 INFO - Running pre-action listener: _resource_record_pre_action 18:08:55 INFO - Running main action method: read_buildbot_config 18:08:55 INFO - Using buildbot properties: 18:08:55 INFO - { 18:08:55 INFO - "project": "", 18:08:55 INFO - "product": "firefox", 18:08:55 INFO - "script_repo_revision": "production", 18:08:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:08:55 INFO - "repository": "", 18:08:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:08:55 INFO - "buildid": "20170206162459", 18:08:55 INFO - "pgo_build": "True", 18:08:55 INFO - "basedir": "/builds/slave/test", 18:08:55 INFO - "buildnumber": 545, 18:08:55 INFO - "slavename": "talos-linux64-ix-014", 18:08:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:08:55 INFO - "platform": "ubuntu64_hw", 18:08:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:08:55 INFO - "branch": "mozilla-beta", 18:08:55 INFO - "repo_path": "releases/mozilla-beta", 18:08:55 INFO - "revision": "feb1845bb0db8d50b9fea389700f70f1de1b628f", 18:08:55 INFO - "stage_platform": "linux64-pgo", 18:08:55 INFO - "builduid": "3b5e821eacc543d2b022e37ab14f0cfa", 18:08:55 INFO - "slavebuilddir": "test" 18:08:55 INFO - } 18:08:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 18:08:55 INFO - Running post-action listener: _resource_record_post_action 18:08:55 INFO - [mozharness: 2017-02-07 02:08:55.097316Z] Finished read-buildbot-config step (success) 18:08:55 INFO - [mozharness: 2017-02-07 02:08:55.097405Z] Running download-and-extract step. 18:08:55 INFO - Running pre-action listener: _resource_record_pre_action 18:08:55 INFO - Running main action method: download_and_extract 18:08:55 INFO - mkdir: /builds/slave/test/build/tests 18:08:55 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')]} 18:08:55 INFO - trying https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:08:55 INFO - Downloading https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:08:55 INFO - Downloaded 1327 bytes. 18:08:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 18:08:55 INFO - Using the following test package requirements: 18:08:55 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:08:55 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:08:55 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 18:08:55 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'jsshell-linux-x86_64.zip'], 18:08:55 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:08:55 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 18:08:55 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 18:08:55 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 18:08:55 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:08:55 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 18:08:55 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:08:55 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:08:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:08:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:08:55 INFO - Fetch https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:08:56 INFO - Http code: 200 18:08:56 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 18:08:56 INFO - x-amz-cf-id: M1oTwIijtceDgszOGZyrlnNBivMWe6OhXpdxc4GQ4g88tVJVCmqCQA== 18:08:56 INFO - x-amz-version-id: hnu9QqNGGYFRs59vPV8ZbJT9N2QUO_O0 18:08:56 INFO - Expected file size: 21957045 18:08:56 INFO - Obtained file size: 21957045 18:09:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:09:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 18:09:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:09:00 INFO - Fetch https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 18:09:01 INFO - Http code: 200 18:09:01 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 18:09:01 INFO - x-amz-cf-id: jWE4Hpa1tg4Z-JioHYrAxHfcY21dA78oxA-LWowjIM4JyRXj8u5M-A== 18:09:01 INFO - x-amz-version-id: hnu9QqNGGYFRs59vPV8ZbJT9N2QUO_O0 18:09:01 INFO - Expected file size: 21957045 18:09:01 INFO - Obtained file size: 21957045 18:09:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 18:09:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:09:05 INFO - Fetch https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 18:09:06 INFO - Http code: 200 18:09:06 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 18:09:06 INFO - x-amz-cf-id: kpYETcVnNihaisCRRa1_UrRxSPsHAODErz7Uzqhnpzb1sGQBDvpHkw== 18:09:06 INFO - x-amz-version-id: 0XRaK_9hrMOxpRJrLS1gZiJeDyN9H1Oo 18:09:06 INFO - Expected file size: 14403005 18:09:06 INFO - Obtained file size: 14403005 18:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:06 INFO - trying https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:09:07 INFO - Downloaded 57702403 bytes. 18:09:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:09:07 INFO - mkdir: /builds/slave/test/properties 18:09:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:07 INFO - Contents: 18:09:07 INFO - build_url:https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 18:09:08 INFO - Running post-action listener: _resource_record_post_action 18:09:08 INFO - Running post-action listener: set_extra_try_arguments 18:09:08 INFO - [mozharness: 2017-02-07 02:09:08.603072Z] Finished download-and-extract step (success) 18:09:08 INFO - [mozharness: 2017-02-07 02:09:08.603302Z] Running populate-webroot step. 18:09:08 INFO - Running pre-action listener: _resource_record_pre_action 18:09:08 INFO - Running main action method: populate_webroot 18:09:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:08 INFO - '--tppagecycles', 18:09:08 INFO - '7'], 18:09:08 INFO - 'tests': ['tsvgm']}}, 18:09:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['damp', 'tps']}, 18:09:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'tests': ['damp', 'tps']}, 18:09:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['dromaeo_dom']}, 18:09:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['basic_compositor_video']}, 18:09:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:09:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['a11yr', 18:09:08 INFO - 'ts_paint', 18:09:08 INFO - 'tpaint', 18:09:08 INFO - 'sessionrestore', 18:09:08 INFO - 'sessionrestore_no_auto_restore', 18:09:08 INFO - 'tabpaint']}, 18:09:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['tsvgx', 18:09:08 INFO - 'tsvgr_opacity', 18:09:08 INFO - 'tart', 18:09:08 INFO - 'tscrollx', 18:09:08 INFO - 'cart']}, 18:09:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:08 INFO - 'tsvgr_opacity', 18:09:08 INFO - 'tart', 18:09:08 INFO - 'tscrollx', 18:09:08 INFO - 'cart']}, 18:09:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'talos_options': ['--disable-e10s'], 18:09:08 INFO - 'tests': ['tp5o']}, 18:09:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'tests': ['tp5o']}, 18:09:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'talos_options': ['--disable-e10s', 18:09:08 INFO - '--xperf_path', 18:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:08 INFO - 'tests': ['tp5n']}, 18:09:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:09:08 INFO - 'talos_options': ['--xperf_path', 18:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:08 INFO - 'tests': ['tp5n']}}, 18:09:08 INFO - 'talos.zip': {'path': '', 18:09:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:08 INFO - Running post-action listener: _resource_record_post_action 18:09:08 INFO - [mozharness: 2017-02-07 02:09:08.619022Z] Finished populate-webroot step (success) 18:09:08 INFO - [mozharness: 2017-02-07 02:09:08.619110Z] Running create-virtualenv step. 18:09:08 INFO - Running pre-action listener: _resource_record_pre_action 18:09:08 INFO - Running main action method: create_virtualenv 18:09:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:08 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 18:09:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:08 INFO - Using real prefix '/usr' 18:09:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:11 INFO - Installing pip.................done. 18:09:11 INFO - Return code: 0 18:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:09:11 INFO - Reading from file tmpfile_stdout 18:09:11 INFO - Output received: 18:09:11 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) 18:09:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:11 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')]} 18:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:11 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')]} 18:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:11 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:11 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 18:09:11 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 18:09:11 INFO - Using env: {'DISPLAY': ':0', 18:09:11 INFO - 'HOME': '/home/cltbld', 18:09:11 INFO - 'LANG': 'en_US.UTF-8', 18:09:11 INFO - 'LANGUAGE': 'en_US:en', 18:09:11 INFO - 'LOGNAME': 'cltbld', 18:09:11 INFO - 'MAIL': '/var/mail/cltbld', 18:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:11 INFO - 'MOZ_NO_REMOTE': '1', 18:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:11 INFO - 'NO_EM_RESTART': '1', 18:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:11 INFO - 'PWD': '/builds/slave/test', 18:09:11 INFO - 'SHELL': '/bin/bash', 18:09:11 INFO - 'SHLVL': '1', 18:09:11 INFO - 'TERM': 'linux', 18:09:11 INFO - 'TMOUT': '86400', 18:09:11 INFO - 'USER': 'cltbld', 18:09:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:11 INFO - '_': '/tools/buildbot/bin/python'} 18:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:11 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 18:09:11 INFO - Cleaning up... 18:09:11 INFO - Return code: 0 18:09:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:09:11 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')]} 18:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:11 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')]} 18:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:11 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:11 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 18:09:11 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 18:09:11 INFO - Using env: {'DISPLAY': ':0', 18:09:11 INFO - 'HOME': '/home/cltbld', 18:09:11 INFO - 'LANG': 'en_US.UTF-8', 18:09:11 INFO - 'LANGUAGE': 'en_US:en', 18:09:11 INFO - 'LOGNAME': 'cltbld', 18:09:11 INFO - 'MAIL': '/var/mail/cltbld', 18:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:11 INFO - 'MOZ_NO_REMOTE': '1', 18:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:11 INFO - 'NO_EM_RESTART': '1', 18:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:11 INFO - 'PWD': '/builds/slave/test', 18:09:11 INFO - 'SHELL': '/bin/bash', 18:09:11 INFO - 'SHLVL': '1', 18:09:11 INFO - 'TERM': 'linux', 18:09:11 INFO - 'TMOUT': '86400', 18:09:11 INFO - 'USER': 'cltbld', 18:09:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:11 INFO - '_': '/tools/buildbot/bin/python'} 18:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:11 INFO - Downloading/unpacking psutil>=3.1.1 18:09:11 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 18:09:11 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 18:09:11 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 18:09:11 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 18:09:11 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 18:09:11 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 18:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:14 INFO - Installing collected packages: psutil 18:09:14 INFO - Running setup.py install for psutil 18:09:14 INFO - building 'psutil._psutil_linux' extension 18:09:14 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 18:09:14 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 18:09:14 INFO - building 'psutil._psutil_posix' extension 18:09:14 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 18:09:14 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 18:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:14 INFO - Successfully installed psutil 18:09:14 INFO - Cleaning up... 18:09:14 INFO - Return code: 0 18:09:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:09:14 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')]} 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:14 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')]} 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:14 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:14 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 18:09:14 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 18:09:14 INFO - Using env: {'DISPLAY': ':0', 18:09:14 INFO - 'HOME': '/home/cltbld', 18:09:14 INFO - 'LANG': 'en_US.UTF-8', 18:09:14 INFO - 'LANGUAGE': 'en_US:en', 18:09:14 INFO - 'LOGNAME': 'cltbld', 18:09:14 INFO - 'MAIL': '/var/mail/cltbld', 18:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:14 INFO - 'MOZ_NO_REMOTE': '1', 18:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:14 INFO - 'NO_EM_RESTART': '1', 18:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:14 INFO - 'PWD': '/builds/slave/test', 18:09:14 INFO - 'SHELL': '/bin/bash', 18:09:14 INFO - 'SHLVL': '1', 18:09:14 INFO - 'TERM': 'linux', 18:09:14 INFO - 'TMOUT': '86400', 18:09:14 INFO - 'USER': 'cltbld', 18:09:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:14 INFO - '_': '/tools/buildbot/bin/python'} 18:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:09:16 INFO - Installing collected packages: mozsystemmonitor 18:09:16 INFO - Running setup.py install for mozsystemmonitor 18:09:16 INFO - Successfully installed mozsystemmonitor 18:09:16 INFO - Cleaning up... 18:09:17 INFO - Return code: 0 18:09:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:09:17 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')]} 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:17 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')]} 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:17 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:17 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 18:09:17 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 18:09:17 INFO - Using env: {'DISPLAY': ':0', 18:09:17 INFO - 'HOME': '/home/cltbld', 18:09:17 INFO - 'LANG': 'en_US.UTF-8', 18:09:17 INFO - 'LANGUAGE': 'en_US:en', 18:09:17 INFO - 'LOGNAME': 'cltbld', 18:09:17 INFO - 'MAIL': '/var/mail/cltbld', 18:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:17 INFO - 'MOZ_NO_REMOTE': '1', 18:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:17 INFO - 'NO_EM_RESTART': '1', 18:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:17 INFO - 'PWD': '/builds/slave/test', 18:09:17 INFO - 'SHELL': '/bin/bash', 18:09:17 INFO - 'SHLVL': '1', 18:09:17 INFO - 'TERM': 'linux', 18:09:17 INFO - 'TMOUT': '86400', 18:09:17 INFO - 'USER': 'cltbld', 18:09:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:17 INFO - '_': '/tools/buildbot/bin/python'} 18:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:17 INFO - Downloading/unpacking jsonschema==2.5.1 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:09:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:19 INFO - Downloading functools32-3.2.3-2.tar.gz 18:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:09:19 INFO - warning: no files found matching '*.txt' 18:09:19 INFO - no previously-included directories found matching 'build' 18:09:19 INFO - no previously-included directories found matching 'dist' 18:09:19 INFO - no previously-included directories found matching '.git*' 18:09:19 INFO - Installing collected packages: jsonschema, functools32 18:09:19 INFO - Running setup.py install for functools32 18:09:19 INFO - warning: no files found matching '*.txt' 18:09:19 INFO - no previously-included directories found matching 'build' 18:09:19 INFO - no previously-included directories found matching 'dist' 18:09:19 INFO - no previously-included directories found matching '.git*' 18:09:19 INFO - Successfully installed jsonschema functools32 18:09:19 INFO - Cleaning up... 18:09:19 INFO - Return code: 0 18:09:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:09:19 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')]} 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:19 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')]} 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:19 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:19 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 18:09:19 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 18:09:19 INFO - Using env: {'DISPLAY': ':0', 18:09:19 INFO - 'HOME': '/home/cltbld', 18:09:19 INFO - 'LANG': 'en_US.UTF-8', 18:09:19 INFO - 'LANGUAGE': 'en_US:en', 18:09:19 INFO - 'LOGNAME': 'cltbld', 18:09:19 INFO - 'MAIL': '/var/mail/cltbld', 18:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:19 INFO - 'MOZ_NO_REMOTE': '1', 18:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:19 INFO - 'NO_EM_RESTART': '1', 18:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:19 INFO - 'PWD': '/builds/slave/test', 18:09:19 INFO - 'SHELL': '/bin/bash', 18:09:19 INFO - 'SHLVL': '1', 18:09:19 INFO - 'TERM': 'linux', 18:09:19 INFO - 'TMOUT': '86400', 18:09:19 INFO - 'USER': 'cltbld', 18:09:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:19 INFO - '_': '/tools/buildbot/bin/python'} 18:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:09:19 INFO - Cleaning up... 18:09:19 INFO - Return code: 0 18:09:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:09:19 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')]} 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:19 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')]} 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:19 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:19 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 18:09:19 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 18:09:19 INFO - Using env: {'DISPLAY': ':0', 18:09:19 INFO - 'HOME': '/home/cltbld', 18:09:19 INFO - 'LANG': 'en_US.UTF-8', 18:09:19 INFO - 'LANGUAGE': 'en_US:en', 18:09:19 INFO - 'LOGNAME': 'cltbld', 18:09:19 INFO - 'MAIL': '/var/mail/cltbld', 18:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:19 INFO - 'MOZ_NO_REMOTE': '1', 18:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:19 INFO - 'NO_EM_RESTART': '1', 18:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:19 INFO - 'PWD': '/builds/slave/test', 18:09:19 INFO - 'SHELL': '/bin/bash', 18:09:19 INFO - 'SHLVL': '1', 18:09:19 INFO - 'TERM': 'linux', 18:09:19 INFO - 'TMOUT': '86400', 18:09:19 INFO - 'USER': 'cltbld', 18:09:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:19 INFO - '_': '/tools/buildbot/bin/python'} 18:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:09:20 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 18:09:20 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 18:09:20 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 18:09:20 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 18:09:20 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 18:09:20 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 18:09:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:09:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:09:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09: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 18:09:22 INFO - Downloading docopt-0.6.1.tar.gz 18:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:09:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:09:22 INFO - Running setup.py install for blobuploader 18:09:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:09:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:09:23 INFO - Running setup.py install for requests 18:09:23 INFO - Running setup.py install for docopt 18:09:23 INFO - Successfully installed blobuploader requests docopt 18:09:23 INFO - Cleaning up... 18:09:23 INFO - Return code: 0 18:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:23 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')]} 18:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:23 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')]} 18:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:23 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:23 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 18:09:23 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 18:09:23 INFO - Using env: {'DISPLAY': ':0', 18:09:23 INFO - 'HOME': '/home/cltbld', 18:09:23 INFO - 'LANG': 'en_US.UTF-8', 18:09:23 INFO - 'LANGUAGE': 'en_US:en', 18:09:23 INFO - 'LOGNAME': 'cltbld', 18:09:23 INFO - 'MAIL': '/var/mail/cltbld', 18:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:23 INFO - 'MOZ_NO_REMOTE': '1', 18:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:23 INFO - 'NO_EM_RESTART': '1', 18:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:23 INFO - 'PWD': '/builds/slave/test', 18:09:23 INFO - 'SHELL': '/bin/bash', 18:09:23 INFO - 'SHLVL': '1', 18:09:23 INFO - 'TERM': 'linux', 18:09:23 INFO - 'TMOUT': '86400', 18:09:23 INFO - 'USER': 'cltbld', 18:09:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:23 INFO - '_': '/tools/buildbot/bin/python'} 18:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:23 INFO - Running setup.py (path:/tmp/pip-GiTzTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:23 INFO - Running setup.py (path:/tmp/pip-L0RLma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:23 INFO - Running setup.py (path:/tmp/pip-1aMq1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:23 INFO - Running setup.py (path:/tmp/pip-wOiRvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:24 INFO - Running setup.py (path:/tmp/pip-33l8VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:24 INFO - Running setup.py (path:/tmp/pip-yLBNq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:24 INFO - Running setup.py (path:/tmp/pip-gtBJwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:24 INFO - Running setup.py (path:/tmp/pip-ZmkP6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:24 INFO - Running setup.py (path:/tmp/pip-Wava2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:24 INFO - Running setup.py (path:/tmp/pip-2iUIRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:24 INFO - Running setup.py (path:/tmp/pip-SexTVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:24 INFO - Running setup.py (path:/tmp/pip-lqxWAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:24 INFO - Running setup.py (path:/tmp/pip-lRXeez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:24 INFO - Running setup.py (path:/tmp/pip-e8JfCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:24 INFO - Running setup.py (path:/tmp/pip-FHzdZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:24 INFO - Running setup.py (path:/tmp/pip-tK0F1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:24 INFO - Running setup.py (path:/tmp/pip-BjJP6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:09:24 INFO - Running setup.py install for manifestparser 18:09:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Running setup.py install for mozcrash 18:09:25 INFO - Running setup.py install for mozdebug 18:09:25 INFO - Running setup.py install for mozdevice 18:09:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Running setup.py install for mozfile 18:09:25 INFO - Running setup.py install for mozhttpd 18:09:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Running setup.py install for mozinfo 18:09:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Running setup.py install for mozInstall 18:09:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:09:25 INFO - Running setup.py install for mozleak 18:09:25 INFO - Running setup.py install for mozlog 18:09:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Running setup.py install for moznetwork 18:09:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Running setup.py install for mozprocess 18:09:26 INFO - Running setup.py install for mozprofile 18:09:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Running setup.py install for mozrunner 18:09:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Running setup.py install for mozscreenshot 18:09:26 INFO - Running setup.py install for moztest 18:09:26 INFO - Running setup.py install for mozversion 18:09:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:09:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:09:26 INFO - Cleaning up... 18:09:26 INFO - Return code: 0 18:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:26 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:26 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 18:09:26 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 18:09:26 INFO - Using env: {'DISPLAY': ':0', 18:09:26 INFO - 'HOME': '/home/cltbld', 18:09:26 INFO - 'LANG': 'en_US.UTF-8', 18:09:26 INFO - 'LANGUAGE': 'en_US:en', 18:09:26 INFO - 'LOGNAME': 'cltbld', 18:09:26 INFO - 'MAIL': '/var/mail/cltbld', 18:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:26 INFO - 'MOZ_NO_REMOTE': '1', 18:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:26 INFO - 'NO_EM_RESTART': '1', 18:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:26 INFO - 'PWD': '/builds/slave/test', 18:09:26 INFO - 'SHELL': '/bin/bash', 18:09:26 INFO - 'SHLVL': '1', 18:09:26 INFO - 'TERM': 'linux', 18:09:26 INFO - 'TMOUT': '86400', 18:09:26 INFO - 'USER': 'cltbld', 18:09:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:26 INFO - '_': '/tools/buildbot/bin/python'} 18:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:27 INFO - Running setup.py (path:/tmp/pip-hnkdrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:27 INFO - Running setup.py (path:/tmp/pip-X75Vtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:27 INFO - Running setup.py (path:/tmp/pip-lWV5XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:27 INFO - Running setup.py (path:/tmp/pip-PWqyuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:27 INFO - Running setup.py (path:/tmp/pip-YwnSvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:27 INFO - Running setup.py (path:/tmp/pip-wdiM1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:27 INFO - Running setup.py (path:/tmp/pip-PrrYA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:27 INFO - Running setup.py (path:/tmp/pip-5ebJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:27 INFO - Running setup.py (path:/tmp/pip-Gk4m5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:27 INFO - Running setup.py (path:/tmp/pip-WGXyW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:27 INFO - Running setup.py (path:/tmp/pip-oBETX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:27 INFO - Running setup.py (path:/tmp/pip-91OnoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:27 INFO - Running setup.py (path:/tmp/pip-Padc4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:27 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)) 18:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:27 INFO - Running setup.py (path:/tmp/pip-kfGtnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:28 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)) 18:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:28 INFO - Running setup.py (path:/tmp/pip-ukg074-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:28 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)) 18:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:28 INFO - Running setup.py (path:/tmp/pip-HDMClk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:28 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)) 18:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:28 INFO - Running setup.py (path:/tmp/pip-hA3hbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:28 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 18:09:28 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 18:09:28 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 18:09:28 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 18:09:28 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 18:09:28 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 18:09:30 INFO - Downloading blessings-1.6.tar.gz 18:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:09:30 INFO - Installing collected packages: blessings 18:09:30 INFO - Running setup.py install for blessings 18:09:30 INFO - Successfully installed blessings 18:09:30 INFO - Cleaning up... 18:09:30 INFO - Return code: 0 18:09:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:30 INFO - Reading from file tmpfile_stdout 18:09:30 INFO - Current package versions: 18:09:30 INFO - argparse == 1.2.1 18:09:30 INFO - blessings == 1.6 18:09:30 INFO - blobuploader == 1.2.4 18:09:30 INFO - docopt == 0.6.1 18:09:30 INFO - functools32 == 3.2.3-2 18:09:30 INFO - jsonschema == 2.5.1 18:09:30 INFO - manifestparser == 1.1 18:09:30 INFO - mozInstall == 1.12 18:09:30 INFO - mozcrash == 1.0 18:09:30 INFO - mozdebug == 0.1 18:09:30 INFO - mozdevice == 0.48 18:09:30 INFO - mozfile == 1.2 18:09:30 INFO - mozhttpd == 0.7 18:09:30 INFO - mozinfo == 0.9 18:09:30 INFO - mozleak == 0.1 18:09:30 INFO - mozlog == 3.4 18:09:30 INFO - moznetwork == 0.27 18:09:30 INFO - mozprocess == 0.23 18:09:30 INFO - mozprofile == 0.28 18:09:30 INFO - mozrunner == 6.13 18:09:30 INFO - mozscreenshot == 0.1 18:09:30 INFO - mozsystemmonitor == 0.3 18:09:30 INFO - moztest == 0.8 18:09:30 INFO - mozversion == 1.4 18:09:30 INFO - psutil == 3.1.1 18:09:30 INFO - requests == 1.2.3 18:09:30 INFO - wsgiref == 0.1.2 18:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:30 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')]} 18:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:30 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')]} 18:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:30 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:30 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 18:09:30 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 18:09:30 INFO - Using env: {'DISPLAY': ':0', 18:09:30 INFO - 'HOME': '/home/cltbld', 18:09:30 INFO - 'LANG': 'en_US.UTF-8', 18:09:30 INFO - 'LANGUAGE': 'en_US:en', 18:09:30 INFO - 'LOGNAME': 'cltbld', 18:09:30 INFO - 'MAIL': '/var/mail/cltbld', 18:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:30 INFO - 'MOZ_NO_REMOTE': '1', 18:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:30 INFO - 'NO_EM_RESTART': '1', 18:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:30 INFO - 'PWD': '/builds/slave/test', 18:09:30 INFO - 'SHELL': '/bin/bash', 18:09:30 INFO - 'SHLVL': '1', 18:09:30 INFO - 'TERM': 'linux', 18:09:30 INFO - 'TMOUT': '86400', 18:09:30 INFO - 'USER': 'cltbld', 18:09:30 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:30 INFO - '_': '/tools/buildbot/bin/python'} 18:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 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)) 18:09:31 INFO - Cleaning up... 18:09:31 INFO - Return code: 0 18:09:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:09:31 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')]} 18:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 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')]} 18:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:09:31 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 0x7f14af991f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, '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': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', '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 18:09:31 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 18:09:31 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 18:09:31 INFO - Using env: {'DISPLAY': ':0', 18:09:31 INFO - 'HOME': '/home/cltbld', 18:09:31 INFO - 'LANG': 'en_US.UTF-8', 18:09:31 INFO - 'LANGUAGE': 'en_US:en', 18:09:31 INFO - 'LOGNAME': 'cltbld', 18:09:31 INFO - 'MAIL': '/var/mail/cltbld', 18:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:31 INFO - 'MOZ_NO_REMOTE': '1', 18:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:31 INFO - 'NO_EM_RESTART': '1', 18:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:31 INFO - 'PWD': '/builds/slave/test', 18:09:31 INFO - 'SHELL': '/bin/bash', 18:09:31 INFO - 'SHLVL': '1', 18:09:31 INFO - 'TERM': 'linux', 18:09:31 INFO - 'TMOUT': '86400', 18:09:31 INFO - 'USER': 'cltbld', 18:09:31 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:31 INFO - '_': '/tools/buildbot/bin/python'} 18:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:09:31 INFO - Cleaning up... 18:09:31 INFO - Return code: 0 18:09:31 INFO - Running post-action listener: _resource_record_post_action 18:09:31 INFO - Running post-action listener: _start_resource_monitoring 18:09:31 INFO - Starting resource monitoring. 18:09:31 INFO - [mozharness: 2017-02-07 02:09:31.470967Z] Finished create-virtualenv step (success) 18:09:31 INFO - [mozharness: 2017-02-07 02:09:31.471420Z] Running install step. 18:09:31 INFO - Running pre-action listener: _resource_record_pre_action 18:09:31 INFO - Running main action method: install 18:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:31 INFO - Reading from file tmpfile_stdout 18:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:09:31 INFO - Reading from file tmpfile_stdout 18:09:31 INFO - Output received: 18:09:31 INFO - Usage: mozinstall [options] installer 18:09:31 INFO - Options: 18:09:31 INFO - -h, --help show this help message and exit 18:09:31 INFO - -d DEST, --destination=DEST 18:09:31 INFO - Directory to install application into. [default: 18:09:31 INFO - "/builds/slave/test"] 18:09:31 INFO - --app=APP Application being installed. [default: firefox] 18:09:31 INFO - mkdir: /builds/slave/test/build/application 18:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:09:45 INFO - Reading from file tmpfile_stdout 18:09:45 INFO - Output received: 18:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 18:09:45 INFO - Running post-action listener: _resource_record_post_action 18:09:45 INFO - [mozharness: 2017-02-07 02:09:45.409112Z] Finished install step (success) 18:09:45 INFO - [mozharness: 2017-02-07 02:09:45.409355Z] Running run-tests step. 18:09:45 INFO - Running pre-action listener: _resource_record_pre_action 18:09:45 INFO - Running main action method: run_tests 18:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:09:45 INFO - Python 2.7.3 18:09:45 INFO - Return code: 0 18:09:45 INFO - grabbing minidump binary from tooltool 18:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:45 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 0x1b78f60>, '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 0x1b79d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:09:45 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 18:09:45 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 18:09:45 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 18:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:09:45 INFO - Return code: 0 18:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 18:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 18:09:45 INFO - Using env: {'DISPLAY': ':0', 18:09:45 INFO - 'HOME': '/home/cltbld', 18:09:45 INFO - 'LANG': 'en_US.UTF-8', 18:09:45 INFO - 'LANGUAGE': 'en_US:en', 18:09:45 INFO - 'LOGNAME': 'cltbld', 18:09:45 INFO - 'MAIL': '/var/mail/cltbld', 18:09:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:09:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:45 INFO - 'MOZ_NO_REMOTE': '1', 18:09:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:45 INFO - 'NO_EM_RESTART': '1', 18:09:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:45 INFO - 'PWD': '/builds/slave/test', 18:09:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:09:45 INFO - 'SHELL': '/bin/bash', 18:09:45 INFO - 'SHLVL': '1', 18:09:45 INFO - 'TERM': 'linux', 18:09:45 INFO - 'TMOUT': '86400', 18:09:45 INFO - 'USER': 'cltbld', 18:09:45 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513', 18:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:45 INFO - '_': '/tools/buildbot/bin/python'} 18:09:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 18:09:45 INFO - mozversion application_buildid: 20170206162459 18:09:45 INFO - mozversion application_changeset: feb1845bb0db8d50b9fea389700f70f1de1b628f 18:09:45 INFO - mozversion application_display_name: Firefox 18:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:09:45 INFO - mozversion application_name: Firefox 18:09:45 INFO - mozversion application_remotingname: firefox 18:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:09:45 INFO - mozversion application_vendor: Mozilla 18:09:45 INFO - mozversion application_version: 52.0 18:09:45 INFO - mozversion platform_buildid: 20170206162459 18:09:45 INFO - mozversion platform_changeset: feb1845bb0db8d50b9fea389700f70f1de1b628f 18:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:09:45 INFO - mozversion platform_version: 52.0 18:09:45 INFO - using testdate: 1486433385 18:09:45 INFO - actual date: 1486433385 18:09:45 INFO - starting webserver on 'localhost:59064' 18:09:45 INFO - SUITE-START | Running 2 tests 18:09:45 INFO - TEST-START | dromaeo_css 18:09:45 INFO - operating with platform_type : linux_ 18:09:45 INFO - Initialising browser for dromaeo_css test... 18:09:45 INFO - TEST-INFO | started process 15840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zQKe1/profile http://localhost:59064/getInfo.html) 18:09:49 INFO - PROCESS | 15840 | __metrics Screen width/height:1600/1200 18:09:49 INFO - PROCESS | 15840 | colorDepth:24 18:09:49 INFO - PROCESS | 15840 | Browser inner width/height: 1024/697 18:09:49 INFO - PROCESS | 15840 | __metrics 18:09:49 INFO - PROCESS | 15840 | 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" 18:09:49 INFO - PROCESS | 15840 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:09:50 INFO - PROCESS | 15840 | console.error: PushService: 18:09:50 INFO - PROCESS | 15840 | stateChangeProcessEnqueue: Error transitioning state 18:09:50 INFO - PROCESS | 15840 | UnknownError 18:09:51 INFO - TEST-INFO | 15840: exit 0 18:09:51 INFO - Browser initialized. 18:09:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:09:51 INFO - TEST-INFO | started process 15931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zQKe1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:02 INFO - PROCESS | 15931 | RSS: Main: 142008320 18:10:02 INFO - PROCESS | 15931 | 18:13:04 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59064/tests/dromaeo/cssquery-ext.html) 18:13:05 INFO - PROCESS | 15931 | RSS: Main: 244355072 18:13:05 INFO - PROCESS | 15931 | 18:16:07 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-ext.html (next: http://localhost:59064/tests/dromaeo/cssquery-jquery.html) 18:16:08 INFO - PROCESS | 15931 | RSS: Main: 222310400 18:16:08 INFO - PROCESS | 15931 | 18:19:09 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59064/tests/dromaeo/cssquery-mootools.html) 18:19:10 INFO - PROCESS | 15931 | RSS: Main: 208400384 18:19:10 INFO - PROCESS | 15931 | 18:22:12 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59064/tests/dromaeo/cssquery-prototype.html) 18:22:12 INFO - PROCESS | 15931 | RSS: Main: 175443968 18:22:12 INFO - PROCESS | 15931 | 18:25:15 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59064/tests/dromaeo/cssquery-yui.html) 18:25:16 INFO - PROCESS | 15931 | RSS: Main: 173613056 18:25:16 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | Cycle 1(1): loaded http://localhost:59064/tests/dromaeo/cssquery-yui.html (next: http://localhost:59064/tests/dromaeo/cssquery-dojo.html) 18:28:18 INFO - PROCESS | 15931 | RSS: Main: 256413696 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | __start_tp_report 18:28:18 INFO - PROCESS | 15931 | _x_x_mozilla_page_load 18:28:18 INFO - PROCESS | 15931 | _x_x_mozilla_page_load_details 18:28:18 INFO - PROCESS | 15931 | |i|pagename|runs| 18:28:18 INFO - PROCESS | 15931 | |0;dojo.html;3254.316593515361;3280.147161737949;3285.556449879267;3304.801711897288;3331.650176731443;5558.249636299103;5638.097904335307;5645.887082258352;5663.6318639288465;5679.432056794319;5627.577931655132;5655.1517272409155;5655.4910058094765;5668.886622267552;5707.77168913243;5075.187969924813;5082.644214904958;5096.490350964892;5100.20946753252;5185.403678576955;4998.750062496879;5005.824796132136;5192.948070519303;5195.818146364878;5218.582513398938;5060.2156665716875;5084.84745457635;5110.974445127769;5114;5144.974275128619;5178.40448348441;5184.2223666450145;5253.343332083451;5253.973730131325;5280.419153893107;4875.8781030474165;5104.183330667112;5124.359455068116;5183.663061900965;5200.401953775327;5475.151351540518;5510;5550.111982082888;5567.2762540869835;5575.553955683536;5950.940490595125;5962.195103661037;6092.786752463642;6092.786752463687;6100.908486372708;5843.737031833578;6136.7852125175405;6137.478314343241;6139.631622102688;6155.953487907066;5484.930438564482;5614.242077319591;5684.289463817023;5704.201411802351;5749.108888122348;6239.719212635442;6247.843803904848;6249.312575616678;6257.655828929362;6263.530235232376;5708.628939118944;5993.820185394445;5994.100884867305;5999.670018148957;6003.3996600339615;5843.532517398683;5932.940670593325;6002.639841609517;6008.09878518217;6097.298810636745;6022.518198544106;6024.3975602439405;6033.728482218311;6036.517078633787;6041.758329666852;6021.729022194012;6068.029115341524;6077.058056001327;6077.058056001327;6095.35998720128;4526.275795872644;4549.818007279738;4585.6102231310715;4605.884852878705;4610.4697959734385;4126.09225970286;4135.937960930589;4137.97931010343;4148.875533733993;4155.065110350208;5687;5696.629719068247;5697;5699.74351154199;5700.173474846124;5887.764489420375;5912.438318359835;5954.612950158225;6027.8794424111275;6039.818805435844;5700.743466544015;5703.572232082611;5706.572007099484;5725.456081672234;5744.540436765049;5183.326167598264;5204.947950520522;5205.011047900886;5205.167173252337;5206.843794686166;6117.4620395853735;6183.659898705524;6193.81418557444;6214.5960512566535;6245.344238854946;6038.5169186465855;6133.487685122301;6133.946794548733;6134.069235337404;6140.565599444434;6392.360763923756;6399.072134540559;6403.167588213502;6406.519511036598;6408.743650253938;5713.714314284186;5744.684042377709;5996.5502587305255;5999.130126131599;6006.189164462917;6007.219061522149;6042.274927008787;6066.575339726177;6129.053167990421;6131.743695906945;5902.350741418355;5954.76180952757;5960.821175364746;5964.343922168645;5968.313643931004;5678.290213723285;5957.285125784933;5963.552733544915;5965.403459654;5969.91045134332;5761.164631128547;5819.679917604403;5868.38381969887;5877.353491115889;5981.252343457068;5964.314103877936;5978.192943952685;5984.13230081627;5986.4013598639785;5991.310999234969;5587.972060139673;5655.4344565543115;5824.621399609012;5832.766689332379;5837.737301821343 18:28:18 INFO - PROCESS | 15931 | |1;ext.html;590.630855715178;614.42858141928;635.2726128582773;636.4431122767578;652.6867103790183;34568;37013;37032.259354812886;46618;48030.51969480304;48440.75779621097;48813.511864881344;48839;48968;48968.265476017885;8956.8656470153;9106.043865394104;9115.27077833775;9119.908800911971;9123.270138388913;8472.618732157038;8680.522571258578;8694.565271736388;8842.646294148226;9028.729138125867;10714.892851071467;11066.28069175505;11070.612528561502;11255.887441125566;11283.66149015531;10806.405647689375;10868.130549556017;10877.619283325046;10880.6191783288;10890.782184356347;10876.12990960729;10939.070179034792;10939.617113401073;10941.343519388782;10942.835857462145;44378.77810610926;44828;44846;44917.550824491664;44943;3639.490471334015;3731.2164445466483;3733.2720119576693;3979.9204015919518;4276.893077673052;33758.49362259568;33820.45929018784;34193.658063419294;34254.14364640879;35049.12377190565;4081.1429599784083;4205.474315710536;4218.114196018809;4321.351797230409;4326.5673432656795;355981.22009390045;357029;357183;359783;359927;61572.69213653903;61809.69095154495;61821.381786182465;61953.69023154856;62025;40905;41308.1738365231;41400.79299603483;65452;65777;19194.520136996685;19708.507287317643;19715.11281992314;19715.408537743602;19741.60516789685;14965.625859353604;15083.396664133532;15095.169765662993;15097;15098.54704358849;18673.346432874783;18750.53123671919;19615.60768784645;20253.797462025486;20506.79493205049;7022.613756243456;7343.1555371131935;7443.255674432622;7453.860602868228;7532.54804711719;990.1979396688705;1071.8499410082595;1085.1915323084195;1092.3882625729616;1140.5779861451317;33989.490157647655;34633.826830866186;34645.826770866486;34846;35293.64706352904;1092.3664274720643;1114.8439218509416;1117.5138814615668;1146.0716819376332;1150.7008177873813;14630.707385852224;17350.13249337528;17773.377931772327;18585.44243672692;18832.811671883104;419501;602968;607231;607567;609916;57350.13974790381;57906.42093579094;57970;62217.688911556055;62283.6885815568;1410.2173293821822;1447.4933773179303;1471.9264036798118;1474.9336279867432;1483.2657834372055;32766.34467310688;34712.479312809824;35157.76947806814;35390.99980570856;35717.82141089278;55566.16650750161;56255.718721406134;56331;56389.436105638415;56414;380864;384889;499210;505875;534773;46174.30738538992;46390;48097;48344.75827620839;48558.5144148554;51916.48083519116;52466.73766631143;52558;52788.73605632101;53159.73420132875;43116.35325470183;43384.566154339314;43429;43875;45254;42425.78787106045;43219.56780432281;43456.34815477834;43870.89053220394;44341.33487997618;44880.32679509745;45669.54330456786;46164.53835461602;46383.3042504356;46518.534814652776;36454;39404.408933865445;39713.80143099266;40053.59946400499;40622.59377406188;29562.408751825275;30368.57051435924;30624.540631890985;30650.386992259584;30729.231769205948 18:28:18 INFO - PROCESS | 15931 | |2;jquery.html;415.69446456854223;415.74016239850096;424.6602717825739;425.90204253021807;443.1314623338257;18527.907360463196;19510.82935023898;20247.898760506214;20288.492787680298;20437.38687839367;19305.517362065955;19671.5082122947;19765.50586235345;20084.196632134735;20103.698444523343;5157.4842515748405;5339.919901201466;5381.219723140142;5467.125259958408;5473.042217611922;5321.8403447896435;5427.294451721271;5455.481729235717;5459.563234941195;5464.098423760095;5498.80754173604;5531.115021596545;5540.196671482632;5540.252065971103;5541.750621222055;5355.544778693816;5501.587380946445;5541.0580201365865;5542.584306177053;5543.1408131739645;5433.293671822677;5434.91847622286;5437.483439073281;5437.673739575638;5441.646292990943;14687.77968330476;14960.40158393663;15066.698666026728;15178.165200913945;15208.315625796866;2273.499830037389;2312.8959196836013;2517.937051573707;2584.780293675021;3014.969850301513;10733.892661073367;10754.623588174376;11040.33757974524;11273.943630281796;11329.660110196624;1952.4142757172792;1974.6050789842088;1987.125664707524;2042.4893776555862;2064.0814837397365;85582;88579.11420885773;89293;90237;91206;11407.828882566768;11430.428478576037;11526.193166478433;11542.59600913964;11844.822327665092;16070;16137.677246455005;16146.515604531884;16161.11113888724;16181.838181618268;8399.160083991552;8415.579221038923;8465.449745766506;8589.226969572768;8771.956140219258;8128.512289262663;8216.21945915137;8349.95825020871;8565.743027709179;8581.656733730706;4898.853034408902;4992.625553083533;5024.799008039638;5061.569766569883;5089.109405853961;2011.9195232190548;2073.6267471855213;2074.2429013409997;2079.376187143851;2081.6357137500877;895.6283142495921;975.5805003848413;977.6480467031863;1001.7095042437758;1010.8534262532039;19702.70445943312;20007;20042.198312067645;20172;20218.898905505674;964.9324547281623;978.3836183204678;989.5448093876753;1031.9638812641522;1062.3519653011656;10520.736981575521;11049;11235.775284494428;11246.268992515461;11252.15608829341;461739;467267;469292;476319;477691;95636;97311.51344243233;99922;100761.48096297505;101015;968.7287559483356;974.9512524373753;990.5245482168599;999.3204620857887;1023.9795204095876;17190.484285471455;17711;17993.73009404886;18047;18100.637987240443;43997.56002440063;44457.77771111124;44635;44982;45460;56692.71653641705;59894.401055990624;60466.69766651138;60860.69569652124;61199.08201377072;11528.193026488065;12442.875571244173;12689.936550317188;13076.346182691017;13212;14024.439022438988;14194;14425.278736062945;14446.566603001927;14667.339969701176;11995.1003674723;12061.457234424648;12246.693832653898;12545.560905368267;12584.74830503403;12225.960793332666;12582.937085314516;12761.872381276069;12780.808287875503;12799.680007999874;9117.817643647222;12489.250644961332;12610.495580177057;12751.936240318739;13147.802782958455;12968.35158242103;12973.221606703628;13063.346832658519;13083.345832708517;13176.209427434385;12324.630261092181;12382.938085309515;12460.190087644636;12681.161231621547;12689.619311420673 18:28:18 INFO - PROCESS | 15931 | |3;mootools.html;1358.7622166120927;1525.2068924159437;1531.5832854609484;1659.5436255029865;1830.0483748450815;7683.807904802383;8378.91621083789;8627.525486098279;8713.215810577054;8902;8781.253593444564;8847.071057538946;8850.601722922467;8861.069587693297;8865.157810008039;2442.4992876460283;2469.2839076667833;2469.925902222936;2473.8144639152047;2478.281298423455;2390.7011623547055;2457.0294733580313;2464.8890799914047;2467.0748469324003;2469.4567195217023;2430.0765709030543;2441.4872876695913;2472.6043832986725;2476.071473197551;2477.430191056058;2386.140989243871;2415.577273977056;2423.8182136339847;2431.234161239204;2448.6449464827588;2383.475635360218;2408.5303365843492;2418.661387405747;2428.040923835093;2429;8593.871091933563;8622.31021518277;8693;8775.122487751174;8785.385023048326;5302.787888484495;5435.945640543583;5453.590980676465;5469.988052210314;5472.7263636818;3539.94690079649;3594.4788005739283;3652.6712595866497;3673.448982652597;3701.167237371597;1201.411308458849;1203.9638810835688;1239;1244.5519612939336;1271.9809202861964;11846.940765296118;12122.151449398545;12128.332941688204;12132.090093242954;12158.756824863452;4780.163471392492;4902.48523904992;4908.558229759267;4931.605471562267;4985.651004429655;10541.789164216672;10553.84169237462;10554.841677374845;10562;10594.31136976094;5579.804706835242;5580.525655319262;5584.497395234448;5586;5590.161475778666;4324.200022995756;4449.421575195269;4531.13908357411;5058.873528161826;5155.871103222375;4192.140611174702;4204.852830150991;4259.87220383389;4295.119500502389;4352.1948439538155;1348.9141241300651;1367.5828872194077;1379.682672985219;1381.3300549233613;1384.9723005539834;957.5068839547639;1000.6347683095763;1015.4364327798143;1019.8266294729914;1022.1107636356269;5722.713864306768;5724.856878577985;5882.411758824169;6133.172021777093;6170.382961703884;894.6332003878379;921.3780698028804;955.2310390135868;967.4823969176598;968.3947532792005;3810.447485114643;4194.559571244975;4234.280172370704;4237.512686041083;4286.421333120051;10782.838257426145;11278.718032049264;11297.661070167907;11301.660950171508;11317.320960742381;11118.22172447937;11231.26996745209;11239.550417983353;11274.436278186058;11295.717607059889;7842.960785196037;8326.292265157408;8338.374621903382;8355.122712115262;8367.916320836714;5746.655200687972;5863.736131874161;5869;5902.557308201988;6054.545909056927;10439.321444106108;10445.738856528647;10460.163186944874;10550.472476376304;10576.312539684895;8907.599158037774;9550.761230969003;10522.947385263025;10584.576616935236;10719.464026798785;7615.238476152341;7835.216478352119;7851.960740196262;7855.7250496232355;7866.7639970800965;8290.668373265244;8340.332773378237;8345.95827020861;8347.2487476125;8374.874376884474;7637.198094200251;7848.686052557834;7881.763547093597;7911.446198766262;7987.281144697005;7500.887486687813;7571.3564347031115;7597.088349398107;7690.6539205737;7831.647575859214;7033.120859892513;7146;7148.142222933281;7149.0706208192605;7165.534240274365;4931.50684931504;5100.285959965534;5106.463821298858;5146.871328216825;5327.840164795062;5029.874253143701;5058.9494105058475;5116.1046816806165;5161.509656582619;5375.919361209507 18:28:18 INFO - PROCESS | 15931 | |4;prototype.html;347.72182254196645;352.6649682801338;352.87784844195465;356.7681007345227;360.8809092999312;5308.416074231836;5315.511656736116;5355.437679043703;5372;5374.328208973879;5273.34083239595;5286.2070689396605;5299.8410047698535;5305.283786688796;5309.044372013036;3956;4002.7998600070027;4157.376393540962;4162.398500936914;4195.790210489478;4169.228692691861;4181.268278051344;4182.950354326388;4188.350805625133;4200.579942005806;4162.8126734296875;4165.354370072643;4170.958290417103;4182.309918863399;4184.225918205142;3885.669718073967;4003.639672429481;4142.627163555295;4155.480564929384;4179.1432756284885;3729.2030976767423;3732.832022558964;3736.505397840858;3743.5507739071486;3754.699624030071;5191.792328306863;5194.818181363634;5206.635535512516;5212.9739351303;5219.947800521984;4525.303011370736;4730.62155027597;4736.9526304736855;4740.454847692525;4814.975925120387;5500.614956953015;5508.641938274;5514.035043867307;5516.365617953947;5536.695481748502;4042.7776472294013;4050.9594904050878;4057.756534607933;4058.857939972116;4070.8982275443054;5555.555555555546;5684.459976302244;5733.569982251348;5742.971285143548;5749.3388260350175;4128.855490057834;4128.979355103205;4130.690198235145;4131.938020929689;4147.585241475888;4173;4197.790110494463;4199.118185181146;4201.558836322203;4204.306289462204;4600.838970636011;4689.6248300136585;4729.6250967855285;4777.420193095759;4793.544613261734;5465.234867118606;5534.723263836792;5559.2217089606675;5566.832995010156;5571.582131340166;1373.587923622909;1389.5201610285014;1401.495461633811;1405.1779708870424;1406.1282005156868;913.9040400757958;930.2743859789375;966.5843687214425;979.5200351827696;982.7444864335324;5088.872778180576;5257.765449683869;5414.8917021659345;5449.700266485302;5470.398256191816;5754.74103665336;5756.856078598069;5761.884762304814;5767.36558978512;5808.825735227865;5179.249008893689;5325.4674532547215;5384.5692344612335;5473.2063850741415;5478.287822583039;2890.612505997133;2918.576806363108;2938.4270067336665;2949.454350945039;2957.7338039576543;5657.405972372924;5664.575156863251;5694.231278777312;5702.0021496238;5716.771329146787;5388.892222155613;5552.472515111058;5573.888522229533;5586.804461843816;5633.802816901389;5607.49532542065;5640.294963129609;5642;5656.832173982583;5702.401247868914;5322.228276899906;5490.203920431435;5497.5601951842955;5536.750846211849;5558.333000040021;5389.757460914347;5435.673859568438;5451.836444906659;5455.754491047833;5484.753186106555;5718.884012915248;5729.341125770423;5732.369439361583;5742.856428589319;5750.102466186232;3862.5751167372127;4008.3787013011865;4008.6191811777835;4115.588441155861;4149.211649786531;5624.3250809903075;5624.550035997192;5634.605577609528;5661.207430959751;5665.405132461032;5518.751656175562;5541.113421852484;5555.777768889199;5610.551155907436;5620.381758006534;5494.80768173112;5535.501804837423;5574.247476590608;5578.107502799533;5583.860403489945;5536.501714845684;5558.694271815089;5566.832995010156;5571.832845014656;5582;5406.486383793691;5478.45215478449;5491.972540137273;5628.493435590653;5637.0552159504905;5518.978988887069;5522.779088836402;5524.751386187711;5526.364468086222;5530.723463826712 18:28:18 INFO - PROCESS | 15931 | |5;yui.html;776.4758787818221;782.6986610155088;814.8166662500936;825.9380546459017;882.67341083799;14689.853101468982;15248.161351125698;15715.921420392882;15978.440754573563;16031.51905442837;13437.260950647711;14125.293735313244;14885.702285954274;15081.396744130248;15082.622934426618;832.7376876283967;864.3733293362325;871.5206636349982;871.7428358634218;871.7559083456642;869.0483920107472;874.3573473497006;875.3303722652176;875.5359659380539;875.6234819027816;911.3666002128523;912.0286894457381;912.2109375390273;912.3795818843184;912.4251721415499;902.2060586683676;903.0382642485731;903.8418276801533;903.941243819153;904.109452189596;660.1714847865898;664.7008846019311;666.9466442684623;667.0461240426189;667.396006614015;13357.198568085849;13407;14527.12837229759;14727.484538041224;14843.851561484355;14138.50515231962;14416.42334306637;14684.192369419678;14730.337134828958;14777;11957.10321725874;12025.63923082309;12125.333106679129;12301.630951071393;12326.938365308117;3742.3450896093077;3752.287065457582;3760.4810705513905;3780.9432858507143;3828.0429892526868;46354;47373;53569.73215133899;59594;65354.67322663404;11580.420978951019;11805.291682499077;11835.875591818763;11840.585579504675;12018.519259229708;19847.503812404517;20339.796602034086;20355.185792568132;20549.178032878815;20635.277765278443;8078;8404.747857564284;9020.594073266719;9083.454992700326;9269.95365023184;4767.284907263869;4799.448063472675;4886.53577910098;4918.311436398907;4993.825216117419;3619.4208926571623;3732.3654978653694;3734.9626503735158;3740.0649837540614;3746.138388170736;663.2405895249912;670.8021133765551;675.3145557259386;687.5290426058166;691.4502970138752;743.5687301365195;754.1176823116966;755.6561764397186;763.5266134996338;768.8961990131372;9086.363954523253;9711.125998660154;9792.902070979342;10211.336263142872;10213.948930255301;762.1654288554024;774.1252384805247;784.8901153838467;790.3637571754792;794.1859593916282;4765.213739732905;4884.3161957326;4958.57852082577;4962.305277261186;4983.526564976321;55357;81558;87563.56218218867;90187;91826.54086729523;50801.74599126981;65513.67243163754;77761.61119194368;79664.60167699124;82637;51524;65114;65706.99999999904;66523;66642;9570.521473926416;9607.807843843224;9718.659846905324;9878.25913056538;10110.545025473724;44845.32732009088;45639;46128.30807537823;46262.53737462583;46740.06519869652;44119;53535.732321338146;53536.46463535315;54714.905701886535;59195.704021479614;12983.675408114872;13224.801627975396;13305.66735831612;13404;13534.390952406968;14759;14963;15069.171195584348;15095.622609434851;16027.679446411239;13757.449702011807;13839.308034598029;13920.651983700489;14225.359858806585;14326.355314010687;13410.798838017243;14107.153570785786;14318.642033949234;14429.42282308696;14515.564533064025;13706.862931370559;14151.363188656329;14229.359678814271;14237;14282.857171428153;10897.945510272399;11219.775604488028;11428.428578571204;11476.885231147582;12106;11935.164538482222;11976.46105925218;11996.460159292677;12092.455839487067;12281.324527151093 18:28:18 INFO - PROCESS | 15931 | __end_tp_report 18:28:18 INFO - PROCESS | 15931 | __start_cc_report 18:28:18 INFO - PROCESS | 15931 | _x_x_mozilla_cycle_collect,1058 18:28:18 INFO - PROCESS | 15931 | __end_cc_report 18:28:18 INFO - PROCESS | 15931 | __startTimestamp1486434498965__endTimestamp 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | ------- Summary: start ------- 18:28:18 INFO - PROCESS | 15931 | Number of tests: 6 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#0] dojo.html Cycles:165 Average:5613.46 Median:5819.68 stddev:644.19 (11.1%) stddev-sans-first:619.01 18:28:18 INFO - PROCESS | 15931 | Values: 3254.3 3280.1 3285.6 3304.8 3331.7 5558.2 5638.1 5645.9 5663.6 5679.4 5627.6 5655.2 5655.5 5668.9 5707.8 5075.2 5082.6 5096.5 5100.2 5185.4 4998.8 5005.8 5192.9 5195.8 5218.6 5060.2 5084.8 5111.0 5114.0 5145.0 5178.4 5184.2 5253.3 5254.0 5280.4 4875.9 5104.2 5124.4 5183.7 5200.4 5475.2 5510.0 5550.1 5567.3 5575.6 5950.9 5962.2 6092.8 6092.8 6100.9 5843.7 6136.8 6137.5 6139.6 6156.0 5484.9 5614.2 5684.3 5704.2 5749.1 6239.7 6247.8 6249.3 6257.7 6263.5 5708.6 5993.8 5994.1 5999.7 6003.4 5843.5 5932.9 6002.6 6008.1 6097.3 6022.5 6024.4 6033.7 6036.5 6041.8 6021.7 6068.0 6077.1 6077.1 6095.4 4526.3 4549.8 4585.6 4605.9 4610.5 4126.1 4135.9 4138.0 4148.9 4155.1 5687.0 5696.6 5697.0 5699.7 5700.2 5887.8 5912.4 5954.6 6027.9 6039.8 5700.7 5703.6 5706.6 5725.5 5744.5 5183.3 5204.9 5205.0 5205.2 5206.8 6117.5 6183.7 6193.8 6214.6 6245.3 6038.5 6133.5 6133.9 6134.1 6140.6 6392.4 6399.1 6403.2 6406.5 6408.7 5713.7 5744.7 5996.6 5999.1 6006.2 6007.2 6042.3 6066.6 6129.1 6131.7 5902.4 5954.8 5960.8 5964.3 5968.3 5678.3 5957.3 5963.6 5965.4 5969.9 5761.2 5819.7 5868.4 5877.4 5981.3 5964.3 5978.2 5984.1 5986.4 5991.3 5588.0 5655.4 5824.6 5832.8 5837.7 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#1] ext.html Cycles:180 Average:63889.32 Median:41354.48 stddev:125759.82 (304.1%) stddev-sans-first:126022.81 18:28:18 INFO - PROCESS | 15931 | Values: 590.6 614.4 635.3 636.4 652.7 34568.0 37013.0 37032.3 46618.0 48030.5 48440.8 48813.5 48839.0 48968.0 48968.3 8956.9 9106.0 9115.3 9119.9 9123.3 8472.6 8680.5 8694.6 8842.6 9028.7 10714.9 11066.3 11070.6 11255.9 11283.7 10806.4 10868.1 10877.6 10880.6 10890.8 10876.1 10939.1 10939.6 10941.3 10942.8 44378.8 44828.0 44846.0 44917.6 44943.0 3639.5 3731.2 3733.3 3979.9 4276.9 33758.5 33820.5 34193.7 34254.1 35049.1 4081.1 4205.5 4218.1 4321.4 4326.6 355981.2 357029.0 357183.0 359783.0 359927.0 61572.7 61809.7 61821.4 61953.7 62025.0 40905.0 41308.2 41400.8 65452.0 65777.0 19194.5 19708.5 19715.1 19715.4 19741.6 14965.6 15083.4 15095.2 15097.0 15098.5 18673.3 18750.5 19615.6 20253.8 20506.8 7022.6 7343.2 7443.3 7453.9 7532.5 990.2 1071.8 1085.2 1092.4 1140.6 33989.5 34633.8 34645.8 34846.0 35293.6 1092.4 1114.8 1117.5 1146.1 1150.7 14630.7 17350.1 17773.4 18585.4 18832.8 419501.0 602968.0 607231.0 607567.0 609916.0 57350.1 57906.4 57970.0 62217.7 62283.7 1410.2 1447.5 1471.9 1474.9 1483.3 32766.3 34712.5 35157.8 35391.0 35717.8 55566.2 56255.7 56331.0 56389.4 56414.0 380864.0 384889.0 499210.0 505875.0 534773.0 46174.3 46390.0 48097.0 48344.8 48558.5 51916.5 52466.7 52558.0 52788.7 53159.7 43116.4 43384.6 43429.0 43875.0 45254.0 42425.8 43219.6 43456.3 43870.9 44341.3 44880.3 45669.5 46164.5 46383.3 46518.5 36454.0 39404.4 39713.8 40053.6 40622.6 29562.4 30368.6 30624.5 30650.4 30729.2 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#2] jquery.html Cycles:180 Average:29270.33 Median:11250.73 stddev:77975.14 (693.1%) stddev-sans-first:78163.79 18:28:18 INFO - PROCESS | 15931 | Values: 415.7 415.7 424.7 425.9 443.1 18527.9 19510.8 20247.9 20288.5 20437.4 19305.5 19671.5 19765.5 20084.2 20103.7 5157.5 5339.9 5381.2 5467.1 5473.0 5321.8 5427.3 5455.5 5459.6 5464.1 5498.8 5531.1 5540.2 5540.3 5541.8 5355.5 5501.6 5541.1 5542.6 5543.1 5433.3 5434.9 5437.5 5437.7 5441.6 14687.8 14960.4 15066.7 15178.2 15208.3 2273.5 2312.9 2517.9 2584.8 3015.0 10733.9 10754.6 11040.3 11273.9 11329.7 1952.4 1974.6 1987.1 2042.5 2064.1 85582.0 88579.1 89293.0 90237.0 91206.0 11407.8 11430.4 11526.2 11542.6 11844.8 16070.0 16137.7 16146.5 16161.1 16181.8 8399.2 8415.6 8465.4 8589.2 8772.0 8128.5 8216.2 8350.0 8565.7 8581.7 4898.9 4992.6 5024.8 5061.6 5089.1 2011.9 2073.6 2074.2 2079.4 2081.6 895.6 975.6 977.6 1001.7 1010.9 19702.7 20007.0 20042.2 20172.0 20218.9 964.9 978.4 989.5 1032.0 1062.4 10520.7 11049.0 11235.8 11246.3 11252.2 461739.0 467267.0 469292.0 476319.0 477691.0 95636.0 97311.5 99922.0 100761.5 101015.0 968.7 975.0 990.5 999.3 1024.0 17190.5 17711.0 17993.7 18047.0 18100.6 43997.6 44457.8 44635.0 44982.0 45460.0 56692.7 59894.4 60466.7 60860.7 61199.1 11528.2 12442.9 12689.9 13076.3 13212.0 14024.4 14194.0 14425.3 14446.6 14667.3 11995.1 12061.5 12246.7 12545.6 12584.7 12226.0 12582.9 12761.9 12780.8 12799.7 9117.8 12489.3 12610.5 12751.9 13147.8 12968.4 12973.2 13063.3 13083.3 13176.2 12324.6 12382.9 12460.2 12681.2 12689.6 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#3] mootools.html Cycles:180 Average:5880.93 Median:4841.32 stddev:3285.24 (67.9%) stddev-sans-first:3276.88 18:28:18 INFO - PROCESS | 15931 | Values: 1358.8 1525.2 1531.6 1659.5 1830.0 7683.8 8378.9 8627.5 8713.2 8902.0 8781.3 8847.1 8850.6 8861.1 8865.2 2442.5 2469.3 2469.9 2473.8 2478.3 2390.7 2457.0 2464.9 2467.1 2469.5 2430.1 2441.5 2472.6 2476.1 2477.4 2386.1 2415.6 2423.8 2431.2 2448.6 2383.5 2408.5 2418.7 2428.0 2429.0 8593.9 8622.3 8693.0 8775.1 8785.4 5302.8 5435.9 5453.6 5470.0 5472.7 3539.9 3594.5 3652.7 3673.4 3701.2 1201.4 1204.0 1239.0 1244.6 1272.0 11846.9 12122.2 12128.3 12132.1 12158.8 4780.2 4902.5 4908.6 4931.6 4985.7 10541.8 10553.8 10554.8 10562.0 10594.3 5579.8 5580.5 5584.5 5586.0 5590.2 4324.2 4449.4 4531.1 5058.9 5155.9 4192.1 4204.9 4259.9 4295.1 4352.2 1348.9 1367.6 1379.7 1381.3 1385.0 957.5 1000.6 1015.4 1019.8 1022.1 5722.7 5724.9 5882.4 6133.2 6170.4 894.6 921.4 955.2 967.5 968.4 3810.4 4194.6 4234.3 4237.5 4286.4 10782.8 11278.7 11297.7 11301.7 11317.3 11118.2 11231.3 11239.6 11274.4 11295.7 7843.0 8326.3 8338.4 8355.1 8367.9 5746.7 5863.7 5869.0 5902.6 6054.5 10439.3 10445.7 10460.2 10550.5 10576.3 8907.6 9550.8 10522.9 10584.6 10719.5 7615.2 7835.2 7852.0 7855.7 7866.8 8290.7 8340.3 8346.0 8347.2 8374.9 7637.2 7848.7 7881.8 7911.4 7987.3 7500.9 7571.4 7597.1 7690.7 7831.6 7033.1 7146.0 7148.1 7149.1 7165.5 4931.5 5100.3 5106.5 5146.9 5327.8 5029.9 5058.9 5116.1 5161.5 5375.9 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#4] prototype.html Cycles:180 Average:4659.27 Median:5386.73 stddev:1351.36 (25.1%) stddev-sans-first:1315.83 18:28:18 INFO - PROCESS | 15931 | Values: 347.7 352.7 352.9 356.8 360.9 5308.4 5315.5 5355.4 5372.0 5374.3 5273.3 5286.2 5299.8 5305.3 5309.0 3956.0 4002.8 4157.4 4162.4 4195.8 4169.2 4181.3 4183.0 4188.4 4200.6 4162.8 4165.4 4171.0 4182.3 4184.2 3885.7 4003.6 4142.6 4155.5 4179.1 3729.2 3732.8 3736.5 3743.6 3754.7 5191.8 5194.8 5206.6 5213.0 5219.9 4525.3 4730.6 4737.0 4740.5 4815.0 5500.6 5508.6 5514.0 5516.4 5536.7 4042.8 4051.0 4057.8 4058.9 4070.9 5555.6 5684.5 5733.6 5743.0 5749.3 4128.9 4129.0 4130.7 4131.9 4147.6 4173.0 4197.8 4199.1 4201.6 4204.3 4600.8 4689.6 4729.6 4777.4 4793.5 5465.2 5534.7 5559.2 5566.8 5571.6 1373.6 1389.5 1401.5 1405.2 1406.1 913.9 930.3 966.6 979.5 982.7 5088.9 5257.8 5414.9 5449.7 5470.4 5754.7 5756.9 5761.9 5767.4 5808.8 5179.2 5325.5 5384.6 5473.2 5478.3 2890.6 2918.6 2938.4 2949.5 2957.7 5657.4 5664.6 5694.2 5702.0 5716.8 5388.9 5552.5 5573.9 5586.8 5633.8 5607.5 5640.3 5642.0 5656.8 5702.4 5322.2 5490.2 5497.6 5536.8 5558.3 5389.8 5435.7 5451.8 5455.8 5484.8 5718.9 5729.3 5732.4 5742.9 5750.1 3862.6 4008.4 4008.6 4115.6 4149.2 5624.3 5624.6 5634.6 5661.2 5665.4 5518.8 5541.1 5555.8 5610.6 5620.4 5494.8 5535.5 5574.2 5578.1 5583.9 5536.5 5558.7 5566.8 5571.8 5582.0 5406.5 5478.5 5492.0 5628.5 5637.1 5519.0 5522.8 5524.8 5526.4 5530.7 18:28:18 INFO - PROCESS | 15931 | 18:28:18 INFO - PROCESS | 15931 | [#5] yui.html Cycles:180 Average:17202.07 Median:26069.11 stddev:21488.83 (82.4%) stddev-sans-first:21513.71 18:28:18 INFO - PROCESS | 15931 | Values: 776.5 782.7 814.8 825.9 882.7 14689.9 15248.2 15715.9 15978.4 16031.5 13437.3 14125.3 14885.7 15081.4 15082.6 832.7 864.4 871.5 871.7 871.8 869.0 874.4 875.3 875.5 875.6 911.4 912.0 912.2 912.4 912.4 902.2 903.0 903.8 903.9 904.1 660.2 664.7 666.9 667.0 667.4 13357.2 13407.0 14527.1 14727.5 14843.9 14138.5 14416.4 14684.2 14730.3 14777.0 11957.1 12025.6 12125.3 12301.6 12326.9 3742.3 3752.3 3760.5 3780.9 3828.0 46354.0 47373.0 53569.7 59594.0 65354.7 11580.4 11805.3 11835.9 11840.6 12018.5 19847.5 20339.8 20355.2 20549.2 20635.3 8078.0 8404.7 9020.6 9083.5 9270.0 4767.3 4799.4 4886.5 4918.3 4993.8 3619.4 3732.4 3735.0 3740.1 3746.1 663.2 670.8 675.3 687.5 691.5 743.6 754.1 755.7 763.5 768.9 9086.4 9711.1 9792.9 10211.3 10213.9 762.2 774.1 784.9 790.4 794.2 4765.2 4884.3 4958.6 4962.3 4983.5 55357.0 81558.0 87563.6 90187.0 91826.5 50801.7 65513.7 77761.6 79664.6 82637.0 51524.0 65114.0 65707.0 66523.0 66642.0 9570.5 9607.8 9718.7 9878.3 10110.5 44845.3 45639.0 46128.3 46262.5 46740.1 44119.0 53535.7 53536.5 54714.9 59195.7 12983.7 13224.8 13305.7 13404.0 13534.4 14759.0 14963.0 15069.2 15095.6 16027.7 13757.4 13839.3 13920.7 14225.4 14326.4 13410.8 14107.2 14318.6 14429.4 14515.6 13706.9 14151.4 14229.4 14237.0 14282.9 10897.9 11219.8 11428.4 11476.9 12106.0 11935.2 11976.5 11996.5 12092.5 12281.3 18:28:18 INFO - PROCESS | 15931 | -------- Summary: end -------- 18:28:18 INFO - PROCESS | 15931 | 18:28:19 INFO - TEST-INFO | 15931: exit 0 18:28:19 INFO - TEST-OK | dromaeo_css | took 1113993ms 18:28:19 INFO - TEST-START | kraken 18:28:19 INFO - operating with platform_type : linux_ 18:28:19 INFO - Initialising browser for kraken test... 18:28:19 INFO - TEST-INFO | started process 16240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7IIWWp/profile http://localhost:59064/getInfo.html) 18:28:23 INFO - PROCESS | 16240 | __metrics Screen width/height:1600/1200 18:28:23 INFO - PROCESS | 16240 | colorDepth:24 18:28:23 INFO - PROCESS | 16240 | Browser inner width/height: 1024/697 18:28:23 INFO - PROCESS | 16240 | __metrics 18:28:23 INFO - PROCESS | 16240 | 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" 18:28:23 INFO - PROCESS | 16240 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:28:24 INFO - PROCESS | 16240 | console.error: PushService: 18:28:24 INFO - PROCESS | 16240 | stateChangeProcessEnqueue: Error transitioning state 18:28:24 INFO - PROCESS | 16240 | UnknownError 18:28:24 INFO - TEST-INFO | 16240: exit 0 18:28:24 INFO - Browser initialized. 18:28:24 INFO - Running cycle 1/1 for kraken test... 18:28:24 INFO - TEST-INFO | started process 16332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7IIWWp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:36 INFO - PROCESS | 16332 | RSS: Main: 141598720 18:28:36 INFO - PROCESS | 16332 | 18:28:39 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59064/tests/kraken/driver.html?testName=audio-beat-detection) 18:28:40 INFO - PROCESS | 16332 | RSS: Main: 183582720 18:28:40 INFO - PROCESS | 16332 | 18:28:42 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59064/tests/kraken/driver.html?testName=audio-dft) 18:28:43 INFO - PROCESS | 16332 | RSS: Main: 173543424 18:28:43 INFO - PROCESS | 16332 | 18:28:45 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59064/tests/kraken/driver.html?testName=audio-fft) 18:28:46 INFO - PROCESS | 16332 | RSS: Main: 264105984 18:28:46 INFO - PROCESS | 16332 | 18:28:48 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59064/tests/kraken/driver.html?testName=audio-oscillator) 18:28:49 INFO - PROCESS | 16332 | RSS: Main: 171393024 18:28:49 INFO - PROCESS | 16332 | 18:28:51 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:28:51 INFO - PROCESS | 16332 | RSS: Main: 173735936 18:28:51 INFO - PROCESS | 16332 | 18:28:54 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59064/tests/kraken/driver.html?testName=imaging-darkroom) 18:28:55 INFO - PROCESS | 16332 | RSS: Main: 211824640 18:28:55 INFO - PROCESS | 16332 | 18:28:58 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59064/tests/kraken/driver.html?testName=imaging-desaturate) 18:28:59 INFO - PROCESS | 16332 | RSS: Main: 211193856 18:28:59 INFO - PROCESS | 16332 | 18:29:01 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59064/tests/kraken/driver.html?testName=json-parse-financial) 18:29:02 INFO - PROCESS | 16332 | RSS: Main: 209186816 18:29:02 INFO - PROCESS | 16332 | 18:29:03 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:29:04 INFO - PROCESS | 16332 | RSS: Main: 171134976 18:29:04 INFO - PROCESS | 16332 | 18:29:06 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:29:06 INFO - PROCESS | 16332 | RSS: Main: 179138560 18:29:06 INFO - PROCESS | 16332 | 18:29:08 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:29:09 INFO - PROCESS | 16332 | RSS: Main: 187940864 18:29:09 INFO - PROCESS | 16332 | 18:29:11 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:29:12 INFO - PROCESS | 16332 | RSS: Main: 195981312 18:29:12 INFO - PROCESS | 16332 | 18:29:15 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:29:15 INFO - PROCESS | 16332 | RSS: Main: 192413696 18:29:15 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | Cycle 1(1): loaded http://localhost:59064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59064/tests/kraken/driver.html?testName=ai-astar) 18:29:17 INFO - PROCESS | 16332 | RSS: Main: 243929088 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | __start_tp_report 18:29:17 INFO - PROCESS | 16332 | _x_x_mozilla_page_load 18:29:17 INFO - PROCESS | 16332 | _x_x_mozilla_page_load_details 18:29:17 INFO - PROCESS | 16332 | |i|pagename|runs| 18:29:17 INFO - PROCESS | 16332 | |0;ai-astar;101;112;112;110;111;110;110;110;110;111 18:29:17 INFO - PROCESS | 16332 | |1;audio-beat-detection;144;117;118;153;122;116;120;122;148;122 18:29:17 INFO - PROCESS | 16332 | |2;audio-dft;162;161;164;162;160;162;159;161;158;158 18:29:17 INFO - PROCESS | 16332 | |3;audio-fft;74;76;74;112;76;76;75;77;113;76 18:29:17 INFO - PROCESS | 16332 | |4;audio-oscillator;82;82;109;82;82;82;98;82;82;111 18:29:17 INFO - PROCESS | 16332 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;116;119;116 18:29:17 INFO - PROCESS | 16332 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;146;145 18:29:17 INFO - PROCESS | 16332 | |7;imaging-desaturate;85;85;85;84;85;85;85;85;84;85 18:29:17 INFO - PROCESS | 16332 | |8;json-parse-financial;51;49;50;52;50;49;49;51;50;49 18:29:17 INFO - PROCESS | 16332 | |9;json-stringify-tinderbox;58;58;58;58;59;59;60;59;58;58 18:29:17 INFO - PROCESS | 16332 | |10;stanford-crypto-aes;75;73;83;80;75;75;75;77;73;74 18:29:17 INFO - PROCESS | 16332 | |11;stanford-crypto-ccm;126;127;126;125;120;119;125;130;161;124 18:29:17 INFO - PROCESS | 16332 | |12;stanford-crypto-pbkdf2;155;156;157;153;158;154;159;158;160;152 18:29:17 INFO - PROCESS | 16332 | |13;stanford-crypto-sha256-iterative;62;62;61;61;62;66;61;62;63;62 18:29:17 INFO - PROCESS | 16332 | __end_tp_report 18:29:17 INFO - PROCESS | 16332 | __start_cc_report 18:29:17 INFO - PROCESS | 16332 | _x_x_mozilla_cycle_collect,1552 18:29:17 INFO - PROCESS | 16332 | __end_cc_report 18:29:17 INFO - PROCESS | 16332 | __startTimestamp1486434557828__endTimestamp 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | ------- Summary: start ------- 18:29:17 INFO - PROCESS | 16332 | Number of tests: 14 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:3.16 (2.9%) stddev-sans-first:0.87 18:29:17 INFO - PROCESS | 16332 | Values: 101.0 112.0 112.0 110.0 111.0 110.0 110.0 110.0 110.0 111.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:122.00 stddev:14.21 (11.6%) stddev-sans-first:13.88 18:29:17 INFO - PROCESS | 16332 | Values: 144.0 117.0 118.0 153.0 122.0 116.0 120.0 122.0 148.0 122.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.50 stddev:1.95 (1.2%) stddev-sans-first:2.01 18:29:17 INFO - PROCESS | 16332 | Values: 162.0 161.0 164.0 162.0 160.0 162.0 159.0 161.0 158.0 158.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:15.63 (20.6%) stddev-sans-first:16.24 18:29:17 INFO - PROCESS | 16332 | Values: 74.0 76.0 74.0 112.0 76.0 76.0 75.0 77.0 113.0 76.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:12.05 (14.7%) stddev-sans-first:12.50 18:29:17 INFO - PROCESS | 16332 | Values: 82.0 82.0 109.0 82.0 82.0 82.0 98.0 82.0 82.0 111.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 18:29:17 INFO - PROCESS | 16332 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 119.0 116.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 18:29:17 INFO - PROCESS | 16332 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 18:29:17 INFO - PROCESS | 16332 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 85.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:1.05 (2.1%) stddev-sans-first:1.05 18:29:17 INFO - PROCESS | 16332 | Values: 51.0 49.0 50.0 52.0 50.0 49.0 49.0 51.0 50.0 49.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 18:29:17 INFO - PROCESS | 16332 | Values: 58.0 58.0 58.0 58.0 59.0 59.0 60.0 59.0 58.0 58.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:3.20 (4.3%) stddev-sans-first:3.37 18:29:17 INFO - PROCESS | 16332 | Values: 75.0 73.0 83.0 80.0 75.0 75.0 75.0 77.0 73.0 74.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.00 stddev:11.93 (9.5%) stddev-sans-first:12.62 18:29:17 INFO - PROCESS | 16332 | Values: 126.0 127.0 126.0 125.0 120.0 119.0 125.0 130.0 161.0 124.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.50 stddev:2.66 (1.7%) stddev-sans-first:2.78 18:29:17 INFO - PROCESS | 16332 | Values: 155.0 156.0 157.0 153.0 158.0 154.0 159.0 158.0 160.0 152.0 18:29:17 INFO - PROCESS | 16332 | 18:29:17 INFO - PROCESS | 16332 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.56 18:29:17 INFO - PROCESS | 16332 | Values: 62.0 62.0 61.0 61.0 62.0 66.0 61.0 62.0 63.0 62.0 18:29:17 INFO - PROCESS | 16332 | -------- Summary: end -------- 18:29:17 INFO - PROCESS | 16332 | 18:29:18 INFO - TEST-INFO | 16332: exit 0 18:29:18 INFO - TEST-OK | kraken | took 59171ms 18:29:18 INFO - SUITE-END | took 1173s 18:29:18 INFO - Completed test suite (00:19:33) 18:29:18 INFO - javascript benchmark 18:29:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.316593515361, 3280.147161737949, 3285.556449879267, 3304.801711897288, 3331.650176731443, 5558.249636299103, 5638.097904335307, 5645.887082258352, 5663.6318639288465, 5679.432056794319, 5627.577931655132, 5655.1517272409155, 5655.4910058094765, 5668.886622267552, 5707.77168913243, 5075.187969924813, 5082.644214904958, 5096.490350964892, 5100.20946753252, 5185.403678576955, 4998.750062496879, 5005.824796132136, 5192.948070519303, 5195.818146364878, 5218.582513398938, 5060.2156665716875, 5084.84745457635, 5110.974445127769, 5114.0, 5144.974275128619, 5178.40448348441, 5184.2223666450145, 5253.343332083451, 5253.973730131325, 5280.419153893107, 4875.8781030474165, 5104.183330667112, 5124.359455068116, 5183.663061900965, 5200.401953775327, 5475.151351540518, 5510.0, 5550.111982082888, 5567.2762540869835, 5575.553955683536, 5950.940490595125, 5962.195103661037, 6092.786752463642, 6092.786752463687, 6100.908486372708, 5843.737031833578, 6136.7852125175405, 6137.478314343241, 6139.631622102688, 6155.953487907066, 5484.930438564482, 5614.242077319591, 5684.289463817023, 5704.201411802351, 5749.108888122348, 6239.719212635442, 6247.843803904848, 6249.312575616678, 6257.655828929362, 6263.530235232376, 5708.628939118944, 5993.820185394445, 5994.100884867305, 5999.670018148957, 6003.3996600339615, 5843.532517398683, 5932.940670593325, 6002.639841609517, 6008.09878518217, 6097.298810636745, 6022.518198544106, 6024.3975602439405, 6033.728482218311, 6036.517078633787, 6041.758329666852, 6021.729022194012, 6068.029115341524, 6077.058056001327, 6077.058056001327, 6095.35998720128, 4526.275795872644, 4549.818007279738, 4585.6102231310715, 4605.884852878705, 4610.4697959734385, 4126.09225970286, 4135.937960930589, 4137.97931010343, 4148.875533733993, 4155.065110350208, 5687.0, 5696.629719068247, 5697.0, 5699.74351154199, 5700.173474846124, 5887.764489420375, 5912.438318359835, 5954.612950158225, 6027.8794424111275, 6039.818805435844, 5700.743466544015, 5703.572232082611, 5706.572007099484, 5725.456081672234, 5744.540436765049, 5183.326167598264, 5204.947950520522, 5205.011047900886, 5205.167173252337, 5206.843794686166, 6117.4620395853735, 6183.659898705524, 6193.81418557444, 6214.5960512566535, 6245.344238854946, 6038.5169186465855, 6133.487685122301, 6133.946794548733, 6134.069235337404, 6140.565599444434, 6392.360763923756, 6399.072134540559, 6403.167588213502, 6406.519511036598, 6408.743650253938, 5713.714314284186, 5744.684042377709, 5996.5502587305255, 5999.130126131599, 6006.189164462917, 6007.219061522149, 6042.274927008787, 6066.575339726177, 6129.053167990421, 6131.743695906945, 5902.350741418355, 5954.76180952757, 5960.821175364746, 5964.343922168645, 5968.313643931004, 5678.290213723285, 5957.285125784933, 5963.552733544915, 5965.403459654, 5969.91045134332, 5761.164631128547, 5819.679917604403, 5868.38381969887, 5877.353491115889, 5981.252343457068, 5964.314103877936, 5978.192943952685, 5984.13230081627, 5986.4013598639785, 5991.310999234969, 5587.972060139673, 5655.4344565543115, 5824.621399609012, 5832.766689332379, 5837.737301821343], "value": 5569.997758542809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.630855715178, 614.42858141928, 635.2726128582773, 636.4431122767578, 652.6867103790183, 34568.0, 37013.0, 37032.259354812886, 46618.0, 48030.51969480304, 48440.75779621097, 48813.511864881344, 48839.0, 48968.0, 48968.265476017885, 8956.8656470153, 9106.043865394104, 9115.27077833775, 9119.908800911971, 9123.270138388913, 8472.618732157038, 8680.522571258578, 8694.565271736388, 8842.646294148226, 9028.729138125867, 10714.892851071467, 11066.28069175505, 11070.612528561502, 11255.887441125566, 11283.66149015531, 10806.405647689375, 10868.130549556017, 10877.619283325046, 10880.6191783288, 10890.782184356347, 10876.12990960729, 10939.070179034792, 10939.617113401073, 10941.343519388782, 10942.835857462145, 44378.77810610926, 44828.0, 44846.0, 44917.550824491664, 44943.0, 3639.490471334015, 3731.2164445466483, 3733.2720119576693, 3979.9204015919518, 4276.893077673052, 33758.49362259568, 33820.45929018784, 34193.658063419294, 34254.14364640879, 35049.12377190565, 4081.1429599784083, 4205.474315710536, 4218.114196018809, 4321.351797230409, 4326.5673432656795, 355981.22009390045, 357029.0, 357183.0, 359783.0, 359927.0, 61572.69213653903, 61809.69095154495, 61821.381786182465, 61953.69023154856, 62025.0, 40905.0, 41308.1738365231, 41400.79299603483, 65452.0, 65777.0, 19194.520136996685, 19708.507287317643, 19715.11281992314, 19715.408537743602, 19741.60516789685, 14965.625859353604, 15083.396664133532, 15095.169765662993, 15097.0, 15098.54704358849, 18673.346432874783, 18750.53123671919, 19615.60768784645, 20253.797462025486, 20506.79493205049, 7022.613756243456, 7343.1555371131935, 7443.255674432622, 7453.860602868228, 7532.54804711719, 990.1979396688705, 1071.8499410082595, 1085.1915323084195, 1092.3882625729616, 1140.5779861451317, 33989.490157647655, 34633.826830866186, 34645.826770866486, 34846.0, 35293.64706352904, 1092.3664274720643, 1114.8439218509416, 1117.5138814615668, 1146.0716819376332, 1150.7008177873813, 14630.707385852224, 17350.13249337528, 17773.377931772327, 18585.44243672692, 18832.811671883104, 419501.0, 602968.0, 607231.0, 607567.0, 609916.0, 57350.13974790381, 57906.42093579094, 57970.0, 62217.688911556055, 62283.6885815568, 1410.2173293821822, 1447.4933773179303, 1471.9264036798118, 1474.9336279867432, 1483.2657834372055, 32766.34467310688, 34712.479312809824, 35157.76947806814, 35390.99980570856, 35717.82141089278, 55566.16650750161, 56255.718721406134, 56331.0, 56389.436105638415, 56414.0, 380864.0, 384889.0, 499210.0, 505875.0, 534773.0, 46174.30738538992, 46390.0, 48097.0, 48344.75827620839, 48558.5144148554, 51916.48083519116, 52466.73766631143, 52558.0, 52788.73605632101, 53159.73420132875, 43116.35325470183, 43384.566154339314, 43429.0, 43875.0, 45254.0, 42425.78787106045, 43219.56780432281, 43456.34815477834, 43870.89053220394, 44341.33487997618, 44880.32679509745, 45669.54330456786, 46164.53835461602, 46383.3042504356, 46518.534814652776, 36454.0, 39404.408933865445, 39713.80143099266, 40053.59946400499, 40622.59377406188, 29562.408751825275, 30368.57051435924, 30624.540631890985, 30650.386992259584, 30729.231769205948], "value": 21716.267961239388, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.69446456854223, 415.74016239850096, 424.6602717825739, 425.90204253021807, 443.1314623338257, 18527.907360463196, 19510.82935023898, 20247.898760506214, 20288.492787680298, 20437.38687839367, 19305.517362065955, 19671.5082122947, 19765.50586235345, 20084.196632134735, 20103.698444523343, 5157.4842515748405, 5339.919901201466, 5381.219723140142, 5467.125259958408, 5473.042217611922, 5321.8403447896435, 5427.294451721271, 5455.481729235717, 5459.563234941195, 5464.098423760095, 5498.80754173604, 5531.115021596545, 5540.196671482632, 5540.252065971103, 5541.750621222055, 5355.544778693816, 5501.587380946445, 5541.0580201365865, 5542.584306177053, 5543.1408131739645, 5433.293671822677, 5434.91847622286, 5437.483439073281, 5437.673739575638, 5441.646292990943, 14687.77968330476, 14960.40158393663, 15066.698666026728, 15178.165200913945, 15208.315625796866, 2273.499830037389, 2312.8959196836013, 2517.937051573707, 2584.780293675021, 3014.969850301513, 10733.892661073367, 10754.623588174376, 11040.33757974524, 11273.943630281796, 11329.660110196624, 1952.4142757172792, 1974.6050789842088, 1987.125664707524, 2042.4893776555862, 2064.0814837397365, 85582.0, 88579.11420885773, 89293.0, 90237.0, 91206.0, 11407.828882566768, 11430.428478576037, 11526.193166478433, 11542.59600913964, 11844.822327665092, 16070.0, 16137.677246455005, 16146.515604531884, 16161.11113888724, 16181.838181618268, 8399.160083991552, 8415.579221038923, 8465.449745766506, 8589.226969572768, 8771.956140219258, 8128.512289262663, 8216.21945915137, 8349.95825020871, 8565.743027709179, 8581.656733730706, 4898.853034408902, 4992.625553083533, 5024.799008039638, 5061.569766569883, 5089.109405853961, 2011.9195232190548, 2073.6267471855213, 2074.2429013409997, 2079.376187143851, 2081.6357137500877, 895.6283142495921, 975.5805003848413, 977.6480467031863, 1001.7095042437758, 1010.8534262532039, 19702.70445943312, 20007.0, 20042.198312067645, 20172.0, 20218.898905505674, 964.9324547281623, 978.3836183204678, 989.5448093876753, 1031.9638812641522, 1062.3519653011656, 10520.736981575521, 11049.0, 11235.775284494428, 11246.268992515461, 11252.15608829341, 461739.0, 467267.0, 469292.0, 476319.0, 477691.0, 95636.0, 97311.51344243233, 99922.0, 100761.48096297505, 101015.0, 968.7287559483356, 974.9512524373753, 990.5245482168599, 999.3204620857887, 1023.9795204095876, 17190.484285471455, 17711.0, 17993.73009404886, 18047.0, 18100.637987240443, 43997.56002440063, 44457.77771111124, 44635.0, 44982.0, 45460.0, 56692.71653641705, 59894.401055990624, 60466.69766651138, 60860.69569652124, 61199.08201377072, 11528.193026488065, 12442.875571244173, 12689.936550317188, 13076.346182691017, 13212.0, 14024.439022438988, 14194.0, 14425.278736062945, 14446.566603001927, 14667.339969701176, 11995.1003674723, 12061.457234424648, 12246.693832653898, 12545.560905368267, 12584.74830503403, 12225.960793332666, 12582.937085314516, 12761.872381276069, 12780.808287875503, 12799.680007999874, 9117.817643647222, 12489.250644961332, 12610.495580177057, 12751.936240318739, 13147.802782958455, 12968.35158242103, 12973.221606703628, 13063.346832658519, 13083.345832708517, 13176.209427434385, 12324.630261092181, 12382.938085309515, 12460.190087644636, 12681.161231621547, 12689.619311420673], "value": 9585.72839173062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.7622166120927, 1525.2068924159437, 1531.5832854609484, 1659.5436255029865, 1830.0483748450815, 7683.807904802383, 8378.91621083789, 8627.525486098279, 8713.215810577054, 8902.0, 8781.253593444564, 8847.071057538946, 8850.601722922467, 8861.069587693297, 8865.157810008039, 2442.4992876460283, 2469.2839076667833, 2469.925902222936, 2473.8144639152047, 2478.281298423455, 2390.7011623547055, 2457.0294733580313, 2464.8890799914047, 2467.0748469324003, 2469.4567195217023, 2430.0765709030543, 2441.4872876695913, 2472.6043832986725, 2476.071473197551, 2477.430191056058, 2386.140989243871, 2415.577273977056, 2423.8182136339847, 2431.234161239204, 2448.6449464827588, 2383.475635360218, 2408.5303365843492, 2418.661387405747, 2428.040923835093, 2429.0, 8593.871091933563, 8622.31021518277, 8693.0, 8775.122487751174, 8785.385023048326, 5302.787888484495, 5435.945640543583, 5453.590980676465, 5469.988052210314, 5472.7263636818, 3539.94690079649, 3594.4788005739283, 3652.6712595866497, 3673.448982652597, 3701.167237371597, 1201.411308458849, 1203.9638810835688, 1239.0, 1244.5519612939336, 1271.9809202861964, 11846.940765296118, 12122.151449398545, 12128.332941688204, 12132.090093242954, 12158.756824863452, 4780.163471392492, 4902.48523904992, 4908.558229759267, 4931.605471562267, 4985.651004429655, 10541.789164216672, 10553.84169237462, 10554.841677374845, 10562.0, 10594.31136976094, 5579.804706835242, 5580.525655319262, 5584.497395234448, 5586.0, 5590.161475778666, 4324.200022995756, 4449.421575195269, 4531.13908357411, 5058.873528161826, 5155.871103222375, 4192.140611174702, 4204.852830150991, 4259.87220383389, 4295.119500502389, 4352.1948439538155, 1348.9141241300651, 1367.5828872194077, 1379.682672985219, 1381.3300549233613, 1384.9723005539834, 957.5068839547639, 1000.6347683095763, 1015.4364327798143, 1019.8266294729914, 1022.1107636356269, 5722.713864306768, 5724.856878577985, 5882.411758824169, 6133.172021777093, 6170.382961703884, 894.6332003878379, 921.3780698028804, 955.2310390135868, 967.4823969176598, 968.3947532792005, 3810.447485114643, 4194.559571244975, 4234.280172370704, 4237.512686041083, 4286.421333120051, 10782.838257426145, 11278.718032049264, 11297.661070167907, 11301.660950171508, 11317.320960742381, 11118.22172447937, 11231.26996745209, 11239.550417983353, 11274.436278186058, 11295.717607059889, 7842.960785196037, 8326.292265157408, 8338.374621903382, 8355.122712115262, 8367.916320836714, 5746.655200687972, 5863.736131874161, 5869.0, 5902.557308201988, 6054.545909056927, 10439.321444106108, 10445.738856528647, 10460.163186944874, 10550.472476376304, 10576.312539684895, 8907.599158037774, 9550.761230969003, 10522.947385263025, 10584.576616935236, 10719.464026798785, 7615.238476152341, 7835.216478352119, 7851.960740196262, 7855.7250496232355, 7866.7639970800965, 8290.668373265244, 8340.332773378237, 8345.95827020861, 8347.2487476125, 8374.874376884474, 7637.198094200251, 7848.686052557834, 7881.763547093597, 7911.446198766262, 7987.281144697005, 7500.887486687813, 7571.3564347031115, 7597.088349398107, 7690.6539205737, 7831.647575859214, 7033.120859892513, 7146.0, 7148.142222933281, 7149.0706208192605, 7165.534240274365, 4931.50684931504, 5100.285959965534, 5106.463821298858, 5146.871328216825, 5327.840164795062, 5029.874253143701, 5058.9494105058475, 5116.1046816806165, 5161.509656582619, 5375.919361209507], "value": 4750.00933207385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.72182254196645, 352.6649682801338, 352.87784844195465, 356.7681007345227, 360.8809092999312, 5308.416074231836, 5315.511656736116, 5355.437679043703, 5372.0, 5374.328208973879, 5273.34083239595, 5286.2070689396605, 5299.8410047698535, 5305.283786688796, 5309.044372013036, 3956.0, 4002.7998600070027, 4157.376393540962, 4162.398500936914, 4195.790210489478, 4169.228692691861, 4181.268278051344, 4182.950354326388, 4188.350805625133, 4200.579942005806, 4162.8126734296875, 4165.354370072643, 4170.958290417103, 4182.309918863399, 4184.225918205142, 3885.669718073967, 4003.639672429481, 4142.627163555295, 4155.480564929384, 4179.1432756284885, 3729.2030976767423, 3732.832022558964, 3736.505397840858, 3743.5507739071486, 3754.699624030071, 5191.792328306863, 5194.818181363634, 5206.635535512516, 5212.9739351303, 5219.947800521984, 4525.303011370736, 4730.62155027597, 4736.9526304736855, 4740.454847692525, 4814.975925120387, 5500.614956953015, 5508.641938274, 5514.035043867307, 5516.365617953947, 5536.695481748502, 4042.7776472294013, 4050.9594904050878, 4057.756534607933, 4058.857939972116, 4070.8982275443054, 5555.555555555546, 5684.459976302244, 5733.569982251348, 5742.971285143548, 5749.3388260350175, 4128.855490057834, 4128.979355103205, 4130.690198235145, 4131.938020929689, 4147.585241475888, 4173.0, 4197.790110494463, 4199.118185181146, 4201.558836322203, 4204.306289462204, 4600.838970636011, 4689.6248300136585, 4729.6250967855285, 4777.420193095759, 4793.544613261734, 5465.234867118606, 5534.723263836792, 5559.2217089606675, 5566.832995010156, 5571.582131340166, 1373.587923622909, 1389.5201610285014, 1401.495461633811, 1405.1779708870424, 1406.1282005156868, 913.9040400757958, 930.2743859789375, 966.5843687214425, 979.5200351827696, 982.7444864335324, 5088.872778180576, 5257.765449683869, 5414.8917021659345, 5449.700266485302, 5470.398256191816, 5754.74103665336, 5756.856078598069, 5761.884762304814, 5767.36558978512, 5808.825735227865, 5179.249008893689, 5325.4674532547215, 5384.5692344612335, 5473.2063850741415, 5478.287822583039, 2890.612505997133, 2918.576806363108, 2938.4270067336665, 2949.454350945039, 2957.7338039576543, 5657.405972372924, 5664.575156863251, 5694.231278777312, 5702.0021496238, 5716.771329146787, 5388.892222155613, 5552.472515111058, 5573.888522229533, 5586.804461843816, 5633.802816901389, 5607.49532542065, 5640.294963129609, 5642.0, 5656.832173982583, 5702.401247868914, 5322.228276899906, 5490.203920431435, 5497.5601951842955, 5536.750846211849, 5558.333000040021, 5389.757460914347, 5435.673859568438, 5451.836444906659, 5455.754491047833, 5484.753186106555, 5718.884012915248, 5729.341125770423, 5732.369439361583, 5742.856428589319, 5750.102466186232, 3862.5751167372127, 4008.3787013011865, 4008.6191811777835, 4115.588441155861, 4149.211649786531, 5624.3250809903075, 5624.550035997192, 5634.605577609528, 5661.207430959751, 5665.405132461032, 5518.751656175562, 5541.113421852484, 5555.777768889199, 5610.551155907436, 5620.381758006534, 5494.80768173112, 5535.501804837423, 5574.247476590608, 5578.107502799533, 5583.860403489945, 5536.501714845684, 5558.694271815089, 5566.832995010156, 5571.832845014656, 5582.0, 5406.486383793691, 5478.45215478449, 5491.972540137273, 5628.493435590653, 5637.0552159504905, 5518.978988887069, 5522.779088836402, 5524.751386187711, 5526.364468086222, 5530.723463826712], "value": 4233.537427805678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.4758787818221, 782.6986610155088, 814.8166662500936, 825.9380546459017, 882.67341083799, 14689.853101468982, 15248.161351125698, 15715.921420392882, 15978.440754573563, 16031.51905442837, 13437.260950647711, 14125.293735313244, 14885.702285954274, 15081.396744130248, 15082.622934426618, 832.7376876283967, 864.3733293362325, 871.5206636349982, 871.7428358634218, 871.7559083456642, 869.0483920107472, 874.3573473497006, 875.3303722652176, 875.5359659380539, 875.6234819027816, 911.3666002128523, 912.0286894457381, 912.2109375390273, 912.3795818843184, 912.4251721415499, 902.2060586683676, 903.0382642485731, 903.8418276801533, 903.941243819153, 904.109452189596, 660.1714847865898, 664.7008846019311, 666.9466442684623, 667.0461240426189, 667.396006614015, 13357.198568085849, 13407.0, 14527.12837229759, 14727.484538041224, 14843.851561484355, 14138.50515231962, 14416.42334306637, 14684.192369419678, 14730.337134828958, 14777.0, 11957.10321725874, 12025.63923082309, 12125.333106679129, 12301.630951071393, 12326.938365308117, 3742.3450896093077, 3752.287065457582, 3760.4810705513905, 3780.9432858507143, 3828.0429892526868, 46354.0, 47373.0, 53569.73215133899, 59594.0, 65354.67322663404, 11580.420978951019, 11805.291682499077, 11835.875591818763, 11840.585579504675, 12018.519259229708, 19847.503812404517, 20339.796602034086, 20355.185792568132, 20549.178032878815, 20635.277765278443, 8078.0, 8404.747857564284, 9020.594073266719, 9083.454992700326, 9269.95365023184, 4767.284907263869, 4799.448063472675, 4886.53577910098, 4918.311436398907, 4993.825216117419, 3619.4208926571623, 3732.3654978653694, 3734.9626503735158, 3740.0649837540614, 3746.138388170736, 663.2405895249912, 670.8021133765551, 675.3145557259386, 687.5290426058166, 691.4502970138752, 743.5687301365195, 754.1176823116966, 755.6561764397186, 763.5266134996338, 768.8961990131372, 9086.363954523253, 9711.125998660154, 9792.902070979342, 10211.336263142872, 10213.948930255301, 762.1654288554024, 774.1252384805247, 784.8901153838467, 790.3637571754792, 794.1859593916282, 4765.213739732905, 4884.3161957326, 4958.57852082577, 4962.305277261186, 4983.526564976321, 55357.0, 81558.0, 87563.56218218867, 90187.0, 91826.54086729523, 50801.74599126981, 65513.67243163754, 77761.61119194368, 79664.60167699124, 82637.0, 51524.0, 65114.0, 65706.99999999904, 66523.0, 66642.0, 9570.521473926416, 9607.807843843224, 9718.659846905324, 9878.25913056538, 10110.545025473724, 44845.32732009088, 45639.0, 46128.30807537823, 46262.53737462583, 46740.06519869652, 44119.0, 53535.732321338146, 53536.46463535315, 54714.905701886535, 59195.704021479614, 12983.675408114872, 13224.801627975396, 13305.66735831612, 13404.0, 13534.390952406968, 14759.0, 14963.0, 15069.171195584348, 15095.622609434851, 16027.679446411239, 13757.449702011807, 13839.308034598029, 13920.651983700489, 14225.359858806585, 14326.355314010687, 13410.798838017243, 14107.153570785786, 14318.642033949234, 14429.42282308696, 14515.564533064025, 13706.862931370559, 14151.363188656329, 14229.359678814271, 14237.0, 14282.857171428153, 10897.945510272399, 11219.775604488028, 11428.428578571204, 11476.885231147582, 12106.0, 11935.164538482222, 11976.46105925218, 11996.460159292677, 12092.455839487067, 12281.324527151093], "value": 7401.239093564737, "unit": "score"}], "name": "dromaeo_css", "value": 7461.664673163286, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 118.0, 153.0, 122.0, 116.0, 120.0, 122.0, 148.0, 122.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 162.0, 160.0, 162.0, 159.0, 161.0, 158.0, 158.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 112.0, 76.0, 76.0, 75.0, 77.0, 113.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 109.0, 82.0, 82.0, 82.0, 98.0, 82.0, 82.0, 111.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 119.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 52.0, 50.0, 49.0, 49.0, 51.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 59.0, 60.0, 59.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 83.0, 80.0, 75.0, 75.0, 75.0, 77.0, 73.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 126.0, 125.0, 120.0, 119.0, 125.0, 130.0, 161.0, 124.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 157.0, 153.0, 158.0, 154.0, 159.0, 158.0, 160.0, 152.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 66.0, 61.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1449.8, "alertThreshold": 2.0}]} 18:29:19 INFO - Return code: 0 18:29:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:29:19 INFO - # TBPL SUCCESS # 18:29:19 INFO - Running post-action listener: _resource_record_post_action 18:29:19 INFO - [mozharness: 2017-02-07 02:29:19.159078Z] Finished run-tests step (success) 18:29:19 INFO - Running post-run listener: _resource_record_post_run 18:29:19 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 307200; Write bytes: 310128640; Read time: 28; Write time: 181608 18:29:19 INFO - TinderboxPrint: CPU usage
12.9% 18:29:19 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 28 18:29:19 INFO - TinderboxPrint: I/O write bytes / time
310,128,640 / 181,608 18:29:19 INFO - TinderboxPrint: CPU idle
8,249.6 (87.1%) 18:29:19 INFO - TinderboxPrint: CPU user
1,184.6 (12.5%) 18:29:19 INFO - TinderboxPrint: Swap in / out
0 / 0 18:29:19 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 96931840; Read time: 0; Write time: 85588 18:29:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 307200; Write bytes: 208408576; Read time: 28; Write time: 95780 18:29:19 INFO - Running post-run listener: _upload_blobber_files 18:29:19 INFO - Blob upload gear active. 18:29:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:29:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:29:20 INFO - (blobuploader) - INFO - Open directory for files ... 18:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:29:21 INFO - (blobuploader) - INFO - Done attempting. 18:29:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:29:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:29:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:29:25 INFO - (blobuploader) - INFO - Done attempting. 18:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:29:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:29:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:29:26 INFO - (blobuploader) - INFO - Done attempting. 18:29:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:29:26 INFO - Return code: 0 18:29:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:29:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:29:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25742f59eb5f034bff5007286a9f4e6b2e7461f7c95e6ca0327d214929960bc8062e522428a199ade1d859a197fc0d702f384f637d86fcea4e14dab26ba4b942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d00d7d1e7e69d6015a48e3cb6abb3b53ec7a8285f9c8a0e886bfe21a8b982bdd77483094f2f7eb4e5a4176b1a96db9b935d0627571048095f9bff1736a0539db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f953e1b5192bbde74dabd28fe7fb73d76db8e615b2c409b8ff101af83c2084fdfc828e7a4e6809dc237193e677cc4bc1eafcaf65d3d26151dc6dc8b05b17b3a7"} 18:29:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:29:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:29:26 INFO - Contents: 18:29:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25742f59eb5f034bff5007286a9f4e6b2e7461f7c95e6ca0327d214929960bc8062e522428a199ade1d859a197fc0d702f384f637d86fcea4e14dab26ba4b942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d00d7d1e7e69d6015a48e3cb6abb3b53ec7a8285f9c8a0e886bfe21a8b982bdd77483094f2f7eb4e5a4176b1a96db9b935d0627571048095f9bff1736a0539db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f953e1b5192bbde74dabd28fe7fb73d76db8e615b2c409b8ff101af83c2084fdfc828e7a4e6809dc237193e677cc4bc1eafcaf65d3d26151dc6dc8b05b17b3a7"} 18:29:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:29:26 INFO - Copying logs to upload dir... 18:29:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:29:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.051492 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 18:29:26.507252) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:29:26.511228) ========= 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=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25742f59eb5f034bff5007286a9f4e6b2e7461f7c95e6ca0327d214929960bc8062e522428a199ade1d859a197fc0d702f384f637d86fcea4e14dab26ba4b942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d00d7d1e7e69d6015a48e3cb6abb3b53ec7a8285f9c8a0e886bfe21a8b982bdd77483094f2f7eb4e5a4176b1a96db9b935d0627571048095f9bff1736a0539db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f953e1b5192bbde74dabd28fe7fb73d76db8e615b2c409b8ff101af83c2084fdfc828e7a4e6809dc237193e677cc4bc1eafcaf65d3d26151dc6dc8b05b17b3a7"} build_url:https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/d2xZERahQ-mlv9qbDVBZKg/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25742f59eb5f034bff5007286a9f4e6b2e7461f7c95e6ca0327d214929960bc8062e522428a199ade1d859a197fc0d702f384f637d86fcea4e14dab26ba4b942", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d00d7d1e7e69d6015a48e3cb6abb3b53ec7a8285f9c8a0e886bfe21a8b982bdd77483094f2f7eb4e5a4176b1a96db9b935d0627571048095f9bff1736a0539db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f953e1b5192bbde74dabd28fe7fb73d76db8e615b2c409b8ff101af83c2084fdfc828e7a4e6809dc237193e677cc4bc1eafcaf65d3d26151dc6dc8b05b17b3a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 18:29:26.536512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:29:26.536856) ========= 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=31acecf42b6a79ec49471d4a000001bb-1486433332.813582-1729381513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 18:29:26.619915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:29:26.620264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 18:29:26.620585) ========= ========= Total master_lag: 0.17 =========