builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1479250815.04 results: success (0) buildid: 20161115121749 builduid: e4aa5a3bdd39438b99da41e79233f0b1 revision: 44ea84d66244726b4145850bd68c165d3a0880df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.037223) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.037688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.037995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.065544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.065814) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 15:00:15-- 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% 23.3M=0s 2016-11-15 15:00:15 (23.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.256028) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.256319) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017425 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.306676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.307006) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 44ea84d66244726b4145850bd68c165d3a0880df --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 44ea84d66244726b4145850bd68c165d3a0880df --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 15:00:15,478 truncating revision to first 12 chars 2016-11-15 15:00:15,478 Setting DEBUG logging. 2016-11-15 15:00:15,478 attempt 1/10 2016-11-15 15:00:15,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/44ea84d66244?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 15:00:15,794 unpacking tar archive at: mozilla-aurora-44ea84d66244/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.974114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.974389) ========= script_repo_revision: 44ea84d66244726b4145850bd68c165d3a0880df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.974773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.975095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:00:15.984356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-15 15:00:15.984641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:00:16 INFO - MultiFileLogger online at 20161115 15:00:16 in /builds/slave/test 15:00:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:00:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:16 INFO - {'append_to_log': False, 15:00:16 INFO - 'base_work_dir': '/builds/slave/test', 15:00:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:00:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:16 INFO - 'branch': 'Mozilla-Aurora', 15:00:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:16 INFO - 'config_files': ('talos/linux_config.py',), 15:00:16 INFO - 'default_actions': ('clobber', 15:00:16 INFO - 'read-buildbot-config', 15:00:16 INFO - 'download-and-extract', 15:00:16 INFO - 'populate-webroot', 15:00:16 INFO - 'create-virtualenv', 15:00:16 INFO - 'install', 15:00:16 INFO - 'run-tests'), 15:00:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:16 INFO - 'download_minidump_stackwalk': True, 15:00:16 INFO - 'download_symbols': 'ondemand', 15:00:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:16 INFO - 'installer_path': 'installer.exe', 15:00:16 INFO - 'log_level': 'info', 15:00:16 INFO - 'log_name': 'talos', 15:00:16 INFO - 'log_to_console': True, 15:00:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:00:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:00:16 INFO - 'opt_config_files': (), 15:00:16 INFO - 'pip_index': False, 15:00:16 INFO - 'sps_profile': False, 15:00:16 INFO - 'sps_profile_interval': 0, 15:00:16 INFO - 'suite': 'dromaeojs-e10s', 15:00:16 INFO - 'system_bits': '32', 15:00:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:16 INFO - 'title': 'talos-linux64-ix-024', 15:00:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:16 INFO - 'use_talos_json': True, 15:00:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:16 INFO - 'work_dir': 'build'} 15:00:16 INFO - [mozharness: 2016-11-15 23:00:16.260774Z] Running clobber step. 15:00:16 INFO - Running pre-action listener: _resource_record_pre_action 15:00:16 INFO - Running main action method: clobber 15:00:16 INFO - rmtree: /builds/slave/test/build 15:00:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:17 INFO - Running post-action listener: _resource_record_post_action 15:00:17 INFO - [mozharness: 2016-11-15 23:00:17.240383Z] Finished clobber step (success) 15:00:17 INFO - [mozharness: 2016-11-15 23:00:17.240485Z] Running read-buildbot-config step. 15:00:17 INFO - Running pre-action listener: _resource_record_pre_action 15:00:17 INFO - Running main action method: read_buildbot_config 15:00:17 INFO - Using buildbot properties: 15:00:17 INFO - { 15:00:17 INFO - "project": "", 15:00:17 INFO - "product": "firefox", 15:00:17 INFO - "script_repo_revision": "production", 15:00:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:00:17 INFO - "repository": "", 15:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:00:17 INFO - "buildid": "20161115121749", 15:00:17 INFO - "pgo_build": "True", 15:00:17 INFO - "basedir": "/builds/slave/test", 15:00:17 INFO - "buildnumber": 650, 15:00:17 INFO - "slavename": "talos-linux64-ix-024", 15:00:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:00:17 INFO - "platform": "ubuntu64_hw", 15:00:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:00:17 INFO - "branch": "mozilla-aurora", 15:00:17 INFO - "repo_path": "releases/mozilla-aurora", 15:00:17 INFO - "revision": "44ea84d66244726b4145850bd68c165d3a0880df", 15:00:17 INFO - "stage_platform": "linux64-pgo", 15:00:17 INFO - "builduid": "e4aa5a3bdd39438b99da41e79233f0b1", 15:00:17 INFO - "slavebuilddir": "test" 15:00:17 INFO - } 15:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:00:17 INFO - Running post-action listener: _resource_record_post_action 15:00:17 INFO - [mozharness: 2016-11-15 23:00:17.242943Z] Finished read-buildbot-config step (success) 15:00:17 INFO - [mozharness: 2016-11-15 23:00:17.243031Z] Running download-and-extract step. 15:00:17 INFO - Running pre-action listener: _resource_record_pre_action 15:00:17 INFO - Running main action method: download_and_extract 15:00:17 INFO - mkdir: /builds/slave/test/build/tests 15:00: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')]} 15:00:17 INFO - trying https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:00:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:00:17 INFO - Downloaded 1361 bytes. 15:00:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:00:17 INFO - Using the following test package requirements: 15:00:17 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:00:17 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:00:17 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:00:17 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'jsshell-linux-x86_64.zip'], 15:00:17 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:00:17 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:00:17 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:00:17 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:00:17 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:00:17 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:00:17 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:00:17 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:00:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:00:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:17 INFO - Fetch https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:00:18 INFO - Http code: 200 15:00:18 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 15:00:18 INFO - x-amz-cf-id: 9xPZoC1LsPqioO46QvqzXOC4QHqR1aSWqfmTOGcVDjDvIaqbFNKMBw== 15:00:18 INFO - x-amz-version-id: qp4eLIjVXQnlkZPNke1DJU8816DlQT6J 15:00:18 INFO - Expected file size: 21999186 15:00:18 INFO - Obtained file size: 21999186 15:00:22 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:00:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:00:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:00:22 INFO - Fetch https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:00:23 INFO - Http code: 200 15:00:23 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 15:00:23 INFO - x-amz-cf-id: S_tRbydcqAyr1JKY72qs_0y908INjLrkcrN7V_cNfQZ5K8zDht-oGA== 15:00:23 INFO - x-amz-version-id: qp4eLIjVXQnlkZPNke1DJU8816DlQT6J 15:00:23 INFO - Expected file size: 21999186 15:00:23 INFO - Obtained file size: 21999186 15:00:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:00:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:00:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:00:28 INFO - Http code: 200 15:00:28 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:00:28 INFO - x-amz-cf-id: TAqq5LnMKdmK0PxKJj5p5tv7PHrIEzQ7-fmt_PWza1OnZjxEqnuVZQ== 15:00:28 INFO - x-amz-version-id: wumpr1DJpzj0dp4BSQK06mKybyQeDLH8 15:00:28 INFO - Expected file size: 14409038 15:00:28 INFO - Obtained file size: 14409038 15:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:29 INFO - trying https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:00:30 INFO - Downloaded 63947000 bytes. 15:00:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:00:30 INFO - mkdir: /builds/slave/test/properties 15:00:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:00:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:00:30 INFO - Contents: 15:00:30 INFO - build_url:https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:00:31 INFO - Running post-action listener: _resource_record_post_action 15:00:31 INFO - Running post-action listener: set_extra_try_arguments 15:00:31 INFO - [mozharness: 2016-11-15 23:00:31.050515Z] Finished download-and-extract step (success) 15:00:31 INFO - [mozharness: 2016-11-15 23:00:31.050744Z] Running populate-webroot step. 15:00:31 INFO - Running pre-action listener: _resource_record_pre_action 15:00:31 INFO - Running main action method: populate_webroot 15:00:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:00:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:00:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:00:31 INFO - '--tppagecycles', 15:00:31 INFO - '7'], 15:00:31 INFO - 'tests': ['tsvgm']}}, 15:00:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:00:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:00:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:00:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:00:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:00:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['damp', 'tps']}, 15:00:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'tests': ['damp', 'tps']}, 15:00:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['dromaeo_dom']}, 15:00:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:00:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['basic_compositor_video']}, 15:00:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:00:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'other-e10s': {'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['a11yr', 15:00:31 INFO - 'ts_paint', 15:00:31 INFO - 'tpaint', 15:00:31 INFO - 'sessionrestore', 15:00:31 INFO - 'sessionrestore_no_auto_restore', 15:00:31 INFO - 'tabpaint']}, 15:00:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['tsvgx', 15:00:31 INFO - 'tsvgr_opacity', 15:00:31 INFO - 'tart', 15:00:31 INFO - 'tscrollx', 15:00:31 INFO - 'cart']}, 15:00:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:00:31 INFO - 'tsvgr_opacity', 15:00:31 INFO - 'tart', 15:00:31 INFO - 'tscrollx', 15:00:31 INFO - 'cart']}, 15:00:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'talos_options': ['--disable-e10s'], 15:00:31 INFO - 'tests': ['tp5o']}, 15:00:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'tests': ['tp5o']}, 15:00:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'talos_options': ['--disable-e10s', 15:00:31 INFO - '--xperf_path', 15:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:31 INFO - 'tests': ['tp5n']}, 15:00:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:00:31 INFO - 'talos_options': ['--xperf_path', 15:00:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:00:31 INFO - 'tests': ['tp5n']}}, 15:00:31 INFO - 'talos.zip': {'path': '', 15:00:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:00:31 INFO - Running post-action listener: _resource_record_post_action 15:00:31 INFO - [mozharness: 2016-11-15 23:00:31.073414Z] Finished populate-webroot step (success) 15:00:31 INFO - [mozharness: 2016-11-15 23:00:31.073518Z] Running create-virtualenv step. 15:00:31 INFO - Running pre-action listener: _resource_record_pre_action 15:00:31 INFO - Running main action method: create_virtualenv 15:00:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:00:31 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 15:00:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:00:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:00:31 INFO - Using real prefix '/usr' 15:00:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:00:31 INFO - Installing distribute.............................................................................................................................................................................................done. 15:00:33 INFO - Installing pip.................done. 15:00:33 INFO - Return code: 0 15:00:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:00:33 INFO - Reading from file tmpfile_stdout 15:00:33 INFO - Output received: 15:00:33 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) 15:00:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:00:33 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')]} 15:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:33 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')]} 15:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:33 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:33 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 15:00:33 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 15:00:33 INFO - Using env: {'DISPLAY': ':0', 15:00:33 INFO - 'HOME': '/home/cltbld', 15:00:33 INFO - 'LANG': 'en_US.UTF-8', 15:00:33 INFO - 'LANGUAGE': 'en_US:en', 15:00:33 INFO - 'LOGNAME': 'cltbld', 15:00:33 INFO - 'MAIL': '/var/mail/cltbld', 15:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:33 INFO - 'MOZ_NO_REMOTE': '1', 15:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:33 INFO - 'NO_EM_RESTART': '1', 15:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:33 INFO - 'PWD': '/builds/slave/test', 15:00:33 INFO - 'SHELL': '/bin/bash', 15:00:33 INFO - 'SHLVL': '1', 15:00:33 INFO - 'TERM': 'linux', 15:00:33 INFO - 'TMOUT': '86400', 15:00:33 INFO - 'USER': 'cltbld', 15:00:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:33 INFO - '_': '/tools/buildbot/bin/python'} 15:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:34 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 15:00:34 INFO - Cleaning up... 15:00:34 INFO - Return code: 0 15:00:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:00:34 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')]} 15:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:34 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')]} 15:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:34 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:34 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 15:00:34 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 15:00:34 INFO - Using env: {'DISPLAY': ':0', 15:00:34 INFO - 'HOME': '/home/cltbld', 15:00:34 INFO - 'LANG': 'en_US.UTF-8', 15:00:34 INFO - 'LANGUAGE': 'en_US:en', 15:00:34 INFO - 'LOGNAME': 'cltbld', 15:00:34 INFO - 'MAIL': '/var/mail/cltbld', 15:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:34 INFO - 'MOZ_NO_REMOTE': '1', 15:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:34 INFO - 'NO_EM_RESTART': '1', 15:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:34 INFO - 'PWD': '/builds/slave/test', 15:00:34 INFO - 'SHELL': '/bin/bash', 15:00:34 INFO - 'SHLVL': '1', 15:00:34 INFO - 'TERM': 'linux', 15:00:34 INFO - 'TMOUT': '86400', 15:00:34 INFO - 'USER': 'cltbld', 15:00:34 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:34 INFO - '_': '/tools/buildbot/bin/python'} 15:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:34 INFO - Downloading/unpacking psutil>=3.1.1 15:00:34 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 15:00:34 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 15:00:34 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 15:00:34 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 15:00:34 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 15:00:34 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 15:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:36 INFO - Installing collected packages: psutil 15:00:36 INFO - Running setup.py install for psutil 15:00:36 INFO - building 'psutil._psutil_linux' extension 15:00:36 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 15:00:36 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 15:00:36 INFO - building 'psutil._psutil_posix' extension 15:00:36 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 15:00:36 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 15:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:00:36 INFO - Successfully installed psutil 15:00:36 INFO - Cleaning up... 15:00:36 INFO - Return code: 0 15:00:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:00:36 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')]} 15:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:36 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')]} 15:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:36 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:36 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 15:00:36 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 15:00:36 INFO - Using env: {'DISPLAY': ':0', 15:00:36 INFO - 'HOME': '/home/cltbld', 15:00:36 INFO - 'LANG': 'en_US.UTF-8', 15:00:36 INFO - 'LANGUAGE': 'en_US:en', 15:00:36 INFO - 'LOGNAME': 'cltbld', 15:00:36 INFO - 'MAIL': '/var/mail/cltbld', 15:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:36 INFO - 'MOZ_NO_REMOTE': '1', 15:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:36 INFO - 'NO_EM_RESTART': '1', 15:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:36 INFO - 'PWD': '/builds/slave/test', 15:00:36 INFO - 'SHELL': '/bin/bash', 15:00:36 INFO - 'SHLVL': '1', 15:00:36 INFO - 'TERM': 'linux', 15:00:36 INFO - 'TMOUT': '86400', 15:00:36 INFO - 'USER': 'cltbld', 15:00:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:36 INFO - '_': '/tools/buildbot/bin/python'} 15:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:37 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 15:00:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:00:39 INFO - Installing collected packages: mozsystemmonitor 15:00:39 INFO - Running setup.py install for mozsystemmonitor 15:00:39 INFO - Successfully installed mozsystemmonitor 15:00:39 INFO - Cleaning up... 15:00:39 INFO - Return code: 0 15:00:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:00:39 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')]} 15:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:39 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')]} 15:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:39 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:39 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 15:00:39 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 15:00:39 INFO - Using env: {'DISPLAY': ':0', 15:00:39 INFO - 'HOME': '/home/cltbld', 15:00:39 INFO - 'LANG': 'en_US.UTF-8', 15:00:39 INFO - 'LANGUAGE': 'en_US:en', 15:00:39 INFO - 'LOGNAME': 'cltbld', 15:00:39 INFO - 'MAIL': '/var/mail/cltbld', 15:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:39 INFO - 'MOZ_NO_REMOTE': '1', 15:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:39 INFO - 'NO_EM_RESTART': '1', 15:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:39 INFO - 'PWD': '/builds/slave/test', 15:00:39 INFO - 'SHELL': '/bin/bash', 15:00:39 INFO - 'SHLVL': '1', 15:00:39 INFO - 'TERM': 'linux', 15:00:39 INFO - 'TMOUT': '86400', 15:00:39 INFO - 'USER': 'cltbld', 15:00:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:39 INFO - '_': '/tools/buildbot/bin/python'} 15:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:00:39 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 15:00:39 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 15:00:39 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 15:00:39 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 15:00:39 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 15:00:39 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 15:00:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:00:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:00:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:00:41 INFO - warning: no files found matching '*.txt' 15:00:41 INFO - no previously-included directories found matching 'build' 15:00:41 INFO - no previously-included directories found matching 'dist' 15:00:41 INFO - no previously-included directories found matching '.git*' 15:00:41 INFO - Installing collected packages: jsonschema, functools32 15:00:41 INFO - Running setup.py install for functools32 15:00:41 INFO - warning: no files found matching '*.txt' 15:00:41 INFO - no previously-included directories found matching 'build' 15:00:41 INFO - no previously-included directories found matching 'dist' 15:00:41 INFO - no previously-included directories found matching '.git*' 15:00:41 INFO - Successfully installed jsonschema functools32 15:00:41 INFO - Cleaning up... 15:00:41 INFO - Return code: 0 15:00:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:00:41 INFO - Using env: {'DISPLAY': ':0', 15:00:41 INFO - 'HOME': '/home/cltbld', 15:00:41 INFO - 'LANG': 'en_US.UTF-8', 15:00:41 INFO - 'LANGUAGE': 'en_US:en', 15:00:41 INFO - 'LOGNAME': 'cltbld', 15:00:41 INFO - 'MAIL': '/var/mail/cltbld', 15:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:41 INFO - 'MOZ_NO_REMOTE': '1', 15:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:41 INFO - 'NO_EM_RESTART': '1', 15:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:41 INFO - 'PWD': '/builds/slave/test', 15:00:41 INFO - 'SHELL': '/bin/bash', 15:00:41 INFO - 'SHLVL': '1', 15:00:41 INFO - 'TERM': 'linux', 15:00:41 INFO - 'TMOUT': '86400', 15:00:41 INFO - 'USER': 'cltbld', 15:00:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:41 INFO - '_': '/tools/buildbot/bin/python'} 15:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:00:42 INFO - Cleaning up... 15:00:42 INFO - Return code: 0 15:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:00:42 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')]} 15:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:42 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')]} 15:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:42 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:42 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 15:00:42 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 15:00:42 INFO - Using env: {'DISPLAY': ':0', 15:00:42 INFO - 'HOME': '/home/cltbld', 15:00:42 INFO - 'LANG': 'en_US.UTF-8', 15:00:42 INFO - 'LANGUAGE': 'en_US:en', 15:00:42 INFO - 'LOGNAME': 'cltbld', 15:00:42 INFO - 'MAIL': '/var/mail/cltbld', 15:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:42 INFO - 'MOZ_NO_REMOTE': '1', 15:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:42 INFO - 'NO_EM_RESTART': '1', 15:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:42 INFO - 'PWD': '/builds/slave/test', 15:00:42 INFO - 'SHELL': '/bin/bash', 15:00:42 INFO - 'SHLVL': '1', 15:00:42 INFO - 'TERM': 'linux', 15:00:42 INFO - 'TMOUT': '86400', 15:00:42 INFO - 'USER': 'cltbld', 15:00:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:42 INFO - '_': '/tools/buildbot/bin/python'} 15:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:00:42 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 15:00:42 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 15:00:42 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 15:00:42 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 15:00:42 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 15:00:42 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 15:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:00:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:44 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 15:00:45 INFO - Downloading docopt-0.6.1.tar.gz 15:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:00:45 INFO - Running setup.py install for blobuploader 15:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:00:45 INFO - Running setup.py install for requests 15:00:45 INFO - Running setup.py install for docopt 15:00:45 INFO - Successfully installed blobuploader requests docopt 15:00:45 INFO - Cleaning up... 15:00:45 INFO - Return code: 0 15:00:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00: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')]} 15:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00: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')]} 15:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:45 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:45 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 15:00:45 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 15:00:45 INFO - Using env: {'DISPLAY': ':0', 15:00:45 INFO - 'HOME': '/home/cltbld', 15:00:45 INFO - 'LANG': 'en_US.UTF-8', 15:00:45 INFO - 'LANGUAGE': 'en_US:en', 15:00:45 INFO - 'LOGNAME': 'cltbld', 15:00:45 INFO - 'MAIL': '/var/mail/cltbld', 15:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:45 INFO - 'MOZ_NO_REMOTE': '1', 15:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:45 INFO - 'NO_EM_RESTART': '1', 15:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:45 INFO - 'PWD': '/builds/slave/test', 15:00:45 INFO - 'SHELL': '/bin/bash', 15:00:45 INFO - 'SHLVL': '1', 15:00:45 INFO - 'TERM': 'linux', 15:00:45 INFO - 'TMOUT': '86400', 15:00:45 INFO - 'USER': 'cltbld', 15:00:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:45 INFO - '_': '/tools/buildbot/bin/python'} 15:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:45 INFO - Running setup.py (path:/tmp/pip-ShE0uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:46 INFO - Running setup.py (path:/tmp/pip-4XJRgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:46 INFO - Running setup.py (path:/tmp/pip-xis7ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:46 INFO - Running setup.py (path:/tmp/pip-NdyD2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:46 INFO - Running setup.py (path:/tmp/pip-2nXky4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:46 INFO - Running setup.py (path:/tmp/pip-OwfoG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:46 INFO - Running setup.py (path:/tmp/pip-CYEEEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:46 INFO - Running setup.py (path:/tmp/pip-q0Q96n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:46 INFO - Running setup.py (path:/tmp/pip-0LVziE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:46 INFO - Running setup.py (path:/tmp/pip-4c2Slp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:46 INFO - Running setup.py (path:/tmp/pip-WQpO_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:46 INFO - Running setup.py (path:/tmp/pip-6PiBZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:46 INFO - Running setup.py (path:/tmp/pip-EvvRyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:46 INFO - Running setup.py (path:/tmp/pip-IbEJRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:47 INFO - Running setup.py (path:/tmp/pip-vy59Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:47 INFO - Running setup.py (path:/tmp/pip-jY9D6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:47 INFO - Running setup.py (path:/tmp/pip-IRGgkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:00:47 INFO - Running setup.py install for manifestparser 15:00:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:00:47 INFO - Running setup.py install for mozcrash 15:00:47 INFO - Running setup.py install for mozdebug 15:00:47 INFO - Running setup.py install for mozdevice 15:00:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:00:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:00:47 INFO - Running setup.py install for mozfile 15:00:47 INFO - Running setup.py install for mozhttpd 15:00:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:00:47 INFO - Running setup.py install for mozinfo 15:00:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:00:47 INFO - Running setup.py install for mozInstall 15:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Running setup.py install for mozleak 15:00:48 INFO - Running setup.py install for mozlog 15:00:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Running setup.py install for moznetwork 15:00:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Running setup.py install for mozprocess 15:00:48 INFO - Running setup.py install for mozprofile 15:00:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Running setup.py install for mozrunner 15:00:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:00:48 INFO - Running setup.py install for mozscreenshot 15:00:48 INFO - Running setup.py install for moztest 15:00:48 INFO - Running setup.py install for mozversion 15:00:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:00:49 INFO - Cleaning up... 15:00:49 INFO - Return code: 0 15:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:49 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:49 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 15:00:49 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 15:00:49 INFO - Using env: {'DISPLAY': ':0', 15:00:49 INFO - 'HOME': '/home/cltbld', 15:00:49 INFO - 'LANG': 'en_US.UTF-8', 15:00:49 INFO - 'LANGUAGE': 'en_US:en', 15:00:49 INFO - 'LOGNAME': 'cltbld', 15:00:49 INFO - 'MAIL': '/var/mail/cltbld', 15:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:49 INFO - 'MOZ_NO_REMOTE': '1', 15:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:49 INFO - 'NO_EM_RESTART': '1', 15:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:49 INFO - 'PWD': '/builds/slave/test', 15:00:49 INFO - 'SHELL': '/bin/bash', 15:00:49 INFO - 'SHLVL': '1', 15:00:49 INFO - 'TERM': 'linux', 15:00:49 INFO - 'TMOUT': '86400', 15:00:49 INFO - 'USER': 'cltbld', 15:00:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:49 INFO - '_': '/tools/buildbot/bin/python'} 15:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:00:49 INFO - Running setup.py (path:/tmp/pip-lTMDzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:00:49 INFO - Running setup.py (path:/tmp/pip-sszcTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:00:49 INFO - Running setup.py (path:/tmp/pip-pYwSa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:00:49 INFO - Running setup.py (path:/tmp/pip-54n2Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:00:49 INFO - Running setup.py (path:/tmp/pip-0PD6vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:00:49 INFO - Running setup.py (path:/tmp/pip-FKaJ0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:00:49 INFO - Running setup.py (path:/tmp/pip-OoNwIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:00:49 INFO - Running setup.py (path:/tmp/pip-uVB7n5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:00:49 INFO - Running setup.py (path:/tmp/pip-85PVy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:00:49 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)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:00:49 INFO - Running setup.py (path:/tmp/pip-xQZmNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:00:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:00:49 INFO - Running setup.py (path:/tmp/pip-aO2BxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:00:50 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:00:50 INFO - Running setup.py (path:/tmp/pip-uzCGhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:00:50 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:00:50 INFO - Running setup.py (path:/tmp/pip-7bk7vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:00:50 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:00:50 INFO - Running setup.py (path:/tmp/pip-_zOC7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:00:50 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:50 INFO - Running setup.py (path:/tmp/pip-7yywJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:00:50 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:00:50 INFO - Running setup.py (path:/tmp/pip-nzU_2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:00:50 INFO - Running setup.py (path:/tmp/pip-uhWOn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:00:50 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)) 15:00:50 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)) 15:00:50 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)) 15:00:50 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)) 15:00:50 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)) 15:00:50 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)) 15:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:00:50 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 15:00:50 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 15:00:50 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 15:00:50 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 15:00:50 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 15:00:50 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 15:00:52 INFO - Downloading blessings-1.6.tar.gz 15:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:00:52 INFO - Installing collected packages: blessings 15:00:52 INFO - Running setup.py install for blessings 15:00:52 INFO - Successfully installed blessings 15:00:52 INFO - Cleaning up... 15:00:52 INFO - Return code: 0 15:00:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:00:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:00:52 INFO - Reading from file tmpfile_stdout 15:00:52 INFO - Current package versions: 15:00:52 INFO - argparse == 1.2.1 15:00:52 INFO - blessings == 1.6 15:00:52 INFO - blobuploader == 1.2.4 15:00:52 INFO - docopt == 0.6.1 15:00:52 INFO - functools32 == 3.2.3-2 15:00:52 INFO - jsonschema == 2.5.1 15:00:52 INFO - manifestparser == 1.1 15:00:52 INFO - mozInstall == 1.12 15:00:52 INFO - mozcrash == 1.0 15:00:52 INFO - mozdebug == 0.1 15:00:52 INFO - mozdevice == 0.48 15:00:52 INFO - mozfile == 1.2 15:00:52 INFO - mozhttpd == 0.7 15:00:52 INFO - mozinfo == 0.9 15:00:52 INFO - mozleak == 0.1 15:00:52 INFO - mozlog == 3.4 15:00:52 INFO - moznetwork == 0.27 15:00:52 INFO - mozprocess == 0.23 15:00:52 INFO - mozprofile == 0.28 15:00:52 INFO - mozrunner == 6.13 15:00:52 INFO - mozscreenshot == 0.1 15:00:52 INFO - mozsystemmonitor == 0.3 15:00:52 INFO - moztest == 0.7 15:00:52 INFO - mozversion == 1.4 15:00:52 INFO - psutil == 3.1.1 15:00:52 INFO - requests == 1.2.3 15:00:52 INFO - wsgiref == 0.1.2 15:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:00:52 INFO - Using env: {'DISPLAY': ':0', 15:00:52 INFO - 'HOME': '/home/cltbld', 15:00:52 INFO - 'LANG': 'en_US.UTF-8', 15:00:52 INFO - 'LANGUAGE': 'en_US:en', 15:00:52 INFO - 'LOGNAME': 'cltbld', 15:00:52 INFO - 'MAIL': '/var/mail/cltbld', 15:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:52 INFO - 'MOZ_NO_REMOTE': '1', 15:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:52 INFO - 'NO_EM_RESTART': '1', 15:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:52 INFO - 'PWD': '/builds/slave/test', 15:00:52 INFO - 'SHELL': '/bin/bash', 15:00:52 INFO - 'SHLVL': '1', 15:00:52 INFO - 'TERM': 'linux', 15:00:52 INFO - 'TMOUT': '86400', 15:00:52 INFO - 'USER': 'cltbld', 15:00:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:52 INFO - '_': '/tools/buildbot/bin/python'} 15:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 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)) 15:00:53 INFO - Cleaning up... 15:00:53 INFO - Return code: 0 15:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:00:53 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')]} 15:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:53 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')]} 15:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:00:53 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 0x7f54d0f7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', '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 15:00:53 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 15:00:53 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 15:00:53 INFO - Using env: {'DISPLAY': ':0', 15:00:53 INFO - 'HOME': '/home/cltbld', 15:00:53 INFO - 'LANG': 'en_US.UTF-8', 15:00:53 INFO - 'LANGUAGE': 'en_US:en', 15:00:53 INFO - 'LOGNAME': 'cltbld', 15:00:53 INFO - 'MAIL': '/var/mail/cltbld', 15:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:00:53 INFO - 'MOZ_NO_REMOTE': '1', 15:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:00:53 INFO - 'NO_EM_RESTART': '1', 15:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:00:53 INFO - 'PWD': '/builds/slave/test', 15:00:53 INFO - 'SHELL': '/bin/bash', 15:00:53 INFO - 'SHLVL': '1', 15:00:53 INFO - 'TERM': 'linux', 15:00:53 INFO - 'TMOUT': '86400', 15:00:53 INFO - 'USER': 'cltbld', 15:00:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:00:53 INFO - '_': '/tools/buildbot/bin/python'} 15:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:00:53 INFO - Cleaning up... 15:00:53 INFO - Return code: 0 15:00:53 INFO - Running post-action listener: _resource_record_post_action 15:00:53 INFO - Running post-action listener: _start_resource_monitoring 15:00:53 INFO - Starting resource monitoring. 15:00:53 INFO - [mozharness: 2016-11-15 23:00:53.374004Z] Finished create-virtualenv step (success) 15:00:53 INFO - [mozharness: 2016-11-15 23:00:53.374505Z] Running install step. 15:00:53 INFO - Running pre-action listener: _resource_record_pre_action 15:00:53 INFO - Running main action method: install 15:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:00:53 INFO - Reading from file tmpfile_stdout 15:00:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:00:53 INFO - Reading from file tmpfile_stdout 15:00:53 INFO - Output received: 15:00:53 INFO - Usage: mozinstall [options] installer 15:00:53 INFO - Options: 15:00:53 INFO - -h, --help show this help message and exit 15:00:53 INFO - -d DEST, --destination=DEST 15:00:53 INFO - Directory to install application into. [default: 15:00:53 INFO - "/builds/slave/test"] 15:00:53 INFO - --app=APP Application being installed. [default: firefox] 15:00:53 INFO - mkdir: /builds/slave/test/build/application 15:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:01:09 INFO - Reading from file tmpfile_stdout 15:01:09 INFO - Output received: 15:01:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:01:09 INFO - Running post-action listener: _resource_record_post_action 15:01:09 INFO - [mozharness: 2016-11-15 23:01:09.676339Z] Finished install step (success) 15:01:09 INFO - [mozharness: 2016-11-15 23:01:09.676583Z] Running run-tests step. 15:01:09 INFO - Running pre-action listener: _resource_record_pre_action 15:01:09 INFO - Running main action method: run_tests 15:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:01:09 INFO - Python 2.7.3 15:01:09 INFO - Return code: 0 15:01:09 INFO - grabbing minidump binary from tooltool 15:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:09 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 0x20e1f60>, '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 0x20e2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20e31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:01:09 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 15:01:09 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 15:01:09 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 15:01:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:01:09 INFO - Return code: 0 15:01:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:01:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:01:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:01:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:01:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:01:09 INFO - Using env: {'DISPLAY': ':0', 15:01:09 INFO - 'HOME': '/home/cltbld', 15:01:09 INFO - 'LANG': 'en_US.UTF-8', 15:01:09 INFO - 'LANGUAGE': 'en_US:en', 15:01:09 INFO - 'LOGNAME': 'cltbld', 15:01:09 INFO - 'MAIL': '/var/mail/cltbld', 15:01:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:01:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:09 INFO - 'MOZ_NO_REMOTE': '1', 15:01:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:09 INFO - 'NO_EM_RESTART': '1', 15:01:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:09 INFO - 'PWD': '/builds/slave/test', 15:01:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:01:09 INFO - 'SHELL': '/bin/bash', 15:01:09 INFO - 'SHLVL': '1', 15:01:09 INFO - 'TERM': 'linux', 15:01:09 INFO - 'TMOUT': '86400', 15:01:09 INFO - 'USER': 'cltbld', 15:01:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835', 15:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:09 INFO - '_': '/tools/buildbot/bin/python'} 15:01:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:01:09 INFO - mozversion application_buildid: 20161115121749 15:01:09 INFO - mozversion application_changeset: 44ea84d66244726b4145850bd68c165d3a0880df 15:01:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:01:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:01:09 INFO - mozversion application_name: Firefox 15:01:09 INFO - mozversion application_remotingname: firefox-dev 15:01:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:01:09 INFO - mozversion application_vendor: Mozilla 15:01:09 INFO - mozversion application_version: 52.0a2 15:01:09 INFO - mozversion platform_buildid: 20161115121749 15:01:09 INFO - mozversion platform_changeset: 44ea84d66244726b4145850bd68c165d3a0880df 15:01:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:01:09 INFO - mozversion platform_version: 52.0a2 15:01:09 INFO - using testdate: 1479250869 15:01:09 INFO - actual date: 1479250869 15:01:09 INFO - starting webserver on 'localhost:54339' 15:01:09 INFO - SUITE-START | Running 2 tests 15:01:09 INFO - TEST-START | dromaeo_css 15:01:09 INFO - operating with platform_type : linux_ 15:01:09 INFO - Initialising browser for dromaeo_css test... 15:01:09 INFO - TEST-INFO | started process 15337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAw1ghE/profile http://localhost:54339/getInfo.html) 15:01:13 ERROR - PROCESS | 15337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 15:01:14 INFO - PROCESS | 15337 | __metrics Screen width/height:1600/1200 15:01:14 INFO - PROCESS | 15337 | colorDepth:24 15:01:14 INFO - PROCESS | 15337 | Browser inner width/height: 1024/697 15:01:14 INFO - PROCESS | 15337 | __metrics 15:01:15 ERROR - PROCESS | 15337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 15:01:15 INFO - TEST-INFO | 15337: exit 0 15:01:15 INFO - Browser initialized. 15:01:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:01:15 INFO - TEST-INFO | started process 15468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAw1ghE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:01:27 INFO - PROCESS | 15468 | RSS: Main: 151801856 15:01:27 INFO - PROCESS | 15468 | 15:02:17 INFO - PROCESS | 15468 | 1479250937383 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:04:27 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54339/tests/dromaeo/cssquery-ext.html) 15:04:29 INFO - PROCESS | 15468 | RSS: Main: 156651520 15:04:29 INFO - PROCESS | 15468 | 15:07:31 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-ext.html (next: http://localhost:54339/tests/dromaeo/cssquery-jquery.html) 15:07:31 INFO - PROCESS | 15468 | RSS: Main: 153235456 15:07:31 INFO - PROCESS | 15468 | 15:10:33 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54339/tests/dromaeo/cssquery-mootools.html) 15:10:34 INFO - PROCESS | 15468 | RSS: Main: 153042944 15:10:34 INFO - PROCESS | 15468 | 15:13:36 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54339/tests/dromaeo/cssquery-prototype.html) 15:13:36 INFO - PROCESS | 15468 | RSS: Main: 151379968 15:13:36 INFO - PROCESS | 15468 | 15:16:39 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54339/tests/dromaeo/cssquery-yui.html) 15:16:39 INFO - PROCESS | 15468 | RSS: Main: 154136576 15:16:39 INFO - PROCESS | 15468 | 15:19:41 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:54339/tests/dromaeo/cssquery-yui.html (next: http://localhost:54339/tests/dromaeo/cssquery-dojo.html) 15:19:42 INFO - PROCESS | 15468 | RSS: Main: 155377664 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | __start_tp_report 15:19:42 INFO - PROCESS | 15468 | _x_x_mozilla_page_load 15:19:42 INFO - PROCESS | 15468 | _x_x_mozilla_page_load_details 15:19:42 INFO - PROCESS | 15468 | |i|pagename|runs| 15:19:42 INFO - PROCESS | 15468 | |0;dojo.html;3218.5976752905885;3237.9676203237964;3261.8042917424955;3281.7702760806746;3284.458064419371;5590.8602284942845;5611.270534830472;5657.66054036757;5665.8583535411535;5669.518090962268;5530.364008139065;5632.831015069544;5642.887142257163;5644.096944488882;5680.204771332006;5106.795728170878;5137.12668846297;5162;5185.714785686786;5195.922061169085;5185.403678576974;5188.247704082905;5197.818076367328;5199.506046925536;5205.713685747282;4973.030259099477;5001.324821149135;5194.974025129869;5199.09015922214;5224.7387630618505;5073;5080.5681517070725;5087.160618497944;5098.235264710304;5121.334226550524;5050.671706339113;5059.797608095671;5075.619328550373;5131.461196574381;5157.4068982067165;5538.6399884007815;5542.91685624716;5575.776968921238;5620.775168993236;5631.099024156116;6025.367336429699;6075.726592303357;6089.8173054807985;6102.328743838174;6122.47958923492;6142.170806941095;6153.876922461571;6173.290071641729;6200.348963358828;6203.534734894901;5496.5053145217125;5548.528375088163;5576.163575463632;5743.10981797822;5749.798757043525;6121.4490695837585;6123.221615589998;6160.229971253593;6175.166352542439;6182.969085154546;5942.881142377215;5946.762129514857;5958.076498142708;5972.701364931736;5977.491913187341;5843.444872737083;5882.3529411764675;6048.4858787003595;6057.939420605826;6060.545459090586;5835.912461313083;5850.795222167204;5877.089051197071;5911.438413350725;5958.463738263577;5871.4715675589405;5873.941260587425;5926.703664816828;5932.436418540318;5934.6142500737315;4553.749543775058;4573.405457290531;4602.194615942197;4604.700694454849;4633.72197668141;4041.595840415935;4078.9592104079175;4101.938470922939;4143.875683729493;4186.413902053715;5738.512226460798;5744;5754.251947246831;5775.855603609859;5804.04233301509;5783.826485205451;5821.650700957956;6037.09443583466;6086.117512960596;6088.330283668793;5554.91667624986;5626.212330273765;5663.915041274384;5720.885582288414;5778.711064446761;5153.793848246029;5175.611829112756;5197.220416937414;5199.29809475716;5208.374995000549;6089.969550152221;6195.256569211633;6218.31598524162;6258.311585725566;6268.811935641938;5946.375630558729;5995.970020149872;6016.217891674054;6025.3070896845675;6116.052011938156;6225.844353891189;6238.532110091671;6255.499560035278;6280.842978925563;6281.59169653971;5972.70136493165;5985.850353741192;6001.579889407874;6003.459688628044;6033.728482218223;5882;5931.9110213345975;6051.243594550681;6059.697015149313;6073.514118870568;5969.582129250911;6027.78902738402;6030.517558595214;6031.517478601789;6034.125051867542;5928.3775203603;5968.46283834457;5994.790182343597;5997.31030931431;6000.279966404059;5652.717364131695;5780.566457515787;5789.478946894799;5827.883442331215;5895.941040589711;5888.057910734262;5908.438698323653;5916.230889984275;5936.079907614327;5948.8215353537735;5739.282589676291;5741.5406767459335;5748.511376533042;5775.595708300379;5780.942190578208 15:19:42 INFO - PROCESS | 15468 | |1;ext.html;569.7521578113518;592.3572923378134;615.4430240632228;698.8252936765808;703.7958991892348;43309.35035974463;44316.3352549712;44343.33484997728;44411.77794111029;44438;45477.54522454783;46628;46690.76654616731;46859.53140468594;46890.765546172304;8692.087330830282;10564.841527377095;10867.29362591433;10869.945650271737;11184.44077796111;10776.137908967303;10857.077148442391;10859.07697845684;10859.40273284969;10872.075873550757;10844.078253348474;10920.18098642605;10935.507902144423;10948.343099414022;10972.451377431136;10746.892531074707;10842.457877106113;10873.565057397695;10874.619388321371;10888.891111088946;10615.893841061568;10696.304740191863;10704.732381690443;10711.678649640524;10738.78522429547;43832.78083609593;44192.77903610461;44264.77867610673;44291.55708442939;44326.55673443257;3791.241751649681;3860.9227815443815;3921.3333733265413;3923.744956577842;4061.248668996245;33569;33644.66355336464;33659.495107573406;33704;33921.83039084813;4454.844080457201;4507.076049409896;4536.072268283629;4553.112143132091;4588.220002599566;378566;381474;384102;384790;385486;63191.36808631947;63303;63568.36431635717;63797.36202638007;63841;68273.3172668277;68635;68955.65522172357;69075;69095.65452172708;18008.36970706019;18202.726959095624;19283.807161928202;19689.803101969082;19803.900980495004;14943.626409339853;15227.771583426258;15249.6187595311;15578.143202123765;15620.218989050501;20430.897845510677;20533.2813351532;20546;20601.48496287605;20609.48476288105;7428.182899881009;7536.6985320587655;7592.658330375147;7623.618819059025;7625.199354067854;973.338130071544;1047.5966752800227;1092.1044743310567;1118.7762447510531;1159.5999380213814;32295;32459.675403246136;32915;33010.504842427385;33105.50341744876;1134.0587312530745;1141.6175581180232;1176.2178151529138;1216.8478940132484;1245.6761242076943;17004.574885627957;17152.742708859376;17170.914145429444;17371.478855634352;17401;508230;510530;511261;511952;512466;41037;41045;41265.587344126776;41272;41310;1364.3996641477718;1393.6515871032243;1398.923059231752;1441.4738620403687;1444.8482909294582;31190.22024449407;32090.518642220854;32997.17507062342;33190.5021424674;33525.83237083799;58911.41088589231;59177;59712.104318436126;59823.401765981784;59998.40001599928;448620;452574;453952;454127;455333;28837;29836.701632983393;30056.69943300539;30592.235194120323;32157.1960700975;49874.501254986986;50314;50553.49446505488;51466.22800658068;54567;42198.367024494044;43111.56888431076;43671;44919;45493;43082.56917430786;43237.567624323354;44027.559724402345;44226.778866105466;44704;42583.787081064394;43426.348604771585;43450.782746086064;43466.34800477932;43655.78172109119;36715.26569468649;38915.61084389233;39078.218435631694;39759.80120099381;40482.79758601188;28961.131166065054;29144.854275728485;29153.833846645895;29399.559006615345;29686.40627187401 15:19:42 INFO - PROCESS | 15468 | |2;jquery.html;430.71719884611554;433.3954133983092;436.55253365300564;439.56263517799783;449.7211728728189;18567.164477598522;18580.90709546452;20013.499662508446;20112.396628101145;20170.193192272327;17568.736468952975;19105.808941910578;19736.60526789467;19736.70394944077;20050;5190.896182076347;5384.865378365553;5409.486098820606;5421.105517589593;5441.5102640762325;5185.325907632003;5260.973695131519;5320.441353657869;5355.705436201008;5415.187721841736;5284.2602035714835;5302.416734159239;5332.040232758102;5346.4118946915805;5347.7058761768085;5197.428282888879;5270.367555893317;5334.199870019509;5335;5344.5724342052545;5210.088234558937;5213.843584692465;5223.347081614798;5233.633645644806;5245.659032162936;13254.072214944958;13592.048556601041;13713.45146194151;14162.150270983773;14378;2367.3016460144127;2407.0251548123038;2670.8130430869846;2682.0344675916654;2789.9581506277423;10543.894561054369;10873.83689244662;11107.611233606865;11205.887941120565;11529.538818447252;1974.9506262343414;2031.065709773506;2079.4281572567666;2109.251215818393;2116.333354993172;88994;89703;90652.54673726589;91685.54157229238;94306;11688.532458701728;11793.410329483491;11940.50743657043;12004;12280.447379867928;17154.228059737343;17168.570785730455;17214.31142754301;17227.22477488516;17230.310787568607;8653.264472519906;9065.501397423204;9176.6788162414;9245.90754092464;9336.813263734823;8771.824563508822;8821.735347939572;8843.69047083349;9071.818563628822;9092.227160691415;5117.744112794346;5171.560417364566;5200.933808569234;5219.747260657491;5239.1355426354985;2122.4269447249467;2184.85798423102;2208.403730992623;2228.621134407155;2265.08264153015;934.7569631895756;982.6757170133982;998.9610804762965;1039.1167507618616;1102.4322473925934;19926.202951882053;20002.39992800218;20223.289291856894;20249;20347.186112555628;1022.6676330192718;1042;1042.1454407386022;1052.9631462898762;1111.1888321525332;10773.946130269298;11197.888021119847;11263.098952083814;11398.886011139783;11422.31466112036;365560;374332;377136;517499;562563;88992;96348;98849;100700.49649751704;104933;1069.3263244156287;1071.341125208007;1092.8961748633867;1100.3178029621686;1116.4585176189541;16543.669126617642;17507.38724144649;17956.730649040015;18104.36634717831;18557;38675.22649546937;40319.596804031586;41082.383764242964;41112;45096.77451612721;56946;59002;62492.68753656385;62905.685471572346;63803.68098159479;8807;8930.106989301277;9038.367314287936;9087.36388452802;9098.363114581916;13257.602271931857;13660.453581856615;13696.93151534236;13743;13949;11711.472983715923;11963.162578619413;12099.75800484003;12120;12137.757244855231;5626.1842032905815;9571.042895710652;11293.661190164308;11497.540098396305;12073.215241009306;6373.107764912823;9688.564014619218;10335.638252661121;12130;12388.380580971096;9096.954515227382;9289.442633442015;9449.43303401798;9455.763605909908;9481.573329200064;10585.470726463493;11478.827817582576;11521.82717259225;11546.364949927498;11689.240199387013 15:19:42 INFO - PROCESS | 15468 | |3;mootools.html;1336.6524703577068;1434.6054834920396;1449.78978048183;1604.9839501604981;1618.8866779325438;7687.577183254933;7848.8037799055055;8017.0379554453475;8664.826703465935;8670.436421632605;8341.082480927093;8577.828443431128;8584.95707521463;8604.741857744262;8620.612072456739;2408;2439.7560243975636;2446.1438496526252;2450.7181674107437;2456;2404.1825779235055;2429.441228517433;2473.6042233242683;2482.317362725256;2483.3915690655813;2379.167291447997;2392.091005417939;2394.9760502395015;2420.540097381501;2428.453597940458;2320.5938960681815;2324.6513023046596;2339.8830058497006;2351.1183306260154;2356.7643235676464;2365.3022358404314;2371.513839662865;2394.0902457066377;2409.5180963807306;2411.9155829546057;8452.154784521561;8488.915110848875;8522.40343175978;8584.828303433958;8625.741227763114;5224.059669259532;5324.92012619811;5351;5352.464753524655;5354.785808567653;3492.3189977954307;3516.77303142043;3517.683408493248;3585.2112535242204;3619.9819000904827;1173.1318824070213;1186.2408058842348;1186.8160435132568;1222.541546919905;1253.6051143889645;11638.825417618742;11688.064954803594;11741.236819606698;11771.94114029433;11774.234674746114;4713.269443236304;4730.390969429763;4775.42694876617;4805.27920811881;4894.143524883131;9950.552225149886;9956.502174891226;9962.501874906371;9975.600975961026;9993.10062094415;5387.784488620411;5395.433479484676;5406.405295417501;5407.188921661782;5421.2139239810795;4393.626541743987;4461.353103799931;4834.95165048352;4965.4289756678445;5023.773930173151;4047.1298670785923;4074.796260186979;4098.159877225162;4121.093359460914;4149.668026557929;1310.0567591334225;1316.1905428161613;1342.7381660576093;1349.352310890778;1351.3378444562093;1007.7833265847731;1035.5909415780725;1047.8061558611682;1053.7312985188728;1062.7502536903821;5965.254343207099;5972.552058595623;6025.578209525379;6181.690915454299;6231.376862313823;491.99754001229763;496;504.75267119112107;505.0807530294828;518.2433646875528;4298.140371925628;4315.741055536678;4339.1104823511105;4364.8908777280185;4408.316710909814;10054.798904021878;10430.843537346946;10464.476776161162;10477.21420893436;10533.210009249184;9558.665446709332;9826.263030272616;9937.503124843728;10164.898351016544;10195.694129176136;8008.839823203503;8049.356051515864;8144.755657330171;8198.385121115822;8234.505929644241;5985.567565949016;6069.726862291119;6155.446009859134;6260.593061450991;6278.497720182466;9307.581158847732;9453.810923781624;9466.290028247771;9487.905120948702;9509.809803804024;9107.681231156877;9393.624255029723;9393.85909211376;9693.854592180982;9721.173700235558;6720.865582688417;6902.309769023058;7351.485396022227;7510.136334321623;7543.622818859145;8020.518768873886;8377.539235342114;8389.496630202208;8415.284700800501;8441.155884411755;7463.2536746327105;7483.663235154322;7539.886901696588;7639.197884222077;7783.221677832398;7290.744823931137;7354.448416368687;7355.411567074728;7497.10034795828;7499.437542184249;6430.614163150039;6475.417212450902;6507.837304067436;6509.479241660751;6511.511636627177;5236.581073514186;5282;5347.465253474621;5366.302380690485;5433.728313584226;5204.947950520446;5257.4742525747115;5329.973350133225;5489.533389661923;5539.169124631338 15:19:42 INFO - PROCESS | 15468 | |4;prototype.html;344.3973047167457;358.64494150790716;361.2540104683828;375.3750006239611;376.15928400025956;5481.75332110055;5578.30271216098;5699.316082070152;5770;5794.188813566099;5514.36584792749;5598.244237028;5605.495505404513;5647;5652.851916271811;4436.3123715824095;4452.866414007569;4458.821647134111;4478.888027799315;4487.19230538503;4213.178430206111;4413.183561041217;4425.5353187915125;4471.508134105262;4487.214737420954;4353.499347575022;4380.255356589388;4382.386465894761;4386.429764130658;4396.956030439686;4370.628496577795;4394.868153955386;4406.5373135820755;4423.646108311327;4463.709858859163;3810.6760925321382;3882.4758657581147;3941.8226179821977;3943.4676318696897;3944.349182384903;5431.592630552725;5435.320584926884;5445.700486473243;5463.153211252262;5487;4995.9500404996215;5025.246213068032;5028.3909149072315;5042.193249080129;5128.71792051437;5737.88524229513;5883.676397798119;5922.170896074553;5960.672163031031;5976.402359764033;4292.1630282095;4298.828046878121;4300.956990430087;4302.483701955754;4303.419038429804;6192.854321950408;6204.410580994799;6217.906731399033;6222.595531290497;6247.156633854417;4295.6778241632;4390.758508282075;4416.227160247008;4427.380166776654;4436.201483732894;4445.488768791631;4447.799849006802;4483.7533935633855;4495.752733599618;4497.505274419811;5025.748712564357;5100.6429549931145;5112.897742045213;5116.437191908962;5135.507854658793;5777.306723193244;5851;5954.469350526009;6001.159837622737;6056.454919057218;1472.3595236072342;1482.4366740638704;1487.7917091607183;1490.8658220760183;1493.9402423902923;1008.9142422893989;1010.5149528226492;1023.9635219190673;1033.421284080917;1042.1975079188983;5526.673598336451;5532.86167845799;5577.358603760619;5590.133529302964;5679.659220446786;5875.149327961678;5946.791862284799;5961.731722072517;5965.791197308074;5966.642001479925;5386.515213630713;5609.775608975677;5616.382197958222;5618.887622247614;5622.606417550732;3118.43868103739;3147.6694947030232;3149.850304638836;3150.9129350374083;3156.6212054553143;5683;6059.545534084873;6114.816555503342;6123.499742563012;6151.384861513813;5900.616459930091;5955.821325360246;5971.641701497924;5989.700514974234;5996.800639872043;6006;6034.155218269446;6120.204373431515;6164.291106522717;6191.349908259658;5687.77248910039;5789.768409263751;5832;5841.130838131757;5856.853578660568;5798.884022319446;5818.359980402068;5845.590808643354;5854.5609079320075;5857.238558987305;6011.579189456696;6112.694365281807;6122.234720659918;6126;6349.396807303298;4341.3922050913525;4378.343248512749;4381.737095774264;4383.758893260774;4388.758618276025;5920.674362910081;6034;6172.88269423956;6191.721372538156;6203.379662033761;5885.646301350799;5994.771071930331;6003.429674180946;6005.219321488178;6038.275406951194;5961.016432288624;5963.91054134197;5973.342932277533;5977.671228082497;5984.730687119177;5795.971020144872;5924.7926322578505;5930.495907847709;5943.1679564861815;5997.820065398045;5953.464188223081;5992.191054207626;6030.819075427744;6033.185519954925;6036.607620504653;5726.599138060295;5845.678487683048;5849.888521180962;5885;5890.587658863838 15:19:42 INFO - PROCESS | 15468 | |5;yui.html;728.1262485017976;762.0664685759945;813.9186081391862;845.4631309118708;866.7269810009842;15949.68100637988;16692.415765448197;16776.245068971893;16804.411845585408;16862.325506979738;14784.852151478482;14831.03598266112;14837.406503739865;14839.851601483982;14842.183679897602;839.5844057191683;855.7261676263598;856.9014563325235;860.5525126933991;861.0786458489418;848.588434609214;848.9151084891492;852.9317654587649;852.9658813647446;853.5049671190694;897.6229983406985;898.9910100898973;900.5992333411634;901.197933838884;903.4940433357341;887.1128871128872;892.1346294094718;895.879056327394;898.9370744047919;900.5812297281796;655.8983357579583;657.4838751579987;657.5922927784757;660.5277226782825;661.3188415931598;14202.786958195635;14354.210518421483;14384.208868512227;14497.347619357155;14549.854501455062;11992.340421276826;13008.089433739642;13224.537141200011;13276.86723132766;13501.729965400735;11631.439564283199;11757.294562326288;11798.764024719543;11802.527898884035;12411.379431028412;3882.9805850970847;3896.941545876814;3920.5099362579676;3966.167104907944;4028.3756017817286;67197;67230.66384668046;67813;68369.3163068373;68404;10117.949410252902;10314.896851031544;10329.173666106693;10404.063634272952;10626;20156.596868062556;20279.08744106519;20281.594368112554;20296.695549566768;20360;8254.8349033019;8414.410991230556;8544.700935467228;8840.33697472692;8846.336524760669;4819.2530157825595;4876.487968763229;4889.119958407521;4899.191633380452;4965.528274813887;3384.221629025338;3462.2036931505895;3487.6512348764923;3491.284286721216;3501.7373696972318;601.2604496469368;601.9736349524138;607.5625549604277;612.3050337866554;612.9295131059985;669.7655820462799;684.2234064337014;693.1924308180912;705.7071315404153;727.0766127018657;9075.54622268884;10362.948185259176;10537.84193237102;10676.893231067745;10738.73153171177;684.7021545627667;701.2006312803409;766.7469734987441;777.6889244302324;783.2285199078902;4453.941966184893;4731.881702957385;4767.785449654774;4788.377510923628;4802.927956080662;80759;81987;82095.17904820995;82414.17585824065;83252.16747832565;48049.27926081111;58155.41844581585;72592;73507;73630;68158;69162;70275;71890;74966.25033749701;8832.116788321116;8855.91144088551;8958.68644597436;8970.058143895058;8994.370394072352;44669.55330446784;44861.77569112134;45019.32471012872;45986.31020534628;46242;55953;57961.42038579729;62506.687466562376;62651.686741566;64175;11238.719032024264;11635.709107272385;11829.763404731684;11851.644450666494;12482.625521234377;13079.803802942773;13330.866691332962;13410.319605660414;13517.59447216585;13548;10786.460676965964;10940.945295273472;11159.442027898735;11803.403251284704;11836.289822610672;11311.886881131413;11596.130290228435;11805;11822.527098916291;11925.194702118368;11254.718632034264;11789.115816313639;11869.881301186877;12062.336571488653;12104.576339828063;9444.0555944405;9515.000924902786;9517.476538790434;9522.575113286972;9562.009777187213;9011.23404510624;9543.618255269712;9683.564239609375;9690.806183876142;9710.417374957526 15:19:42 INFO - PROCESS | 15468 | __end_tp_report 15:19:42 INFO - PROCESS | 15468 | __start_cc_report 15:19:42 INFO - PROCESS | 15468 | _x_x_mozilla_cycle_collect,306 15:19:42 INFO - PROCESS | 15468 | __end_cc_report 15:19:42 INFO - PROCESS | 15468 | __startTimestamp1479251982164__endTimestamp 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | ------- Summary: start ------- 15:19:42 INFO - PROCESS | 15468 | Number of tests: 6 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#0] dojo.html Cycles:165 Average:5598.77 Median:5789.48 stddev:638.03 (11.0%) stddev-sans-first:612.06 15:19:42 INFO - PROCESS | 15468 | Values: 3218.6 3238.0 3261.8 3281.8 3284.5 5590.9 5611.3 5657.7 5665.9 5669.5 5530.4 5632.8 5642.9 5644.1 5680.2 5106.8 5137.1 5162.0 5185.7 5195.9 5185.4 5188.2 5197.8 5199.5 5205.7 4973.0 5001.3 5195.0 5199.1 5224.7 5073.0 5080.6 5087.2 5098.2 5121.3 5050.7 5059.8 5075.6 5131.5 5157.4 5538.6 5542.9 5575.8 5620.8 5631.1 6025.4 6075.7 6089.8 6102.3 6122.5 6142.2 6153.9 6173.3 6200.3 6203.5 5496.5 5548.5 5576.2 5743.1 5749.8 6121.4 6123.2 6160.2 6175.2 6183.0 5942.9 5946.8 5958.1 5972.7 5977.5 5843.4 5882.4 6048.5 6057.9 6060.5 5835.9 5850.8 5877.1 5911.4 5958.5 5871.5 5873.9 5926.7 5932.4 5934.6 4553.7 4573.4 4602.2 4604.7 4633.7 4041.6 4079.0 4101.9 4143.9 4186.4 5738.5 5744.0 5754.3 5775.9 5804.0 5783.8 5821.7 6037.1 6086.1 6088.3 5554.9 5626.2 5663.9 5720.9 5778.7 5153.8 5175.6 5197.2 5199.3 5208.4 6090.0 6195.3 6218.3 6258.3 6268.8 5946.4 5996.0 6016.2 6025.3 6116.1 6225.8 6238.5 6255.5 6280.8 6281.6 5972.7 5985.9 6001.6 6003.5 6033.7 5882.0 5931.9 6051.2 6059.7 6073.5 5969.6 6027.8 6030.5 6031.5 6034.1 5928.4 5968.5 5994.8 5997.3 6000.3 5652.7 5780.6 5789.5 5827.9 5895.9 5888.1 5908.4 5916.2 5936.1 5948.8 5739.3 5741.5 5748.5 5775.6 5780.9 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#1] ext.html Cycles:180 Average:62243.28 Median:21388.27 stddev:119389.97 (558.2%) stddev-sans-first:119635.09 15:19:42 INFO - PROCESS | 15468 | Values: 569.8 592.4 615.4 698.8 703.8 43309.4 44316.3 44343.3 44411.8 44438.0 45477.5 46628.0 46690.8 46859.5 46890.8 8692.1 10564.8 10867.3 10869.9 11184.4 10776.1 10857.1 10859.1 10859.4 10872.1 10844.1 10920.2 10935.5 10948.3 10972.5 10746.9 10842.5 10873.6 10874.6 10888.9 10615.9 10696.3 10704.7 10711.7 10738.8 43832.8 44192.8 44264.8 44291.6 44326.6 3791.2 3860.9 3921.3 3923.7 4061.2 33569.0 33644.7 33659.5 33704.0 33921.8 4454.8 4507.1 4536.1 4553.1 4588.2 378566.0 381474.0 384102.0 384790.0 385486.0 63191.4 63303.0 63568.4 63797.4 63841.0 68273.3 68635.0 68955.7 69075.0 69095.7 18008.4 18202.7 19283.8 19689.8 19803.9 14943.6 15227.8 15249.6 15578.1 15620.2 20430.9 20533.3 20546.0 20601.5 20609.5 7428.2 7536.7 7592.7 7623.6 7625.2 973.3 1047.6 1092.1 1118.8 1159.6 32295.0 32459.7 32915.0 33010.5 33105.5 1134.1 1141.6 1176.2 1216.8 1245.7 17004.6 17152.7 17170.9 17371.5 17401.0 508230.0 510530.0 511261.0 511952.0 512466.0 41037.0 41045.0 41265.6 41272.0 41310.0 1364.4 1393.7 1398.9 1441.5 1444.8 31190.2 32090.5 32997.2 33190.5 33525.8 58911.4 59177.0 59712.1 59823.4 59998.4 448620.0 452574.0 453952.0 454127.0 455333.0 28837.0 29836.7 30056.7 30592.2 32157.2 49874.5 50314.0 50553.5 51466.2 54567.0 42198.4 43111.6 43671.0 44919.0 45493.0 43082.6 43237.6 44027.6 44226.8 44704.0 42583.8 43426.3 43450.8 43466.3 43655.8 36715.3 38915.6 39078.2 39759.8 40482.8 28961.1 29144.9 29153.8 29399.6 29686.4 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#2] jquery.html Cycles:180 Average:28008.79 Median:2387.16 stddev:74502.96 (3121.0%) stddev-sans-first:74683.19 15:19:42 INFO - PROCESS | 15468 | Values: 430.7 433.4 436.6 439.6 449.7 18567.2 18580.9 20013.5 20112.4 20170.2 17568.7 19105.8 19736.6 19736.7 20050.0 5190.9 5384.9 5409.5 5421.1 5441.5 5185.3 5261.0 5320.4 5355.7 5415.2 5284.3 5302.4 5332.0 5346.4 5347.7 5197.4 5270.4 5334.2 5335.0 5344.6 5210.1 5213.8 5223.3 5233.6 5245.7 13254.1 13592.0 13713.5 14162.2 14378.0 2367.3 2407.0 2670.8 2682.0 2790.0 10543.9 10873.8 11107.6 11205.9 11529.5 1975.0 2031.1 2079.4 2109.3 2116.3 88994.0 89703.0 90652.5 91685.5 94306.0 11688.5 11793.4 11940.5 12004.0 12280.4 17154.2 17168.6 17214.3 17227.2 17230.3 8653.3 9065.5 9176.7 9245.9 9336.8 8771.8 8821.7 8843.7 9071.8 9092.2 5117.7 5171.6 5200.9 5219.7 5239.1 2122.4 2184.9 2208.4 2228.6 2265.1 934.8 982.7 999.0 1039.1 1102.4 19926.2 20002.4 20223.3 20249.0 20347.2 1022.7 1042.0 1042.1 1053.0 1111.2 10773.9 11197.9 11263.1 11398.9 11422.3 365560.0 374332.0 377136.0 517499.0 562563.0 88992.0 96348.0 98849.0 100700.5 104933.0 1069.3 1071.3 1092.9 1100.3 1116.5 16543.7 17507.4 17956.7 18104.4 18557.0 38675.2 40319.6 41082.4 41112.0 45096.8 56946.0 59002.0 62492.7 62905.7 63803.7 8807.0 8930.1 9038.4 9087.4 9098.4 13257.6 13660.5 13696.9 13743.0 13949.0 11711.5 11963.2 12099.8 12120.0 12137.8 5626.2 9571.0 11293.7 11497.5 12073.2 6373.1 9688.6 10335.6 12130.0 12388.4 9097.0 9289.4 9449.4 9455.8 9481.6 10585.5 11478.8 11521.8 11546.4 11689.2 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#3] mootools.html Cycles:180 Average:5668.63 Median:5269.74 stddev:3078.34 (58.4%) stddev-sans-first:3069.75 15:19:42 INFO - PROCESS | 15468 | Values: 1336.7 1434.6 1449.8 1605.0 1618.9 7687.6 7848.8 8017.0 8664.8 8670.4 8341.1 8577.8 8585.0 8604.7 8620.6 2408.0 2439.8 2446.1 2450.7 2456.0 2404.2 2429.4 2473.6 2482.3 2483.4 2379.2 2392.1 2395.0 2420.5 2428.5 2320.6 2324.7 2339.9 2351.1 2356.8 2365.3 2371.5 2394.1 2409.5 2411.9 8452.2 8488.9 8522.4 8584.8 8625.7 5224.1 5324.9 5351.0 5352.5 5354.8 3492.3 3516.8 3517.7 3585.2 3620.0 1173.1 1186.2 1186.8 1222.5 1253.6 11638.8 11688.1 11741.2 11771.9 11774.2 4713.3 4730.4 4775.4 4805.3 4894.1 9950.6 9956.5 9962.5 9975.6 9993.1 5387.8 5395.4 5406.4 5407.2 5421.2 4393.6 4461.4 4835.0 4965.4 5023.8 4047.1 4074.8 4098.2 4121.1 4149.7 1310.1 1316.2 1342.7 1349.4 1351.3 1007.8 1035.6 1047.8 1053.7 1062.8 5965.3 5972.6 6025.6 6181.7 6231.4 492.0 496.0 504.8 505.1 518.2 4298.1 4315.7 4339.1 4364.9 4408.3 10054.8 10430.8 10464.5 10477.2 10533.2 9558.7 9826.3 9937.5 10164.9 10195.7 8008.8 8049.4 8144.8 8198.4 8234.5 5985.6 6069.7 6155.4 6260.6 6278.5 9307.6 9453.8 9466.3 9487.9 9509.8 9107.7 9393.6 9393.9 9693.9 9721.2 6720.9 6902.3 7351.5 7510.1 7543.6 8020.5 8377.5 8389.5 8415.3 8441.2 7463.3 7483.7 7539.9 7639.2 7783.2 7290.7 7354.4 7355.4 7497.1 7499.4 6430.6 6475.4 6507.8 6509.5 6511.5 5236.6 5282.0 5347.5 5366.3 5433.7 5204.9 5257.5 5330.0 5489.5 5539.2 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#4] prototype.html Cycles:180 Average:4967.30 Median:5613.08 stddev:1443.40 (25.7%) stddev-sans-first:1405.13 15:19:42 INFO - PROCESS | 15468 | Values: 344.4 358.6 361.3 375.4 376.2 5481.8 5578.3 5699.3 5770.0 5794.2 5514.4 5598.2 5605.5 5647.0 5652.9 4436.3 4452.9 4458.8 4478.9 4487.2 4213.2 4413.2 4425.5 4471.5 4487.2 4353.5 4380.3 4382.4 4386.4 4397.0 4370.6 4394.9 4406.5 4423.6 4463.7 3810.7 3882.5 3941.8 3943.5 3944.3 5431.6 5435.3 5445.7 5463.2 5487.0 4996.0 5025.2 5028.4 5042.2 5128.7 5737.9 5883.7 5922.2 5960.7 5976.4 4292.2 4298.8 4301.0 4302.5 4303.4 6192.9 6204.4 6217.9 6222.6 6247.2 4295.7 4390.8 4416.2 4427.4 4436.2 4445.5 4447.8 4483.8 4495.8 4497.5 5025.7 5100.6 5112.9 5116.4 5135.5 5777.3 5851.0 5954.5 6001.2 6056.5 1472.4 1482.4 1487.8 1490.9 1493.9 1008.9 1010.5 1024.0 1033.4 1042.2 5526.7 5532.9 5577.4 5590.1 5679.7 5875.1 5946.8 5961.7 5965.8 5966.6 5386.5 5609.8 5616.4 5618.9 5622.6 3118.4 3147.7 3149.9 3150.9 3156.6 5683.0 6059.5 6114.8 6123.5 6151.4 5900.6 5955.8 5971.6 5989.7 5996.8 6006.0 6034.2 6120.2 6164.3 6191.3 5687.8 5789.8 5832.0 5841.1 5856.9 5798.9 5818.4 5845.6 5854.6 5857.2 6011.6 6112.7 6122.2 6126.0 6349.4 4341.4 4378.3 4381.7 4383.8 4388.8 5920.7 6034.0 6172.9 6191.7 6203.4 5885.6 5994.8 6003.4 6005.2 6038.3 5961.0 5963.9 5973.3 5977.7 5984.7 5796.0 5924.8 5930.5 5943.2 5997.8 5953.5 5992.2 6030.8 6033.2 6036.6 5726.6 5845.7 5849.9 5885.0 5890.6 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - PROCESS | 15468 | [#5] yui.html Cycles:180 Average:17338.18 Median:56957.21 stddev:22686.71 (39.8%) stddev-sans-first:22716.07 15:19:42 INFO - PROCESS | 15468 | Values: 728.1 762.1 813.9 845.5 866.7 15949.7 16692.4 16776.2 16804.4 16862.3 14784.9 14831.0 14837.4 14839.9 14842.2 839.6 855.7 856.9 860.6 861.1 848.6 848.9 852.9 853.0 853.5 897.6 899.0 900.6 901.2 903.5 887.1 892.1 895.9 898.9 900.6 655.9 657.5 657.6 660.5 661.3 14202.8 14354.2 14384.2 14497.3 14549.9 11992.3 13008.1 13224.5 13276.9 13501.7 11631.4 11757.3 11798.8 11802.5 12411.4 3883.0 3896.9 3920.5 3966.2 4028.4 67197.0 67230.7 67813.0 68369.3 68404.0 10117.9 10314.9 10329.2 10404.1 10626.0 20156.6 20279.1 20281.6 20296.7 20360.0 8254.8 8414.4 8544.7 8840.3 8846.3 4819.3 4876.5 4889.1 4899.2 4965.5 3384.2 3462.2 3487.7 3491.3 3501.7 601.3 602.0 607.6 612.3 612.9 669.8 684.2 693.2 705.7 727.1 9075.5 10362.9 10537.8 10676.9 10738.7 684.7 701.2 766.7 777.7 783.2 4453.9 4731.9 4767.8 4788.4 4802.9 80759.0 81987.0 82095.2 82414.2 83252.2 48049.3 58155.4 72592.0 73507.0 73630.0 68158.0 69162.0 70275.0 71890.0 74966.3 8832.1 8855.9 8958.7 8970.1 8994.4 44669.6 44861.8 45019.3 45986.3 46242.0 55953.0 57961.4 62506.7 62651.7 64175.0 11238.7 11635.7 11829.8 11851.6 12482.6 13079.8 13330.9 13410.3 13517.6 13548.0 10786.5 10940.9 11159.4 11803.4 11836.3 11311.9 11596.1 11805.0 11822.5 11925.2 11254.7 11789.1 11869.9 12062.3 12104.6 9444.1 9515.0 9517.5 9522.6 9562.0 9011.2 9543.6 9683.6 9690.8 9710.4 15:19:42 INFO - PROCESS | 15468 | -------- Summary: end -------- 15:19:42 INFO - PROCESS | 15468 | 15:19:42 INFO - TEST-INFO | 15468: exit 0 15:19:42 INFO - TEST-OK | dromaeo_css | took 1112898ms 15:19:42 INFO - TEST-START | kraken 15:19:42 INFO - operating with platform_type : linux_ 15:19:42 INFO - Initialising browser for kraken test... 15:19:42 INFO - TEST-INFO | started process 15851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMGzSKE/profile http://localhost:54339/getInfo.html) 15:19:45 ERROR - PROCESS | 15851 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 15:19:47 INFO - PROCESS | 15851 | __metrics Screen width/height:1600/1200 15:19:47 INFO - PROCESS | 15851 | colorDepth:24 15:19:47 INFO - PROCESS | 15851 | Browser inner width/height: 1024/697 15:19:47 INFO - PROCESS | 15851 | __metrics 15:19:47 ERROR - PROCESS | 15851 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 15:19:48 INFO - TEST-INFO | 15851: exit 0 15:19:48 INFO - Browser initialized. 15:19:48 INFO - Running cycle 1/1 for kraken test... 15:19:48 INFO - TEST-INFO | started process 15983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMGzSKE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:00 INFO - PROCESS | 15983 | RSS: Main: 152137728 15:20:00 INFO - PROCESS | 15983 | 15:20:03 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54339/tests/kraken/driver.html?testName=audio-beat-detection) 15:20:04 INFO - PROCESS | 15983 | RSS: Main: 157257728 15:20:04 INFO - PROCESS | 15983 | 15:20:06 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54339/tests/kraken/driver.html?testName=audio-dft) 15:20:07 INFO - PROCESS | 15983 | RSS: Main: 155402240 15:20:07 INFO - PROCESS | 15983 | 15:20:10 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54339/tests/kraken/driver.html?testName=audio-fft) 15:20:10 INFO - PROCESS | 15983 | RSS: Main: 155926528 15:20:10 INFO - PROCESS | 15983 | 15:20:12 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54339/tests/kraken/driver.html?testName=audio-oscillator) 15:20:13 INFO - PROCESS | 15983 | RSS: Main: 155451392 15:20:13 INFO - PROCESS | 15983 | 15:20:15 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:20:16 INFO - PROCESS | 15983 | RSS: Main: 155447296 15:20:16 INFO - PROCESS | 15983 | 15:20:19 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54339/tests/kraken/driver.html?testName=imaging-darkroom) 15:20:19 INFO - PROCESS | 15983 | RSS: Main: 158662656 15:20:19 INFO - PROCESS | 15983 | 15:20:23 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54339/tests/kraken/driver.html?testName=imaging-desaturate) 15:20:23 INFO - PROCESS | 15983 | RSS: Main: 158605312 15:20:23 INFO - PROCESS | 15983 | 15:20:26 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54339/tests/kraken/driver.html?testName=json-parse-financial) 15:20:27 INFO - PROCESS | 15983 | RSS: Main: 158646272 15:20:27 INFO - PROCESS | 15983 | 15:20:28 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:20:29 INFO - PROCESS | 15983 | RSS: Main: 157069312 15:20:29 INFO - PROCESS | 15983 | 15:20:31 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:20:31 INFO - PROCESS | 15983 | RSS: Main: 158240768 15:20:31 INFO - PROCESS | 15983 | 15:20:33 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:20:34 INFO - PROCESS | 15983 | RSS: Main: 157630464 15:20:34 INFO - PROCESS | 15983 | 15:20:37 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:20:37 INFO - PROCESS | 15983 | RSS: Main: 157913088 15:20:37 INFO - PROCESS | 15983 | 15:20:40 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:20:41 INFO - PROCESS | 15983 | RSS: Main: 158298112 15:20:41 INFO - PROCESS | 15983 | 15:20:42 INFO - PROCESS | 15983 | Cycle 1(1): loaded http://localhost:54339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54339/tests/kraken/driver.html?testName=ai-astar) 15:20:43 INFO - PROCESS | 15983 | RSS: Main: 159358976 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | __start_tp_report 15:20:43 INFO - PROCESS | 15983 | _x_x_mozilla_page_load 15:20:43 INFO - PROCESS | 15983 | _x_x_mozilla_page_load_details 15:20:43 INFO - PROCESS | 15983 | |i|pagename|runs| 15:20:43 INFO - PROCESS | 15983 | |0;ai-astar;100;111;112;111;111;110;110;109;110;109 15:20:43 INFO - PROCESS | 15983 | |1;audio-beat-detection;144;123;123;161;125;122;122;124;147;123 15:20:43 INFO - PROCESS | 15983 | |2;audio-dft;162;164;165;162;165;162;162;164;162;163 15:20:43 INFO - PROCESS | 15983 | |3;audio-fft;76;75;75;108;75;75;77;76;98;76 15:20:43 INFO - PROCESS | 15983 | |4;audio-oscillator;81;81;117;82;83;82;94;82;84;113 15:20:43 INFO - PROCESS | 15983 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;118;117;124 15:20:43 INFO - PROCESS | 15983 | |6;imaging-darkroom;148;149;147;147;147;147;148;147;149;147 15:20:43 INFO - PROCESS | 15983 | |7;imaging-desaturate;85;86;85;87;85;87;85;85;85;85 15:20:43 INFO - PROCESS | 15983 | |8;json-parse-financial;52;52;52;53;53;58;51;55;51;52 15:20:43 INFO - PROCESS | 15983 | |9;json-stringify-tinderbox;61;60;59;61;61;61;61;65;60;60 15:20:43 INFO - PROCESS | 15983 | |10;stanford-crypto-aes;75;75;75;76;75;75;81;75;73;75 15:20:43 INFO - PROCESS | 15983 | |11;stanford-crypto-ccm;146;139;130;136;131;124;134;130;167;137 15:20:43 INFO - PROCESS | 15983 | |12;stanford-crypto-pbkdf2;161;158;158;154;155;158;160;156;164;158 15:20:43 INFO - PROCESS | 15983 | |13;stanford-crypto-sha256-iterative;65;63;62;62;61;63;62;64;64;66 15:20:43 INFO - PROCESS | 15983 | __end_tp_report 15:20:43 INFO - PROCESS | 15983 | __start_cc_report 15:20:43 INFO - PROCESS | 15983 | _x_x_mozilla_cycle_collect,821 15:20:43 INFO - PROCESS | 15983 | __end_cc_report 15:20:43 INFO - PROCESS | 15983 | __startTimestamp1479252043070__endTimestamp 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | ------- Summary: start ------- 15:20:43 INFO - PROCESS | 15983 | Number of tests: 14 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.40 (3.1%) stddev-sans-first:1.00 15:20:43 INFO - PROCESS | 15983 | Values: 100.0 111.0 112.0 111.0 111.0 110.0 110.0 109.0 110.0 109.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:124.50 stddev:13.99 (11.2%) stddev-sans-first:14.08 15:20:43 INFO - PROCESS | 15983 | Values: 144.0 123.0 123.0 161.0 125.0 122.0 122.0 124.0 147.0 123.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 15:20:43 INFO - PROCESS | 15983 | Values: 162.0 164.0 165.0 162.0 165.0 162.0 162.0 164.0 162.0 163.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.80 (15.5%) stddev-sans-first:12.37 15:20:43 INFO - PROCESS | 15983 | Values: 76.0 75.0 75.0 108.0 75.0 75.0 77.0 76.0 98.0 76.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.80 (16.8%) stddev-sans-first:14.25 15:20:43 INFO - PROCESS | 15983 | Values: 81.0 81.0 117.0 82.0 83.0 82.0 94.0 82.0 84.0 113.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:117.50 stddev:2.16 (1.8%) stddev-sans-first:2.26 15:20:43 INFO - PROCESS | 15983 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 124.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 15:20:43 INFO - PROCESS | 15983 | Values: 148.0 149.0 147.0 147.0 147.0 147.0 148.0 147.0 149.0 147.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 15:20:43 INFO - PROCESS | 15983 | Values: 85.0 86.0 85.0 87.0 85.0 87.0 85.0 85.0 85.0 85.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.13 (4.1%) stddev-sans-first:2.24 15:20:43 INFO - PROCESS | 15983 | Values: 52.0 52.0 52.0 53.0 53.0 58.0 51.0 55.0 51.0 52.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:1.60 (2.6%) stddev-sans-first:1.69 15:20:43 INFO - PROCESS | 15983 | Values: 61.0 60.0 59.0 61.0 61.0 61.0 61.0 65.0 60.0 60.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.07 (2.8%) stddev-sans-first:2.19 15:20:43 INFO - PROCESS | 15983 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 81.0 75.0 73.0 75.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:136.50 stddev:12.00 (8.8%) stddev-sans-first:12.32 15:20:43 INFO - PROCESS | 15983 | Values: 146.0 139.0 130.0 136.0 131.0 124.0 134.0 130.0 167.0 137.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:2.94 (1.9%) stddev-sans-first:2.93 15:20:43 INFO - PROCESS | 15983 | Values: 161.0 158.0 158.0 154.0 155.0 158.0 160.0 156.0 164.0 158.0 15:20:43 INFO - PROCESS | 15983 | 15:20:43 INFO - PROCESS | 15983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.55 (2.4%) stddev-sans-first:1.50 15:20:43 INFO - PROCESS | 15983 | Values: 65.0 63.0 62.0 62.0 61.0 63.0 62.0 64.0 64.0 66.0 15:20:43 INFO - PROCESS | 15983 | -------- Summary: end -------- 15:20:43 INFO - PROCESS | 15983 | 15:20:44 INFO - TEST-INFO | 15983: exit 0 15:20:44 INFO - TEST-OK | kraken | took 61283ms 15:20:44 INFO - SUITE-END | took 1174s 15:20:44 INFO - Completed test suite (00:19:34) 15:20:44 INFO - javascript benchmark 15:20:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7389.897399289153, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3218.5976752905885, 3237.9676203237964, 3261.8042917424955, 3281.7702760806746, 3284.458064419371, 5590.8602284942845, 5611.270534830472, 5657.66054036757, 5665.8583535411535, 5669.518090962268, 5530.364008139065, 5632.831015069544, 5642.887142257163, 5644.096944488882, 5680.204771332006, 5106.795728170878, 5137.12668846297, 5162.0, 5185.714785686786, 5195.922061169085, 5185.403678576974, 5188.247704082905, 5197.818076367328, 5199.506046925536, 5205.713685747282, 4973.030259099477, 5001.324821149135, 5194.974025129869, 5199.09015922214, 5224.7387630618505, 5073.0, 5080.5681517070725, 5087.160618497944, 5098.235264710304, 5121.334226550524, 5050.671706339113, 5059.797608095671, 5075.619328550373, 5131.461196574381, 5157.4068982067165, 5538.6399884007815, 5542.91685624716, 5575.776968921238, 5620.775168993236, 5631.099024156116, 6025.367336429699, 6075.726592303357, 6089.8173054807985, 6102.328743838174, 6122.47958923492, 6142.170806941095, 6153.876922461571, 6173.290071641729, 6200.348963358828, 6203.534734894901, 5496.5053145217125, 5548.528375088163, 5576.163575463632, 5743.10981797822, 5749.798757043525, 6121.4490695837585, 6123.221615589998, 6160.229971253593, 6175.166352542439, 6182.969085154546, 5942.881142377215, 5946.762129514857, 5958.076498142708, 5972.701364931736, 5977.491913187341, 5843.444872737083, 5882.3529411764675, 6048.4858787003595, 6057.939420605826, 6060.545459090586, 5835.912461313083, 5850.795222167204, 5877.089051197071, 5911.438413350725, 5958.463738263577, 5871.4715675589405, 5873.941260587425, 5926.703664816828, 5932.436418540318, 5934.6142500737315, 4553.749543775058, 4573.405457290531, 4602.194615942197, 4604.700694454849, 4633.72197668141, 4041.595840415935, 4078.9592104079175, 4101.938470922939, 4143.875683729493, 4186.413902053715, 5738.512226460798, 5744.0, 5754.251947246831, 5775.855603609859, 5804.04233301509, 5783.826485205451, 5821.650700957956, 6037.09443583466, 6086.117512960596, 6088.330283668793, 5554.91667624986, 5626.212330273765, 5663.915041274384, 5720.885582288414, 5778.711064446761, 5153.793848246029, 5175.611829112756, 5197.220416937414, 5199.29809475716, 5208.374995000549, 6089.969550152221, 6195.256569211633, 6218.31598524162, 6258.311585725566, 6268.811935641938, 5946.375630558729, 5995.970020149872, 6016.217891674054, 6025.3070896845675, 6116.052011938156, 6225.844353891189, 6238.532110091671, 6255.499560035278, 6280.842978925563, 6281.59169653971, 5972.70136493165, 5985.850353741192, 6001.579889407874, 6003.459688628044, 6033.728482218223, 5882.0, 5931.9110213345975, 6051.243594550681, 6059.697015149313, 6073.514118870568, 5969.582129250911, 6027.78902738402, 6030.517558595214, 6031.517478601789, 6034.125051867542, 5928.3775203603, 5968.46283834457, 5994.790182343597, 5997.31030931431, 6000.279966404059, 5652.717364131695, 5780.566457515787, 5789.478946894799, 5827.883442331215, 5895.941040589711, 5888.057910734262, 5908.438698323653, 5916.230889984275, 5936.079907614327, 5948.8215353537735, 5739.282589676291, 5741.5406767459335, 5748.511376533042, 5775.595708300379, 5780.942190578208], "value": 5555.5188625255905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.7521578113518, 592.3572923378134, 615.4430240632228, 698.8252936765808, 703.7958991892348, 43309.35035974463, 44316.3352549712, 44343.33484997728, 44411.77794111029, 44438.0, 45477.54522454783, 46628.0, 46690.76654616731, 46859.53140468594, 46890.765546172304, 8692.087330830282, 10564.841527377095, 10867.29362591433, 10869.945650271737, 11184.44077796111, 10776.137908967303, 10857.077148442391, 10859.07697845684, 10859.40273284969, 10872.075873550757, 10844.078253348474, 10920.18098642605, 10935.507902144423, 10948.343099414022, 10972.451377431136, 10746.892531074707, 10842.457877106113, 10873.565057397695, 10874.619388321371, 10888.891111088946, 10615.893841061568, 10696.304740191863, 10704.732381690443, 10711.678649640524, 10738.78522429547, 43832.78083609593, 44192.77903610461, 44264.77867610673, 44291.55708442939, 44326.55673443257, 3791.241751649681, 3860.9227815443815, 3921.3333733265413, 3923.744956577842, 4061.248668996245, 33569.0, 33644.66355336464, 33659.495107573406, 33704.0, 33921.83039084813, 4454.844080457201, 4507.076049409896, 4536.072268283629, 4553.112143132091, 4588.220002599566, 378566.0, 381474.0, 384102.0, 384790.0, 385486.0, 63191.36808631947, 63303.0, 63568.36431635717, 63797.36202638007, 63841.0, 68273.3172668277, 68635.0, 68955.65522172357, 69075.0, 69095.65452172708, 18008.36970706019, 18202.726959095624, 19283.807161928202, 19689.803101969082, 19803.900980495004, 14943.626409339853, 15227.771583426258, 15249.6187595311, 15578.143202123765, 15620.218989050501, 20430.897845510677, 20533.2813351532, 20546.0, 20601.48496287605, 20609.48476288105, 7428.182899881009, 7536.6985320587655, 7592.658330375147, 7623.618819059025, 7625.199354067854, 973.338130071544, 1047.5966752800227, 1092.1044743310567, 1118.7762447510531, 1159.5999380213814, 32295.0, 32459.675403246136, 32915.0, 33010.504842427385, 33105.50341744876, 1134.0587312530745, 1141.6175581180232, 1176.2178151529138, 1216.8478940132484, 1245.6761242076943, 17004.574885627957, 17152.742708859376, 17170.914145429444, 17371.478855634352, 17401.0, 508230.0, 510530.0, 511261.0, 511952.0, 512466.0, 41037.0, 41045.0, 41265.587344126776, 41272.0, 41310.0, 1364.3996641477718, 1393.6515871032243, 1398.923059231752, 1441.4738620403687, 1444.8482909294582, 31190.22024449407, 32090.518642220854, 32997.17507062342, 33190.5021424674, 33525.83237083799, 58911.41088589231, 59177.0, 59712.104318436126, 59823.401765981784, 59998.40001599928, 448620.0, 452574.0, 453952.0, 454127.0, 455333.0, 28837.0, 29836.701632983393, 30056.69943300539, 30592.235194120323, 32157.1960700975, 49874.501254986986, 50314.0, 50553.49446505488, 51466.22800658068, 54567.0, 42198.367024494044, 43111.56888431076, 43671.0, 44919.0, 45493.0, 43082.56917430786, 43237.567624323354, 44027.559724402345, 44226.778866105466, 44704.0, 42583.787081064394, 43426.348604771585, 43450.782746086064, 43466.34800477932, 43655.78172109119, 36715.26569468649, 38915.61084389233, 39078.218435631694, 39759.80120099381, 40482.79758601188, 28961.131166065054, 29144.854275728485, 29153.833846645895, 29399.559006615345, 29686.40627187401], "value": 21568.713444762318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.71719884611554, 433.3954133983092, 436.55253365300564, 439.56263517799783, 449.7211728728189, 18567.164477598522, 18580.90709546452, 20013.499662508446, 20112.396628101145, 20170.193192272327, 17568.736468952975, 19105.808941910578, 19736.60526789467, 19736.70394944077, 20050.0, 5190.896182076347, 5384.865378365553, 5409.486098820606, 5421.105517589593, 5441.5102640762325, 5185.325907632003, 5260.973695131519, 5320.441353657869, 5355.705436201008, 5415.187721841736, 5284.2602035714835, 5302.416734159239, 5332.040232758102, 5346.4118946915805, 5347.7058761768085, 5197.428282888879, 5270.367555893317, 5334.199870019509, 5335.0, 5344.5724342052545, 5210.088234558937, 5213.843584692465, 5223.347081614798, 5233.633645644806, 5245.659032162936, 13254.072214944958, 13592.048556601041, 13713.45146194151, 14162.150270983773, 14378.0, 2367.3016460144127, 2407.0251548123038, 2670.8130430869846, 2682.0344675916654, 2789.9581506277423, 10543.894561054369, 10873.83689244662, 11107.611233606865, 11205.887941120565, 11529.538818447252, 1974.9506262343414, 2031.065709773506, 2079.4281572567666, 2109.251215818393, 2116.333354993172, 88994.0, 89703.0, 90652.54673726589, 91685.54157229238, 94306.0, 11688.532458701728, 11793.410329483491, 11940.50743657043, 12004.0, 12280.447379867928, 17154.228059737343, 17168.570785730455, 17214.31142754301, 17227.22477488516, 17230.310787568607, 8653.264472519906, 9065.501397423204, 9176.6788162414, 9245.90754092464, 9336.813263734823, 8771.824563508822, 8821.735347939572, 8843.69047083349, 9071.818563628822, 9092.227160691415, 5117.744112794346, 5171.560417364566, 5200.933808569234, 5219.747260657491, 5239.1355426354985, 2122.4269447249467, 2184.85798423102, 2208.403730992623, 2228.621134407155, 2265.08264153015, 934.7569631895756, 982.6757170133982, 998.9610804762965, 1039.1167507618616, 1102.4322473925934, 19926.202951882053, 20002.39992800218, 20223.289291856894, 20249.0, 20347.186112555628, 1022.6676330192718, 1042.0, 1042.1454407386022, 1052.9631462898762, 1111.1888321525332, 10773.946130269298, 11197.888021119847, 11263.098952083814, 11398.886011139783, 11422.31466112036, 365560.0, 374332.0, 377136.0, 517499.0, 562563.0, 88992.0, 96348.0, 98849.0, 100700.49649751704, 104933.0, 1069.3263244156287, 1071.341125208007, 1092.8961748633867, 1100.3178029621686, 1116.4585176189541, 16543.669126617642, 17507.38724144649, 17956.730649040015, 18104.36634717831, 18557.0, 38675.22649546937, 40319.596804031586, 41082.383764242964, 41112.0, 45096.77451612721, 56946.0, 59002.0, 62492.68753656385, 62905.685471572346, 63803.68098159479, 8807.0, 8930.106989301277, 9038.367314287936, 9087.36388452802, 9098.363114581916, 13257.602271931857, 13660.453581856615, 13696.93151534236, 13743.0, 13949.0, 11711.472983715923, 11963.162578619413, 12099.75800484003, 12120.0, 12137.757244855231, 5626.1842032905815, 9571.042895710652, 11293.661190164308, 11497.540098396305, 12073.215241009306, 6373.107764912823, 9688.564014619218, 10335.638252661121, 12130.0, 12388.380580971096, 9096.954515227382, 9289.442633442015, 9449.43303401798, 9455.763605909908, 9481.573329200064, 10585.470726463493, 11478.827817582576, 11521.82717259225, 11546.364949927498, 11689.240199387013], "value": 9318.939346796222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.6524703577068, 1434.6054834920396, 1449.78978048183, 1604.9839501604981, 1618.8866779325438, 7687.577183254933, 7848.8037799055055, 8017.0379554453475, 8664.826703465935, 8670.436421632605, 8341.082480927093, 8577.828443431128, 8584.95707521463, 8604.741857744262, 8620.612072456739, 2408.0, 2439.7560243975636, 2446.1438496526252, 2450.7181674107437, 2456.0, 2404.1825779235055, 2429.441228517433, 2473.6042233242683, 2482.317362725256, 2483.3915690655813, 2379.167291447997, 2392.091005417939, 2394.9760502395015, 2420.540097381501, 2428.453597940458, 2320.5938960681815, 2324.6513023046596, 2339.8830058497006, 2351.1183306260154, 2356.7643235676464, 2365.3022358404314, 2371.513839662865, 2394.0902457066377, 2409.5180963807306, 2411.9155829546057, 8452.154784521561, 8488.915110848875, 8522.40343175978, 8584.828303433958, 8625.741227763114, 5224.059669259532, 5324.92012619811, 5351.0, 5352.464753524655, 5354.785808567653, 3492.3189977954307, 3516.77303142043, 3517.683408493248, 3585.2112535242204, 3619.9819000904827, 1173.1318824070213, 1186.2408058842348, 1186.8160435132568, 1222.541546919905, 1253.6051143889645, 11638.825417618742, 11688.064954803594, 11741.236819606698, 11771.94114029433, 11774.234674746114, 4713.269443236304, 4730.390969429763, 4775.42694876617, 4805.27920811881, 4894.143524883131, 9950.552225149886, 9956.502174891226, 9962.501874906371, 9975.600975961026, 9993.10062094415, 5387.784488620411, 5395.433479484676, 5406.405295417501, 5407.188921661782, 5421.2139239810795, 4393.626541743987, 4461.353103799931, 4834.95165048352, 4965.4289756678445, 5023.773930173151, 4047.1298670785923, 4074.796260186979, 4098.159877225162, 4121.093359460914, 4149.668026557929, 1310.0567591334225, 1316.1905428161613, 1342.7381660576093, 1349.352310890778, 1351.3378444562093, 1007.7833265847731, 1035.5909415780725, 1047.8061558611682, 1053.7312985188728, 1062.7502536903821, 5965.254343207099, 5972.552058595623, 6025.578209525379, 6181.690915454299, 6231.376862313823, 491.99754001229763, 496.0, 504.75267119112107, 505.0807530294828, 518.2433646875528, 4298.140371925628, 4315.741055536678, 4339.1104823511105, 4364.8908777280185, 4408.316710909814, 10054.798904021878, 10430.843537346946, 10464.476776161162, 10477.21420893436, 10533.210009249184, 9558.665446709332, 9826.263030272616, 9937.503124843728, 10164.898351016544, 10195.694129176136, 8008.839823203503, 8049.356051515864, 8144.755657330171, 8198.385121115822, 8234.505929644241, 5985.567565949016, 6069.726862291119, 6155.446009859134, 6260.593061450991, 6278.497720182466, 9307.581158847732, 9453.810923781624, 9466.290028247771, 9487.905120948702, 9509.809803804024, 9107.681231156877, 9393.624255029723, 9393.85909211376, 9693.854592180982, 9721.173700235558, 6720.865582688417, 6902.309769023058, 7351.485396022227, 7510.136334321623, 7543.622818859145, 8020.518768873886, 8377.539235342114, 8389.496630202208, 8415.284700800501, 8441.155884411755, 7463.2536746327105, 7483.663235154322, 7539.886901696588, 7639.197884222077, 7783.221677832398, 7290.744823931137, 7354.448416368687, 7355.411567074728, 7497.10034795828, 7499.437542184249, 6430.614163150039, 6475.417212450902, 6507.837304067436, 6509.479241660751, 6511.511636627177, 5236.581073514186, 5282.0, 5347.465253474621, 5366.302380690485, 5433.728313584226, 5204.947950520446, 5257.4742525747115, 5329.973350133225, 5489.533389661923, 5539.169124631338], "value": 4555.137921780085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.3973047167457, 358.64494150790716, 361.2540104683828, 375.3750006239611, 376.15928400025956, 5481.75332110055, 5578.30271216098, 5699.316082070152, 5770.0, 5794.188813566099, 5514.36584792749, 5598.244237028, 5605.495505404513, 5647.0, 5652.851916271811, 4436.3123715824095, 4452.866414007569, 4458.821647134111, 4478.888027799315, 4487.19230538503, 4213.178430206111, 4413.183561041217, 4425.5353187915125, 4471.508134105262, 4487.214737420954, 4353.499347575022, 4380.255356589388, 4382.386465894761, 4386.429764130658, 4396.956030439686, 4370.628496577795, 4394.868153955386, 4406.5373135820755, 4423.646108311327, 4463.709858859163, 3810.6760925321382, 3882.4758657581147, 3941.8226179821977, 3943.4676318696897, 3944.349182384903, 5431.592630552725, 5435.320584926884, 5445.700486473243, 5463.153211252262, 5487.0, 4995.9500404996215, 5025.246213068032, 5028.3909149072315, 5042.193249080129, 5128.71792051437, 5737.88524229513, 5883.676397798119, 5922.170896074553, 5960.672163031031, 5976.402359764033, 4292.1630282095, 4298.828046878121, 4300.956990430087, 4302.483701955754, 4303.419038429804, 6192.854321950408, 6204.410580994799, 6217.906731399033, 6222.595531290497, 6247.156633854417, 4295.6778241632, 4390.758508282075, 4416.227160247008, 4427.380166776654, 4436.201483732894, 4445.488768791631, 4447.799849006802, 4483.7533935633855, 4495.752733599618, 4497.505274419811, 5025.748712564357, 5100.6429549931145, 5112.897742045213, 5116.437191908962, 5135.507854658793, 5777.306723193244, 5851.0, 5954.469350526009, 6001.159837622737, 6056.454919057218, 1472.3595236072342, 1482.4366740638704, 1487.7917091607183, 1490.8658220760183, 1493.9402423902923, 1008.9142422893989, 1010.5149528226492, 1023.9635219190673, 1033.421284080917, 1042.1975079188983, 5526.673598336451, 5532.86167845799, 5577.358603760619, 5590.133529302964, 5679.659220446786, 5875.149327961678, 5946.791862284799, 5961.731722072517, 5965.791197308074, 5966.642001479925, 5386.515213630713, 5609.775608975677, 5616.382197958222, 5618.887622247614, 5622.606417550732, 3118.43868103739, 3147.6694947030232, 3149.850304638836, 3150.9129350374083, 3156.6212054553143, 5683.0, 6059.545534084873, 6114.816555503342, 6123.499742563012, 6151.384861513813, 5900.616459930091, 5955.821325360246, 5971.641701497924, 5989.700514974234, 5996.800639872043, 6006.0, 6034.155218269446, 6120.204373431515, 6164.291106522717, 6191.349908259658, 5687.77248910039, 5789.768409263751, 5832.0, 5841.130838131757, 5856.853578660568, 5798.884022319446, 5818.359980402068, 5845.590808643354, 5854.5609079320075, 5857.238558987305, 6011.579189456696, 6112.694365281807, 6122.234720659918, 6126.0, 6349.396807303298, 4341.3922050913525, 4378.343248512749, 4381.737095774264, 4383.758893260774, 4388.758618276025, 5920.674362910081, 6034.0, 6172.88269423956, 6191.721372538156, 6203.379662033761, 5885.646301350799, 5994.771071930331, 6003.429674180946, 6005.219321488178, 6038.275406951194, 5961.016432288624, 5963.91054134197, 5973.342932277533, 5977.671228082497, 5984.730687119177, 5795.971020144872, 5924.7926322578505, 5930.495907847709, 5943.1679564861815, 5997.820065398045, 5953.464188223081, 5992.191054207626, 6030.819075427744, 6033.185519954925, 6036.607620504653, 5726.599138060295, 5845.678487683048, 5849.888521180962, 5885.0, 5890.587658863838], "value": 4509.143699669318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1262485017976, 762.0664685759945, 813.9186081391862, 845.4631309118708, 866.7269810009842, 15949.68100637988, 16692.415765448197, 16776.245068971893, 16804.411845585408, 16862.325506979738, 14784.852151478482, 14831.03598266112, 14837.406503739865, 14839.851601483982, 14842.183679897602, 839.5844057191683, 855.7261676263598, 856.9014563325235, 860.5525126933991, 861.0786458489418, 848.588434609214, 848.9151084891492, 852.9317654587649, 852.9658813647446, 853.5049671190694, 897.6229983406985, 898.9910100898973, 900.5992333411634, 901.197933838884, 903.4940433357341, 887.1128871128872, 892.1346294094718, 895.879056327394, 898.9370744047919, 900.5812297281796, 655.8983357579583, 657.4838751579987, 657.5922927784757, 660.5277226782825, 661.3188415931598, 14202.786958195635, 14354.210518421483, 14384.208868512227, 14497.347619357155, 14549.854501455062, 11992.340421276826, 13008.089433739642, 13224.537141200011, 13276.86723132766, 13501.729965400735, 11631.439564283199, 11757.294562326288, 11798.764024719543, 11802.527898884035, 12411.379431028412, 3882.9805850970847, 3896.941545876814, 3920.5099362579676, 3966.167104907944, 4028.3756017817286, 67197.0, 67230.66384668046, 67813.0, 68369.3163068373, 68404.0, 10117.949410252902, 10314.896851031544, 10329.173666106693, 10404.063634272952, 10626.0, 20156.596868062556, 20279.08744106519, 20281.594368112554, 20296.695549566768, 20360.0, 8254.8349033019, 8414.410991230556, 8544.700935467228, 8840.33697472692, 8846.336524760669, 4819.2530157825595, 4876.487968763229, 4889.119958407521, 4899.191633380452, 4965.528274813887, 3384.221629025338, 3462.2036931505895, 3487.6512348764923, 3491.284286721216, 3501.7373696972318, 601.2604496469368, 601.9736349524138, 607.5625549604277, 612.3050337866554, 612.9295131059985, 669.7655820462799, 684.2234064337014, 693.1924308180912, 705.7071315404153, 727.0766127018657, 9075.54622268884, 10362.948185259176, 10537.84193237102, 10676.893231067745, 10738.73153171177, 684.7021545627667, 701.2006312803409, 766.7469734987441, 777.6889244302324, 783.2285199078902, 4453.941966184893, 4731.881702957385, 4767.785449654774, 4788.377510923628, 4802.927956080662, 80759.0, 81987.0, 82095.17904820995, 82414.17585824065, 83252.16747832565, 48049.27926081111, 58155.41844581585, 72592.0, 73507.0, 73630.0, 68158.0, 69162.0, 70275.0, 71890.0, 74966.25033749701, 8832.116788321116, 8855.91144088551, 8958.68644597436, 8970.058143895058, 8994.370394072352, 44669.55330446784, 44861.77569112134, 45019.32471012872, 45986.31020534628, 46242.0, 55953.0, 57961.42038579729, 62506.687466562376, 62651.686741566, 64175.0, 11238.719032024264, 11635.709107272385, 11829.763404731684, 11851.644450666494, 12482.625521234377, 13079.803802942773, 13330.866691332962, 13410.319605660414, 13517.59447216585, 13548.0, 10786.460676965964, 10940.945295273472, 11159.442027898735, 11803.403251284704, 11836.289822610672, 11311.886881131413, 11596.130290228435, 11805.0, 11822.527098916291, 11925.194702118368, 11254.718632034264, 11789.115816313639, 11869.881301186877, 12062.336571488653, 12104.576339828063, 9444.0555944405, 9515.000924902786, 9517.476538790434, 9522.575113286972, 9562.009777187213, 9011.23404510624, 9543.618255269712, 9683.564239609375, 9690.806183876142, 9710.417374957526], "value": 7100.262133090702, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 112.0, 111.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 123.0, 161.0, 125.0, 122.0, 122.0, 124.0, 147.0, 123.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 162.0, 165.0, 162.0, 162.0, 164.0, 162.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 108.0, 75.0, 75.0, 77.0, 76.0, 98.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 117.0, 82.0, 83.0, 82.0, 94.0, 82.0, 84.0, 113.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 124.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 87.0, 85.0, 87.0, 85.0, 85.0, 85.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 53.0, 58.0, 51.0, 55.0, 51.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 61.0, 61.0, 61.0, 61.0, 65.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 81.0, 75.0, 73.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 130.0, 136.0, 131.0, 124.0, 134.0, 130.0, 167.0, 137.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 158.0, 154.0, 155.0, 158.0, 160.0, 156.0, 164.0, 158.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 64.0, 64.0, 66.0], "value": 63.2, "unit": "score"}]}]} 15:20:44 INFO - Return code: 0 15:20:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:20:44 ERROR - # TBPL SUCCESS # 15:20:44 INFO - Running post-action listener: _resource_record_post_action 15:20:44 INFO - [mozharness: 2016-11-15 23:20:44.368207Z] Finished run-tests step (success) 15:20:44 INFO - Running post-run listener: _resource_record_post_run 15:20:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 354041856; Read time: 176; Write time: 202692 15:20:44 INFO - TinderboxPrint: CPU usage
13.3% 15:20:44 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 176 15:20:44 INFO - TinderboxPrint: I/O write bytes / time
354,041,856 / 202,692 15:20:44 INFO - TinderboxPrint: CPU idle
8,227.0 (86.7%) 15:20:44 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 15:20:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:20:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107266048; Read time: 0; Write time: 65232 15:20:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245645312; Read time: 164; Write time: 137424 15:20:44 INFO - Running post-run listener: _upload_blobber_files 15:20:44 INFO - Blob upload gear active. 15:20:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:20:44 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 15:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:20:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:20:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:20:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:46 INFO - (blobuploader) - INFO - Done attempting. 15:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:49 INFO - (blobuploader) - INFO - Done attempting. 15:20:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:20:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:20:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:20:50 INFO - (blobuploader) - INFO - Done attempting. 15:20:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:20:50 INFO - Return code: 0 15:20:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:20:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:20:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd8bf44c900e3c6f87d0e8f9efb16a8c6de915a8fb83eb2d26761dc1fb0671b97a8e2d41ba785f477f9225adcd86e94a1c72b2e12338da681a8167102327b8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ca7364b15390778f82dbee9cb0981525a9a4fcae898480498c12cd8a2c7ab102b111bcc5fc225317fa14cd4b03778d2b05a8cbd67354b19a9ec1b339d2649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7e419c8f42ff9526e829e94161d48d4e2de69877661b5800364a354681936d870e5c61bd028109f6ab625b1e41d5dc280f4f649a1c61bd32e7a38c8223c971b"} 15:20:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:20:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:20:50 INFO - Contents: 15:20:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd8bf44c900e3c6f87d0e8f9efb16a8c6de915a8fb83eb2d26761dc1fb0671b97a8e2d41ba785f477f9225adcd86e94a1c72b2e12338da681a8167102327b8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ca7364b15390778f82dbee9cb0981525a9a4fcae898480498c12cd8a2c7ab102b111bcc5fc225317fa14cd4b03778d2b05a8cbd67354b19a9ec1b339d2649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7e419c8f42ff9526e829e94161d48d4e2de69877661b5800364a354681936d870e5c61bd028109f6ab625b1e41d5dc280f4f649a1c61bd32e7a38c8223c971b"} 15:20:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:20:50 INFO - Copying logs to upload dir... 15:20:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:20:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.462216 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-15 15:20:50.468458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 15:20:50.472551) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd8bf44c900e3c6f87d0e8f9efb16a8c6de915a8fb83eb2d26761dc1fb0671b97a8e2d41ba785f477f9225adcd86e94a1c72b2e12338da681a8167102327b8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ca7364b15390778f82dbee9cb0981525a9a4fcae898480498c12cd8a2c7ab102b111bcc5fc225317fa14cd4b03778d2b05a8cbd67354b19a9ec1b339d2649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7e419c8f42ff9526e829e94161d48d4e2de69877661b5800364a354681936d870e5c61bd028109f6ab625b1e41d5dc280f4f649a1c61bd32e7a38c8223c971b"} build_url:https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011862 build_url: 'https://queue.taskcluster.net/v1/task/GUCx0NM9QuCFFpY_2UQR4g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd8bf44c900e3c6f87d0e8f9efb16a8c6de915a8fb83eb2d26761dc1fb0671b97a8e2d41ba785f477f9225adcd86e94a1c72b2e12338da681a8167102327b8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/96ca7364b15390778f82dbee9cb0981525a9a4fcae898480498c12cd8a2c7ab102b111bcc5fc225317fa14cd4b03778d2b05a8cbd67354b19a9ec1b339d2649d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7e419c8f42ff9526e829e94161d48d4e2de69877661b5800364a354681936d870e5c61bd028109f6ab625b1e41d5dc280f4f649a1c61bd32e7a38c8223c971b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 15:20:50.498853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:20:50.499229) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1479250591.556390-882083835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:20:50.582763) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 15:20:50.583182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 15:20:50.583516) ========= ========= Total master_lag: 0.18 =========