builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-079 starttime: 1488243025.12 results: success (0) buildid: 20170227151041 builduid: d2b79f1e60e04589bd5f3bc3cb7cb70a revision: f6462becdfe1e87617fc7570c06a72abb29751d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.121057) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.121551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.121896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.569472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.569819) ========= 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=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-27 16:50:26-- 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% 226M=0s 2017-02-27 16:50:26 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090398 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.695024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.695376) ========= 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=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023126 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:25.938682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 16:50:25.939076) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6462becdfe1e87617fc7570c06a72abb29751d0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6462becdfe1e87617fc7570c06a72abb29751d0 --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=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-27 16:50:27,092 truncating revision to first 12 chars 2017-02-27 16:50:27,092 Setting DEBUG logging. 2017-02-27 16:50:27,092 attempt 1/10 2017-02-27 16:50:27,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f6462becdfe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 16:50:27,820 unpacking tar archive at: mozilla-beta-f6462becdfe1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026037 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 16:50:27.007192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:27.007479) ========= script_repo_revision: f6462becdfe1e87617fc7570c06a72abb29751d0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:27.007862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:27.008132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 16:50:27.015826) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-27 16:50:27.016099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:28 INFO - MultiFileLogger online at 20170227 16:50:28 in /builds/slave/test 16:50:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:50:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:50:28 INFO - {'append_to_log': False, 16:50:28 INFO - 'base_work_dir': '/builds/slave/test', 16:50:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:50:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:50:28 INFO - 'branch': 'Mozilla-Beta', 16:50:28 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:28 INFO - 'config_files': ('talos/linux_config.py',), 16:50:28 INFO - 'default_actions': ('clobber', 16:50:28 INFO - 'read-buildbot-config', 16:50:28 INFO - 'download-and-extract', 16:50:28 INFO - 'populate-webroot', 16:50:28 INFO - 'create-virtualenv', 16:50:28 INFO - 'install', 16:50:28 INFO - 'run-tests'), 16:50:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:28 INFO - 'download_minidump_stackwalk': True, 16:50:28 INFO - 'download_symbols': 'ondemand', 16:50:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:28 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:28 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:28 INFO - 'installer_path': 'installer.exe', 16:50:28 INFO - 'log_level': 'info', 16:50:28 INFO - 'log_name': 'talos', 16:50:28 INFO - 'log_to_console': True, 16:50:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:28 INFO - 'opt_config_files': (), 16:50:28 INFO - 'pip_index': False, 16:50:28 INFO - 'sps_profile': False, 16:50:28 INFO - 'sps_profile_interval': 0, 16:50:28 INFO - 'suite': 'dromaeojs-e10s', 16:50:28 INFO - 'system_bits': '32', 16:50:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:28 INFO - 'title': 'talos-linux64-ix-079', 16:50:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:28 INFO - 'use_talos_json': True, 16:50:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:50:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:28 INFO - 'work_dir': 'build'} 16:50:28 INFO - [mozharness: 2017-02-28 00:50:28.236414Z] Running clobber step. 16:50:28 INFO - Running pre-action listener: _resource_record_pre_action 16:50:28 INFO - Running main action method: clobber 16:50:28 INFO - rmtree: /builds/slave/test/build 16:50:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:50:29 INFO - Running post-action listener: _resource_record_post_action 16:50:29 INFO - [mozharness: 2017-02-28 00:50:29.152430Z] Finished clobber step (success) 16:50:29 INFO - [mozharness: 2017-02-28 00:50:29.152531Z] Running read-buildbot-config step. 16:50:29 INFO - Running pre-action listener: _resource_record_pre_action 16:50:29 INFO - Running main action method: read_buildbot_config 16:50:29 INFO - Using buildbot properties: 16:50:29 INFO - { 16:50:29 INFO - "project": "", 16:50:29 INFO - "product": "firefox", 16:50:29 INFO - "script_repo_revision": "production", 16:50:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 16:50:29 INFO - "repository": "", 16:50:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 16:50:29 INFO - "buildid": "20170227151041", 16:50:29 INFO - "pgo_build": "True", 16:50:29 INFO - "basedir": "/builds/slave/test", 16:50:29 INFO - "buildnumber": 87, 16:50:29 INFO - "slavename": "talos-linux64-ix-079", 16:50:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:50:29 INFO - "platform": "ubuntu64_hw", 16:50:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:50:29 INFO - "branch": "mozilla-beta", 16:50:29 INFO - "repo_path": "releases/mozilla-beta", 16:50:29 INFO - "revision": "f6462becdfe1e87617fc7570c06a72abb29751d0", 16:50:29 INFO - "stage_platform": "linux64-pgo", 16:50:29 INFO - "builduid": "d2b79f1e60e04589bd5f3bc3cb7cb70a", 16:50:29 INFO - "slavebuilddir": "test" 16:50:29 INFO - } 16:50:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 16:50:29 INFO - Running post-action listener: _resource_record_post_action 16:50:29 INFO - [mozharness: 2017-02-28 00:50:29.154965Z] Finished read-buildbot-config step (success) 16:50:29 INFO - [mozharness: 2017-02-28 00:50:29.155053Z] Running download-and-extract step. 16:50:29 INFO - Running pre-action listener: _resource_record_pre_action 16:50:29 INFO - Running main action method: download_and_extract 16:50:29 INFO - mkdir: /builds/slave/test/build/tests 16:50: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')]} 16:50:29 INFO - trying https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:50:29 INFO - Downloaded 1327 bytes. 16:50:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:50:29 INFO - Using the following test package requirements: 16:50:29 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:50:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:29 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 16:50:29 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'jsshell-linux-x86_64.zip'], 16:50:29 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:29 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:50:29 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 16:50:29 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 16:50:29 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:50:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:50:29 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:29 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:50:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:29 INFO - Fetch https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:50:30 INFO - Http code: 200 16:50:30 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 16:50:30 INFO - x-amz-cf-id: qEeuYM-kQwc1k54EJjwBncsKw2UFgfyay3N5t-RfYrhgtQxaXdXtpw== 16:50:30 INFO - x-amz-version-id: zaKX_uz6PxLhl4PsMyOhTWJ4DH6_VQl1 16:50:31 INFO - Expected file size: 21962680 16:50:31 INFO - Obtained file size: 21962680 16:50:35 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:50:36 INFO - Http code: 200 16:50:36 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 16:50:36 INFO - x-amz-cf-id: pfRXTNtTBE55yfLXDBVm8xjucQJv1srbHYg2khBuNk5dGp3nneOUGQ== 16:50:36 INFO - x-amz-version-id: zaKX_uz6PxLhl4PsMyOhTWJ4DH6_VQl1 16:50:36 INFO - Expected file size: 21962680 16:50:36 INFO - Obtained file size: 21962680 16:50:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 16:50:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:41 INFO - Fetch https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 16:50:42 INFO - Http code: 200 16:50:42 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 16:50:42 INFO - x-amz-cf-id: 3Fcto9qezUSWfhuCh0a47-R2Srlvx0tvaMWqR8HS5i_zFyempiC14w== 16:50:42 INFO - x-amz-version-id: 8zvQNak9yJtduJVoRHrAlqpjY7Ik8leD 16:50:42 INFO - Expected file size: 14402992 16:50:42 INFO - Obtained file size: 14402992 16:50: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')]} 16:50:42 INFO - trying https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:50:42 INFO - Downloading https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:45 INFO - Downloaded 57760759 bytes. 16:50:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:50:45 INFO - mkdir: /builds/slave/test/properties 16:50:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:50:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:50:45 INFO - Contents: 16:50:45 INFO - build_url:https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:50:46 INFO - Running post-action listener: _resource_record_post_action 16:50:46 INFO - Running post-action listener: set_extra_try_arguments 16:50:46 INFO - [mozharness: 2017-02-28 00:50:46.329732Z] Finished download-and-extract step (success) 16:50:46 INFO - [mozharness: 2017-02-28 00:50:46.329960Z] Running populate-webroot step. 16:50:46 INFO - Running pre-action listener: _resource_record_pre_action 16:50:46 INFO - Running main action method: populate_webroot 16:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:46 INFO - '--tppagecycles', 16:50:46 INFO - '7'], 16:50:46 INFO - 'tests': ['tsvgm']}}, 16:50:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:50:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:50:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['damp', 'tps']}, 16:50:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'tests': ['damp', 'tps']}, 16:50:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['dromaeo_dom']}, 16:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['basic_compositor_video']}, 16:50:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:50:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['a11yr', 16:50:46 INFO - 'ts_paint', 16:50:46 INFO - 'tpaint', 16:50:46 INFO - 'sessionrestore', 16:50:46 INFO - 'sessionrestore_no_auto_restore', 16:50:46 INFO - 'tabpaint']}, 16:50:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['tsvgx', 16:50:46 INFO - 'tsvgr_opacity', 16:50:46 INFO - 'tart', 16:50:46 INFO - 'tscrollx', 16:50:46 INFO - 'cart']}, 16:50:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:50:46 INFO - 'tsvgr_opacity', 16:50:46 INFO - 'tart', 16:50:46 INFO - 'tscrollx', 16:50:46 INFO - 'cart']}, 16:50:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'talos_options': ['--disable-e10s'], 16:50:46 INFO - 'tests': ['tp5o']}, 16:50:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'tests': ['tp5o']}, 16:50:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'talos_options': ['--disable-e10s', 16:50:46 INFO - '--xperf_path', 16:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:46 INFO - 'tests': ['tp5n']}, 16:50:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:46 INFO - 'talos_options': ['--xperf_path', 16:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:46 INFO - 'tests': ['tp5n']}}, 16:50:46 INFO - 'talos.zip': {'path': '', 16:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:46 INFO - Running post-action listener: _resource_record_post_action 16:50:46 INFO - [mozharness: 2017-02-28 00:50:46.350053Z] Finished populate-webroot step (success) 16:50:46 INFO - [mozharness: 2017-02-28 00:50:46.350141Z] Running create-virtualenv step. 16:50:46 INFO - Running pre-action listener: _resource_record_pre_action 16:50:46 INFO - Running main action method: create_virtualenv 16:50:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:50:46 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 16:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:50:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:46 INFO - Using real prefix '/usr' 16:50:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:50:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:48 INFO - Installing pip.................done. 16:50:48 INFO - Return code: 0 16:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:50:49 INFO - Reading from file tmpfile_stdout 16:50:49 INFO - Output received: 16:50:49 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) 16:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:50: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')]} 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:49 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:49 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 16:50:49 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 16:50:49 INFO - Using env: {'DISPLAY': ':0', 16:50:49 INFO - 'HOME': '/home/cltbld', 16:50:49 INFO - 'LANG': 'en_US.UTF-8', 16:50:49 INFO - 'LANGUAGE': 'en_US:en', 16:50:49 INFO - 'LOGNAME': 'cltbld', 16:50:49 INFO - 'MAIL': '/var/mail/cltbld', 16:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:49 INFO - 'MOZ_NO_REMOTE': '1', 16:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:49 INFO - 'NO_EM_RESTART': '1', 16:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:49 INFO - 'PWD': '/builds/slave/test', 16:50:49 INFO - 'SHELL': '/bin/bash', 16:50:49 INFO - 'SHLVL': '1', 16:50:49 INFO - 'TERM': 'linux', 16:50:49 INFO - 'TMOUT': '86400', 16:50:49 INFO - 'USER': 'cltbld', 16:50:49 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:49 INFO - '_': '/tools/buildbot/bin/python'} 16:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:49 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 16:50:49 INFO - Cleaning up... 16:50:49 INFO - Return code: 0 16:50:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:50: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')]} 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:49 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:49 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 16:50:49 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 16:50:49 INFO - Using env: {'DISPLAY': ':0', 16:50:49 INFO - 'HOME': '/home/cltbld', 16:50:49 INFO - 'LANG': 'en_US.UTF-8', 16:50:49 INFO - 'LANGUAGE': 'en_US:en', 16:50:49 INFO - 'LOGNAME': 'cltbld', 16:50:49 INFO - 'MAIL': '/var/mail/cltbld', 16:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:49 INFO - 'MOZ_NO_REMOTE': '1', 16:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:49 INFO - 'NO_EM_RESTART': '1', 16:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:49 INFO - 'PWD': '/builds/slave/test', 16:50:49 INFO - 'SHELL': '/bin/bash', 16:50:49 INFO - 'SHLVL': '1', 16:50:49 INFO - 'TERM': 'linux', 16:50:49 INFO - 'TMOUT': '86400', 16:50:49 INFO - 'USER': 'cltbld', 16:50:49 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:49 INFO - '_': '/tools/buildbot/bin/python'} 16:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:49 INFO - Downloading/unpacking psutil>=3.1.1 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:51 INFO - Installing collected packages: psutil 16:50:51 INFO - Running setup.py install for psutil 16:50:51 INFO - building 'psutil._psutil_linux' extension 16:50:51 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 16:50:51 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 16:50:51 INFO - building 'psutil._psutil_posix' extension 16:50:51 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 16:50:52 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 16:50:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:52 INFO - Successfully installed psutil 16:50:52 INFO - Cleaning up... 16:50:52 INFO - Return code: 0 16:50:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:50: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')]} 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:50:52 INFO - Using env: {'DISPLAY': ':0', 16:50:52 INFO - 'HOME': '/home/cltbld', 16:50:52 INFO - 'LANG': 'en_US.UTF-8', 16:50:52 INFO - 'LANGUAGE': 'en_US:en', 16:50:52 INFO - 'LOGNAME': 'cltbld', 16:50:52 INFO - 'MAIL': '/var/mail/cltbld', 16:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:52 INFO - 'MOZ_NO_REMOTE': '1', 16:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:52 INFO - 'NO_EM_RESTART': '1', 16:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:52 INFO - 'PWD': '/builds/slave/test', 16:50:52 INFO - 'SHELL': '/bin/bash', 16:50:52 INFO - 'SHLVL': '1', 16:50:52 INFO - 'TERM': 'linux', 16:50:52 INFO - 'TMOUT': '86400', 16:50:52 INFO - 'USER': 'cltbld', 16:50:52 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:52 INFO - '_': '/tools/buildbot/bin/python'} 16:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:50:54 INFO - Installing collected packages: mozsystemmonitor 16:50:54 INFO - Running setup.py install for mozsystemmonitor 16:50:54 INFO - Successfully installed mozsystemmonitor 16:50:54 INFO - Cleaning up... 16:50:54 INFO - Return code: 0 16:50:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:50:54 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')]} 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 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')]} 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:54 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 16:50:54 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 16:50:54 INFO - Using env: {'DISPLAY': ':0', 16:50:54 INFO - 'HOME': '/home/cltbld', 16:50:54 INFO - 'LANG': 'en_US.UTF-8', 16:50:54 INFO - 'LANGUAGE': 'en_US:en', 16:50:54 INFO - 'LOGNAME': 'cltbld', 16:50:54 INFO - 'MAIL': '/var/mail/cltbld', 16:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:54 INFO - 'MOZ_NO_REMOTE': '1', 16:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:54 INFO - 'NO_EM_RESTART': '1', 16:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:54 INFO - 'PWD': '/builds/slave/test', 16:50:54 INFO - 'SHELL': '/bin/bash', 16:50:54 INFO - 'SHLVL': '1', 16:50:54 INFO - 'TERM': 'linux', 16:50:54 INFO - 'TMOUT': '86400', 16:50:54 INFO - 'USER': 'cltbld', 16:50:54 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:54 INFO - '_': '/tools/buildbot/bin/python'} 16:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:50:56 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 16:50:56 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 16:50:56 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 16:50:56 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 16:50:56 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 16:50:56 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 16:50:57 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:57 INFO - warning: no files found matching '*.txt' 16:50:57 INFO - no previously-included directories found matching 'build' 16:50:57 INFO - no previously-included directories found matching 'dist' 16:50:57 INFO - no previously-included directories found matching '.git*' 16:50:57 INFO - Installing collected packages: jsonschema, functools32 16:50:57 INFO - Running setup.py install for functools32 16:50:57 INFO - warning: no files found matching '*.txt' 16:50:57 INFO - no previously-included directories found matching 'build' 16:50:57 INFO - no previously-included directories found matching 'dist' 16:50:57 INFO - no previously-included directories found matching '.git*' 16:50:57 INFO - Successfully installed jsonschema functools32 16:50:57 INFO - Cleaning up... 16:50:57 INFO - Return code: 0 16:50:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:50:57 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')]} 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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')]} 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:57 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 16:50:57 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 16:50:57 INFO - Using env: {'DISPLAY': ':0', 16:50:57 INFO - 'HOME': '/home/cltbld', 16:50:57 INFO - 'LANG': 'en_US.UTF-8', 16:50:57 INFO - 'LANGUAGE': 'en_US:en', 16:50:57 INFO - 'LOGNAME': 'cltbld', 16:50:57 INFO - 'MAIL': '/var/mail/cltbld', 16:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:57 INFO - 'MOZ_NO_REMOTE': '1', 16:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:57 INFO - 'NO_EM_RESTART': '1', 16:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:57 INFO - 'PWD': '/builds/slave/test', 16:50:57 INFO - 'SHELL': '/bin/bash', 16:50:57 INFO - 'SHLVL': '1', 16:50:57 INFO - 'TERM': 'linux', 16:50:57 INFO - 'TMOUT': '86400', 16:50:57 INFO - 'USER': 'cltbld', 16:50:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:57 INFO - '_': '/tools/buildbot/bin/python'} 16:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:50:57 INFO - Cleaning up... 16:50:57 INFO - Return code: 0 16:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:50:57 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')]} 16:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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')]} 16:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:57 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:50:57 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 16:50:57 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 16:50:57 INFO - Using env: {'DISPLAY': ':0', 16:50:57 INFO - 'HOME': '/home/cltbld', 16:50:57 INFO - 'LANG': 'en_US.UTF-8', 16:50:57 INFO - 'LANGUAGE': 'en_US:en', 16:50:57 INFO - 'LOGNAME': 'cltbld', 16:50:57 INFO - 'MAIL': '/var/mail/cltbld', 16:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:57 INFO - 'MOZ_NO_REMOTE': '1', 16:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:57 INFO - 'NO_EM_RESTART': '1', 16:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:57 INFO - 'PWD': '/builds/slave/test', 16:50:57 INFO - 'SHELL': '/bin/bash', 16:50:57 INFO - 'SHLVL': '1', 16:50:57 INFO - 'TERM': 'linux', 16:50:57 INFO - 'TMOUT': '86400', 16:50:57 INFO - 'USER': 'cltbld', 16:50:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:57 INFO - '_': '/tools/buildbot/bin/python'} 16:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:50:59 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 16:50:59 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 16:50:59 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 16:50:59 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 16:50:59 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 16:50:59 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 16:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 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 16:51:00 INFO - Downloading docopt-0.6.1.tar.gz 16:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:00 INFO - Running setup.py install for blobuploader 16:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:00 INFO - Running setup.py install for requests 16:51:01 INFO - Running setup.py install for docopt 16:51:01 INFO - Successfully installed blobuploader requests docopt 16:51:01 INFO - Cleaning up... 16:51:01 INFO - Return code: 0 16:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:01 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')]} 16:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 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')]} 16:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:51:01 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 16:51:01 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 16:51:01 INFO - Using env: {'DISPLAY': ':0', 16:51:01 INFO - 'HOME': '/home/cltbld', 16:51:01 INFO - 'LANG': 'en_US.UTF-8', 16:51:01 INFO - 'LANGUAGE': 'en_US:en', 16:51:01 INFO - 'LOGNAME': 'cltbld', 16:51:01 INFO - 'MAIL': '/var/mail/cltbld', 16:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:01 INFO - 'MOZ_NO_REMOTE': '1', 16:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:01 INFO - 'NO_EM_RESTART': '1', 16:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:01 INFO - 'PWD': '/builds/slave/test', 16:51:01 INFO - 'SHELL': '/bin/bash', 16:51:01 INFO - 'SHLVL': '1', 16:51:01 INFO - 'TERM': 'linux', 16:51:01 INFO - 'TMOUT': '86400', 16:51:01 INFO - 'USER': 'cltbld', 16:51:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:01 INFO - '_': '/tools/buildbot/bin/python'} 16:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:01 INFO - Running setup.py (path:/tmp/pip-rRRDUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:01 INFO - Running setup.py (path:/tmp/pip-JQqVqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:01 INFO - Running setup.py (path:/tmp/pip-mGAfi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:01 INFO - Running setup.py (path:/tmp/pip-W6zv6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:01 INFO - Running setup.py (path:/tmp/pip-fMIS5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:01 INFO - Running setup.py (path:/tmp/pip-MABKv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:01 INFO - Running setup.py (path:/tmp/pip-QP4N0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 INFO - Running setup.py (path:/tmp/pip-lFptr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:02 INFO - Running setup.py (path:/tmp/pip-nh6mGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:02 INFO - Running setup.py (path:/tmp/pip-NZSAe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:02 INFO - Running setup.py (path:/tmp/pip-cfBsFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:02 INFO - Running setup.py (path:/tmp/pip-LK5PDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:02 INFO - Running setup.py (path:/tmp/pip-JSpfUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:02 INFO - Running setup.py (path:/tmp/pip-bGnLrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:02 INFO - Running setup.py (path:/tmp/pip-hUBSYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:02 INFO - Running setup.py (path:/tmp/pip-fYb4y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:02 INFO - Running setup.py (path:/tmp/pip-hu9rl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:02 INFO - Running setup.py install for manifestparser 16:51:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:02 INFO - Running setup.py install for mozcrash 16:51:02 INFO - Running setup.py install for mozdebug 16:51:03 INFO - Running setup.py install for mozdevice 16:51:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozfile 16:51:03 INFO - Running setup.py install for mozhttpd 16:51:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozinfo 16:51:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozInstall 16:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozleak 16:51:03 INFO - Running setup.py install for mozlog 16:51:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for moznetwork 16:51:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:03 INFO - Running setup.py install for mozprocess 16:51:03 INFO - Running setup.py install for mozprofile 16:51:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozrunner 16:51:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Running setup.py install for mozscreenshot 16:51:04 INFO - Running setup.py install for moztest 16:51:04 INFO - Running setup.py install for mozversion 16:51:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:04 INFO - Cleaning up... 16:51:04 INFO - Return code: 0 16:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:04 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')]} 16:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:04 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')]} 16:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:04 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:51:04 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 16:51:04 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 16:51:04 INFO - Using env: {'DISPLAY': ':0', 16:51:04 INFO - 'HOME': '/home/cltbld', 16:51:04 INFO - 'LANG': 'en_US.UTF-8', 16:51:04 INFO - 'LANGUAGE': 'en_US:en', 16:51:04 INFO - 'LOGNAME': 'cltbld', 16:51:04 INFO - 'MAIL': '/var/mail/cltbld', 16:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:04 INFO - 'MOZ_NO_REMOTE': '1', 16:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:04 INFO - 'NO_EM_RESTART': '1', 16:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:04 INFO - 'PWD': '/builds/slave/test', 16:51:04 INFO - 'SHELL': '/bin/bash', 16:51:04 INFO - 'SHLVL': '1', 16:51:04 INFO - 'TERM': 'linux', 16:51:04 INFO - 'TMOUT': '86400', 16:51:04 INFO - 'USER': 'cltbld', 16:51:04 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:04 INFO - '_': '/tools/buildbot/bin/python'} 16:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:04 INFO - Running setup.py (path:/tmp/pip-8HVyf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:04 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)) 16:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:04 INFO - Running setup.py (path:/tmp/pip-TVf_Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:04 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)) 16:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:04 INFO - Running setup.py (path:/tmp/pip-kfGkrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:04 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)) 16:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:05 INFO - Running setup.py (path:/tmp/pip-dgjW5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:05 INFO - Running setup.py (path:/tmp/pip-PWvgsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:05 INFO - Running setup.py (path:/tmp/pip-WvhHei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:05 INFO - Running setup.py (path:/tmp/pip-ip00h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:05 INFO - Running setup.py (path:/tmp/pip-EQWmrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:05 INFO - Running setup.py (path:/tmp/pip-3TlZFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:05 INFO - Running setup.py (path:/tmp/pip-xHTHcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:05 INFO - Running setup.py (path:/tmp/pip-wKEtmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:05 INFO - Running setup.py (path:/tmp/pip-0gLdUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:05 INFO - Running setup.py (path:/tmp/pip-UFasFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:05 INFO - Running setup.py (path:/tmp/pip-EezTbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:05 INFO - Running setup.py (path:/tmp/pip-smN4l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:05 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)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:05 INFO - Running setup.py (path:/tmp/pip-gAKr1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:05 INFO - Running setup.py (path:/tmp/pip-CzuPZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 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)) 16:51:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:06 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 16:51:08 INFO - Downloading blessings-1.6.tar.gz 16:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:08 INFO - Installing collected packages: blessings 16:51:08 INFO - Running setup.py install for blessings 16:51:08 INFO - Successfully installed blessings 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:08 INFO - Reading from file tmpfile_stdout 16:51:08 INFO - Current package versions: 16:51:08 INFO - argparse == 1.2.1 16:51:08 INFO - blessings == 1.6 16:51:08 INFO - blobuploader == 1.2.4 16:51:08 INFO - docopt == 0.6.1 16:51:08 INFO - functools32 == 3.2.3-2 16:51:08 INFO - jsonschema == 2.5.1 16:51:08 INFO - manifestparser == 1.1 16:51:08 INFO - mozInstall == 1.12 16:51:08 INFO - mozcrash == 1.0 16:51:08 INFO - mozdebug == 0.1 16:51:08 INFO - mozdevice == 0.48 16:51:08 INFO - mozfile == 1.2 16:51:08 INFO - mozhttpd == 0.7 16:51:08 INFO - mozinfo == 0.9 16:51:08 INFO - mozleak == 0.1 16:51:08 INFO - mozlog == 3.4 16:51:08 INFO - moznetwork == 0.27 16:51:08 INFO - mozprocess == 0.23 16:51:08 INFO - mozprofile == 0.28 16:51:08 INFO - mozrunner == 6.13 16:51:08 INFO - mozscreenshot == 0.1 16:51:08 INFO - mozsystemmonitor == 0.3 16:51:08 INFO - moztest == 0.8 16:51:08 INFO - mozversion == 1.4 16:51:08 INFO - psutil == 3.1.1 16:51:08 INFO - requests == 1.2.3 16:51:08 INFO - wsgiref == 0.1.2 16:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:51:08 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 16:51:08 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 16:51:08 INFO - Using env: {'DISPLAY': ':0', 16:51:08 INFO - 'HOME': '/home/cltbld', 16:51:08 INFO - 'LANG': 'en_US.UTF-8', 16:51:08 INFO - 'LANGUAGE': 'en_US:en', 16:51:08 INFO - 'LOGNAME': 'cltbld', 16:51:08 INFO - 'MAIL': '/var/mail/cltbld', 16:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:08 INFO - 'MOZ_NO_REMOTE': '1', 16:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:08 INFO - 'NO_EM_RESTART': '1', 16:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:08 INFO - 'PWD': '/builds/slave/test', 16:51:08 INFO - 'SHELL': '/bin/bash', 16:51:08 INFO - 'SHLVL': '1', 16:51:08 INFO - 'TERM': 'linux', 16:51:08 INFO - 'TMOUT': '86400', 16:51:08 INFO - 'USER': 'cltbld', 16:51:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:08 INFO - '_': '/tools/buildbot/bin/python'} 16:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 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)) 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:08 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 0x7f7e4960bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dafca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, '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': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', '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 16:51:08 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 16:51:08 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 16:51:08 INFO - Using env: {'DISPLAY': ':0', 16:51:08 INFO - 'HOME': '/home/cltbld', 16:51:08 INFO - 'LANG': 'en_US.UTF-8', 16:51:08 INFO - 'LANGUAGE': 'en_US:en', 16:51:08 INFO - 'LOGNAME': 'cltbld', 16:51:08 INFO - 'MAIL': '/var/mail/cltbld', 16:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:08 INFO - 'MOZ_NO_REMOTE': '1', 16:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:08 INFO - 'NO_EM_RESTART': '1', 16:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:08 INFO - 'PWD': '/builds/slave/test', 16:51:08 INFO - 'SHELL': '/bin/bash', 16:51:08 INFO - 'SHLVL': '1', 16:51:08 INFO - 'TERM': 'linux', 16:51:08 INFO - 'TMOUT': '86400', 16:51:08 INFO - 'USER': 'cltbld', 16:51:08 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:08 INFO - '_': '/tools/buildbot/bin/python'} 16:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:08 INFO - Cleaning up... 16:51:08 INFO - Return code: 0 16:51:08 INFO - Running post-action listener: _resource_record_post_action 16:51:08 INFO - Running post-action listener: _start_resource_monitoring 16:51:08 INFO - Starting resource monitoring. 16:51:09 INFO - [mozharness: 2017-02-28 00:51:09.000926Z] Finished create-virtualenv step (success) 16:51:09 INFO - [mozharness: 2017-02-28 00:51:09.001428Z] Running install step. 16:51:09 INFO - Running pre-action listener: _resource_record_pre_action 16:51:09 INFO - Running main action method: install 16:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:09 INFO - Reading from file tmpfile_stdout 16:51:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:09 INFO - Reading from file tmpfile_stdout 16:51:09 INFO - Output received: 16:51:09 INFO - Usage: mozinstall [options] installer 16:51:09 INFO - Options: 16:51:09 INFO - -h, --help show this help message and exit 16:51:09 INFO - -d DEST, --destination=DEST 16:51:09 INFO - Directory to install application into. [default: 16:51:09 INFO - "/builds/slave/test"] 16:51:09 INFO - --app=APP Application being installed. [default: firefox] 16:51:09 INFO - mkdir: /builds/slave/test/build/application 16:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:51:22 INFO - Reading from file tmpfile_stdout 16:51:22 INFO - Output received: 16:51:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:51:22 INFO - Running post-action listener: _resource_record_post_action 16:51:22 INFO - [mozharness: 2017-02-28 00:51:22.947965Z] Finished install step (success) 16:51:22 INFO - [mozharness: 2017-02-28 00:51:22.948205Z] Running run-tests step. 16:51:22 INFO - Running pre-action listener: _resource_record_pre_action 16:51:22 INFO - Running main action method: run_tests 16:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:22 INFO - Python 2.7.3 16:51:22 INFO - Return code: 0 16:51:22 INFO - grabbing minidump binary from tooltool 16:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:22 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 0x1dacf60>, '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 0x1dadd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dae1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:22 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 16:51:22 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 16:51:22 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 16:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:23 INFO - Return code: 0 16:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 16:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 16:51:23 INFO - Using env: {'DISPLAY': ':0', 16:51:23 INFO - 'HOME': '/home/cltbld', 16:51:23 INFO - 'LANG': 'en_US.UTF-8', 16:51:23 INFO - 'LANGUAGE': 'en_US:en', 16:51:23 INFO - 'LOGNAME': 'cltbld', 16:51:23 INFO - 'MAIL': '/var/mail/cltbld', 16:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:23 INFO - 'MOZ_NO_REMOTE': '1', 16:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:23 INFO - 'NO_EM_RESTART': '1', 16:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:23 INFO - 'PWD': '/builds/slave/test', 16:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:23 INFO - 'SHELL': '/bin/bash', 16:51:23 INFO - 'SHLVL': '1', 16:51:23 INFO - 'TERM': 'linux', 16:51:23 INFO - 'TMOUT': '86400', 16:51:23 INFO - 'USER': 'cltbld', 16:51:23 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808', 16:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:23 INFO - '_': '/tools/buildbot/bin/python'} 16:51:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 16:51:23 INFO - mozversion application_buildid: 20170227151041 16:51:23 INFO - mozversion application_changeset: f6462becdfe1e87617fc7570c06a72abb29751d0 16:51:23 INFO - mozversion application_display_name: Firefox 16:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:23 INFO - mozversion application_name: Firefox 16:51:23 INFO - mozversion application_remotingname: firefox 16:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:51:23 INFO - mozversion application_vendor: Mozilla 16:51:23 INFO - mozversion application_version: 52.0 16:51:23 INFO - mozversion platform_buildid: 20170227151041 16:51:23 INFO - mozversion platform_changeset: f6462becdfe1e87617fc7570c06a72abb29751d0 16:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:51:23 INFO - mozversion platform_version: 52.0 16:51:23 INFO - using testdate: 1488243083 16:51:23 INFO - actual date: 1488243083 16:51:23 INFO - starting webserver on 'localhost:36281' 16:51:23 INFO - SUITE-START | Running 2 tests 16:51:23 INFO - TEST-START | dromaeo_css 16:51:23 INFO - operating with platform_type : linux_ 16:51:23 INFO - Initialising browser for dromaeo_css test... 16:51:23 INFO - TEST-INFO | started process 14584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpct3_wr/profile http://localhost:36281/getInfo.html) 16:51:27 INFO - PROCESS | 14584 | __metrics Screen width/height:1600/1200 16:51:27 INFO - PROCESS | 14584 | colorDepth:24 16:51:27 INFO - PROCESS | 14584 | Browser inner width/height: 1024/697 16:51:27 INFO - PROCESS | 14584 | __metrics 16:51:28 ERROR - PROCESS | 14584 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 16:51:29 INFO - TEST-INFO | 14584: exit 0 16:51:29 INFO - Browser initialized. 16:51:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:29 INFO - TEST-INFO | started process 14711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpct3_wr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:41 INFO - PROCESS | 14711 | RSS: Main: 146640896 16:51:41 INFO - PROCESS | 14711 | 16:54:41 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36281/tests/dromaeo/cssquery-ext.html) 16:54:42 INFO - PROCESS | 14711 | RSS: Main: 154144768 16:54:42 INFO - PROCESS | 14711 | 16:57:44 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-ext.html (next: http://localhost:36281/tests/dromaeo/cssquery-jquery.html) 16:57:45 INFO - PROCESS | 14711 | RSS: Main: 152895488 16:57:45 INFO - PROCESS | 14711 | 17:00:46 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36281/tests/dromaeo/cssquery-mootools.html) 17:00:47 INFO - PROCESS | 14711 | RSS: Main: 151814144 17:00:47 INFO - PROCESS | 14711 | 17:03:49 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36281/tests/dromaeo/cssquery-prototype.html) 17:03:49 INFO - PROCESS | 14711 | RSS: Main: 153653248 17:03:49 INFO - PROCESS | 14711 | 17:06:52 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36281/tests/dromaeo/cssquery-yui.html) 17:06:52 INFO - PROCESS | 14711 | RSS: Main: 154005504 17:06:52 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | Cycle 1(1): loaded http://localhost:36281/tests/dromaeo/cssquery-yui.html (next: http://localhost:36281/tests/dromaeo/cssquery-dojo.html) 17:09:55 INFO - PROCESS | 14711 | RSS: Main: 154152960 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | __start_tp_report 17:09:55 INFO - PROCESS | 14711 | _x_x_mozilla_page_load 17:09:55 INFO - PROCESS | 14711 | _x_x_mozilla_page_load_details 17:09:55 INFO - PROCESS | 14711 | |i|pagename|runs| 17:09:55 INFO - PROCESS | 14711 | |0;dojo.html;3208.3743669984347;3219.6619354967743;3234.4663130583453;3239.514072889068;3240.627327857297;5549.833504994846;5560.555155587554;5592.692401917893;5619.297587801525;5643.661380317179;5563.638363506369;5677;5691.06097493913;5691.9146212806845;5704.1443783432505;5110.667806592569;5138.203578445328;5171.818986335479;5184.040952423814;5188.455212202721;5152.175651895697;5158.484151584849;5182.481751824806;5183.118869792125;5193.506616871391;4962.280469331963;4986.376702912136;5189.558887494549;5201.479852014806;5218.712970786605;5060.569851562622;5066.088104141253;5096.770645320951;5112.36095488064;5184.377874655065;5046.899062018739;5102.464241254689;5114.590832733373;5115.8209462669;5128.871778205537;5554.888902221933;5596.048671725816;5645.858853528694;5664.348599910981;5668.518175955049;5804.738786754606;5850.5612079094235;5914.142449344821;5918.585699001072;5923.466887980059;5975.910361344583;5978.2228310319815;5980.820575382745;5987.580869339148;6004.249468816398;5609.999999999959;5623.268975033219;5636.549076073904;5637.661740295554;5647.745851436695;6142.345304543789;6144.109104179869;6144.8771024579255;6148.077788331697;6203;5940.376260492672;5977.970110149421;5995.730192141364;5999;6008;5810.767569297181;6077.908831367533;6086.300075491286;6090.116933044772;6092.421219984094;5824.854378640568;6010.759569617167;6055.485283750842;6058.1518587397795;6071.423214794588;6014.308354539196;6021.7591296347655;6031.336552979169;6033.215681961317;6035.6076855004285;4654.650901182425;4654.743989080633;4658.34783130362;4673.345731597579;4675.18184317743;4045.292073887058;4074.0629655179473;4077.7757223353;4088.0597462583773;4124.298869192185;5705.144228365695;5711.714414279352;5714.485696287354;5735.254416925773;5752.626079304916;5991.430814072656;6027.939720602825;6036.185115009417;6044.093385992136;6048.758049677964;5524.558035357162;5568.582356323292;5667.234923285386;5681;5727.3699893011735;5160.071187186268;5173.508516690984;5173.534381905646;5188.610854185876;5194.97402512985;6139.26328840542;6159.076138579159;6159.5072394208355;6160.014397696436;6171.629702217791;5849.3858144894175;5865.237519122486;5880.323762767336;6034.366391528826;6060.636361818305;5984.042553191643;6136.447719705248;6142.652254521207;6143.450468055707;6155.322914479493;5982.252218472691;5988.850278743066;5989.610675306091;5993.101034844633;6018.9398106020135;6028.216331876828;6065.757369705162;6089.147519347383;6092.847678807888;6093.847653808691;5683.318001839641;5743.712814359349;5845.561582881216;5879.559033072622;5894.0274854650215;5874.882502350015;5896.734646940984;5904.852378690567;5932.970335148297;5955.880882382415;5809.82570522885;5841.036229022334;5862.296524416926;5868.413158684098;5879.412058794086;5719.342275638189;5721.427857214246;5848.473637372486;5856.765729370777;5940.495057920125;5744.798932037359;5787.016207244863;5790.044642633919;5819.243498345358;5822.650640961556 17:09:55 INFO - PROCESS | 14711 | |1;ext.html;572.4189947203587;610.5451438678184;635.856932190257;639.1499305923122;662.0697919423212;44030.67907962758;45451.77274113629;45624.54375456249;48818.511814881844;49050.75474622631;45060;46103;46177.769111154485;46272.30591541129;46423.53576464234;8886.51124188171;9093.454392736425;9098.77253068672;9148.771280718001;9159.404638698497;8982.955085224565;9131.13254240846;9139.040400757924;9144;9151.725448236564;9117.133872282157;9158.404703694272;9176;9178.678746243882;9204.72385828423;9102.954485227565;9105.863412048791;9150.588223529958;9158.816823663556;9175;9074.13795689415;9168.633254669805;9172.2203612693;9181.67864124759;9193.35646504745;44149;44388.112237755384;44511.55488445106;44552.77723611361;44712.3293150603;3572.374834403995;3687.2625474905126;3711.3876210425246;3830.291396091732;4108.972756810797;32660.836695816608;32947.50578741321;32967.50548741771;32974;33209.3358132836;4013.4381186633896;4176.102138040305;4228.809703563347;4234.491860976703;4242.745435273862;381062;381063;381325;383456;384500;65439.67280163569;65948.34051659518;65973.34026659768;65993.67003164954;66173.33826661672;69407;69419;69527.30472695208;69570.65214673894;69866.25334366682;17440.302387904594;17621.118944052745;17675;17692.734608980874;17694.734578981326;13230;13334.33328333599;13344.666383340495;13356.465741370237;13363.53227637028;19813;20288.49278768013;20425.48936276605;20447.488812779502;20637.174513019312;7400.444966627417;7414.777556673308;7426.257374262531;7499.2500749924575;7563.394928405714;1004.4324956399611;1051.75283808305;1064.6167379743285;1111.050052205369;1128.0129886349443;31425.214369640486;31486.842565787025;31508;31646.841765791025;32268.677313227035;1170.2861254634665;1222.6332100370032;1234;1260.9156125731863;1264.595329494553;16945;17165.7425138623;17212.913935430242;17214.225359858836;17480.47558573245;503268;506761;511177;511685;512301;61121.69439152865;61461;61533.69233153895;61614;61653.07520387198;1359.25241117387;1378.3866179550005;1404.768213244803;1438.26648409312;1452.7021960498073;30763.384732305676;31265.218369540944;31986.36027279488;32313.51529727009;32606;53205.73397133144;53764.193537096195;54064.729676351366;54095.188572172236;54110.72944635252;431959;432961;436331;437525;438472;30146.246343840703;30527.54208686827;30534.541981869846;30714.38571228518;30802.537961930142;48252.758736206095;48386.75806620944;48512.757436212596;49003.754981226295;50050.74974625104;39891;40178.59821401865;40695.38956915708;41585.792071039454;44928;41624.58375416207;41753.1649367017;42307;43413.13173736444;43564.78217608892;41437.049491849575;41927.161456771304;42602.14795704131;43051.56948430601;43125.13749724925;34969.475457867644;38028.809855950545;38318.80840595779;38333.4249986256;39016.41475377928;28928.855355723088;28988.99398537506;29349.85325073361;29366.265843354086;29378.559321609766 17:09:55 INFO - PROCESS | 14711 | |2;jquery.html;414.15305699843816;418.78432607207276;424.6623933972493;425.1560652105571;437.1519252649859;18735.2505899764;19354.90322548387;19853.3051343203;19907.900460497676;20253.189872405106;19772.802271977274;20085.899570502163;20538.794612053876;20767;20826.16695332189;5863.2670916135485;6124.5100391968535;6131.172291740625;6133.509319254449;6136.6011209271255;5798.565107616924;6002;6073.240844894388;6088.086786981944;6098.024316109423;6166.7533298667995;6190.752369905198;6194.225721784777;6198.876022479548;6203;6016.608920420181;6134.723937422827;6192.566520343577;6196.628202307876;6203.968980155116;5874.383189765099;6031.306399764039;6032.758689652409;6033.125196846477;6050.092486127072;23246.53506929852;23262.65106023411;23665.76334236653;23926.16258430964;24013.039478420844;2201.6587428948537;2357.387079359362;2378.797802186816;2476.876156192201;2669.0391459074717;10207.693769186937;10639.361638301727;10848.403337816417;10897.564097436092;11245.15661325404;1916.5879335942839;1968.0946764488353;1999.1103958738368;2030.7664618568906;2034.4608678700156;74944.62527687327;75849.24150758532;77455.61272193659;87928.5603571978;87960.56019719924;11548.556430446195;11782.705432364088;11882.524699012116;11907.70230744221;12288.569900053455;16927.0690112045;16928.153592320334;17065.14674266282;17087.658246834995;17118.743218851727;8515.659373624985;8556.844825948541;8658.95670521656;8670.566471676391;8749.212570868525;8140.389470789596;8220.424570280024;8341.624626891804;8439.789005274795;8481.872771908425;5084.669496482791;5134.358205224347;5149.536541711264;5152.355955505562;5207.6875387476875;2005.2179649936536;2028.695695645665;2107.315122585166;2131.9573608528053;2166.230987999269;947.1522986926662;967.2068903499204;1023.3194925374692;1036.72008557689;1097.4951522299673;19943.900280498503;19987.800121998593;20036.298729544396;20364.898175509028;20365.389038328874;1014.2190513304714;1026.1124127629546;1037.2998226197287;1040.953157107932;1040.9635662751768;10673.519691613896;11486.827697584376;11522.481488333045;11608.535658573732;11629.418529073513;471344;472170;487781;488141;494089;87644.56177719071;89321.55339223263;92730;99571;100056;1032.7831155457438;1042.926995110335;1092.9180311476512;1096.5668560918393;1111.3220935229342;17722.822771772633;17762;17809.198586063918;18108.366207182684;18136.18387172607;44444.333334999355;44604.77697611491;44610.77694611636;45361.546384537054;45791;62070;62721;62913;63026.68486657537;63209.68395157995;8393.790155246168;8564;8640.04959454472;8713.172248636369;8884.60019299146;10030.398176109456;11869.703257418289;12339.13626046168;12383.133180677267;12530.248185108923;5255.369355677343;5895.734691938787;9692.321537492307;10194.898051019394;10868.130549555859;10297.588096476056;10936.398498082364;10954.671359859218;10990.505427255952;11198.21612487118;10675.412852292888;10855.18586106061;10944.562217511211;10949.83575246388;11148.275362101438;7726.961365193138;8266.462679925786;8345.457545259538;8434.409591328547;8989.235914947303;10068.899311006797;11592.188546801643;11624.418779060845;11774.705632358917;11799.764004719686 17:09:55 INFO - PROCESS | 14711 | |3;mootools.html;1498.4380857178555;1517.5674932644195;1638.5903524118971;1786.392626506989;1807.2228941555127;7642.503237289572;7805.336546393563;8201.794955126124;8706.1729135732;8709.346798990076;8244.67021319148;8476.91523084769;8485.91514084859;8703.695370662028;8707.521086340248;2389.199618127929;2426.8301218914685;2447.8041756659422;2451.3013791069548;2461.4092617771785;2389.7490763469846;2456.1771806444863;2460.753924607534;2464.494778570389;2465.161844972709;2424.781769640732;2427;2436.8537887726793;2467.1365022242253;2493.6259561065804;2347.1080989224156;2375.524895020994;2381.4879800842727;2400.3879010852297;2400.855948643078;2358.304300231419;2378.2865140457793;2405.8436201647014;2406.1097393964346;2406.8074554035634;8489.915100848973;8655.956720216358;8657.350698697623;8667.39328247023;8718.694845680435;5410.431904649994;5477.917831232535;5508.283923090013;5543.279373681396;5549.528290095347;3438.985499277719;3439.2949445363643;3442.707369873564;3458.39478091333;3493.2489514754197;1116.4696769034645;1116.8393446546254;1126.2679258481971;1141.3779490177874;1198.8201769734521;11792.88207117935;11847.0522358212;11936.462859171359;11938.761224775455;11971.46128424223;4749.762511874393;4842.539958703917;4928.827491037797;4957.702537847741;4960.330355402047;10126.392416455037;10156.796864062677;10167.034131757471;10182.18542516597;10200.591976320864;5485.972570137204;5491;5491.341039075257;5493.23094766733;5497.835064948058;4918.5819205367225;4932.161532539477;5032.547070763649;5040;5144.022635699205;3906.5507466641134;3973.7814420207164;4011.819468123883;4041.7574945503366;4044.595540445932;1191.9344436055926;1193.2840295822436;1193.7493126443544;1202.2005366431226;1232.5193174661888;832.2759199496477;966.5167416291854;977.6285011695652;978.5058545434653;989.3223142147652;5642.802501912413;5792.247007888947;5820.883582328414;5847.3275573308765;5917.497012753965;475.6860472088405;480.538682864454;482.6187312023532;485.66003797341295;1001.7495626093477;3785.2618739346112;3805.315043292234;3898.7270891037924;3966.2067586482817;4127.2570937231585;10340.638077667245;10727.517261723242;10742.838857417146;10768.676939691823;10770.515326810313;10449.68650940473;10537.209709271681;10575.576976920991;10619.681409557727;10627.309224900357;8053.1946805319;8102.432829701865;8196.30331421824;8272.627731751965;8278.503289802631;5621.213030175697;5669;5687.829365119053;5737.713114344349;5808.767649293981;9493.715188544355;9618.759531011781;9659.517024148623;9684.564194611401;9721.513924303898;9784.364016338915;9816.80366392654;9870.901290986998;9910;9916.851247231152;7200.675969581277;7345.045144131443;7558.2441755823975;7706.383489320729;7737.187595302412;8442.197991190827;8486.151384861465;8499.490030598185;8511.106333834858;8522.36082293818;7352.338289553966;7386.815329616587;7393.963030184815;7552.886706699294;7587.430942679432;7251.5286506376915;7283.927160728537;7352.264773522605;7488.9625551871895;7546.2831031051965;6942.895856562257;6987.301269873175;7017.789466316019;7022.262662420372;7037.190723066913;4926.064047830901;4929.112759703288;4939.5554400104165;4947.431045429822;5112.565431938327;4858.805647774049;4887.1208354052715;4988.326575912205;4991.650584459053;5000.324956131021 17:09:55 INFO - PROCESS | 14711 | |4;prototype.html;326.83298834295675;344.5796128722958;346.63949492527763;356.5097990263388;358.55897246386945;5665.490105890469;5712.200291959129;5728.885422291552;5758.424157584244;5768.3943185965445;5496.5053145216925;5591.8602034949145;5606.887862242753;5608.43915608439;5630.915536266959;4381.3647021181905;4381.53993830648;4382.715123516961;4394.450693663292;4398.120375924812;4179.9245735407885;4323.200207961521;4330.480342358921;4332.826686932534;4382.868513944587;4283.828646854122;4291;4295.248331541983;4305.277888844456;4307.633851122659;4269.231538323101;4285.250081235771;4320.805563749639;4348.9782551087355;4359.476862776487;3756.887293381203;3798.2023775007283;3830.693544516432;3847.076701591598;3853.2486165197797;5464.6994415307145;5465.754041068161;5469.753861076261;5482.698451585161;5504.321182039476;4944.615507657862;4977.875553111201;4984.750762461862;5005.624578156617;5009.123403404426;5677.261955945742;5722.656640601577;5807.854803629901;5808.1578171165365;5827.4755272025295;4175.498940127174;4178.247915375231;4188.853390131361;4192.308269135589;4209.65291106846;6061.484628842789;6061.66660833654;6075.9670855954155;6082.776128651777;6083.536167852027;4196.979015104905;4274.2092712848225;4288.399624052635;4300.075483771005;4305.720128191658;4337.544557821447;4344.174606824757;4364.934525982113;4373.300271956472;4377.299632058855;4991.80032798684;4993.4756850530175;4993.625478089158;5000.2749601307605;5013.373328333958;5640.405413509831;5669.489745922887;5831.941680583224;5834.970825145847;5941.346451890288;1427.5075099090798;1433.7634290341978;1439.1293267573176;1440.4526280013738;1440.5030264558711;984.5877599880322;999.6751055906859;1010.6614284214724;1018.1193267823279;1023.4319952426475;5497.47773961473;5511.724413779295;5514.338279406497;5529;5530.529904958124;5844.532437404998;5867.354590994987;5869.882602348014;5891;5907.556933230025;5384.784608615611;5556.472135147154;5558.471945165203;5718.170865224519;5724.685142317129;3115.8909438169553;3115.968840311568;3123.406552754969;3127.702868227515;3130.4521708700886;5917.733701983421;6035.607685500516;6073.301570319381;6085.847853803691;6086.2087928569;6161.353057928853;6167.506599472032;6184.752609895554;6190.628562286277;6206.441420272197;6241.625502469776;6246.656433896089;6248.187735594343;6248.812535623939;6290.716917738713;6003.589156548295;6033.879322413615;6043.184170136975;6099.817005489843;6119.84700382494;6024.789132380346;6054.788082417271;6074.542109893506;6082.148499210026;6092.725827337869;6088.847778805565;6216.409441103088;6228.22147231596;6262.93530099875;6291.420517587767;4326.805293761851;4353.782310884507;4355.564443555619;4359.128174365203;4360.56101486515;5871.911921321098;6052.515798736179;6080.604760690541;6082.787102451393;6094.299155597163;5844.181814545882;5893.263342082239;5903.468687818117;5907.556933230111;5925.644461332334;5899.882002359843;5931.3178984417345;5937.554683398676;5949.19685842423;5967.522598192048;5692.743826527733;5809.796657116981;5851.444112809277;5864.765409383577;5879.853003674943;5969.791057312973;5970.805618993817;5989.940100598938;6001;6002.579819412599;5659.405762395054;5825.2135961644635;5833;5843.2695913010875;5851.063829787214 17:09:55 INFO - PROCESS | 14711 | |5;yui.html;817.9550124743137;839.3075712537159;860.0238729042536;868.7273144842812;903.7198468474771;13067.869321306784;13739.381727822247;13796.03427760056;13825.17048977062;13904.930475347623;13118.081734278605;13217.339133043333;13231.999999999976;13234.93382533086;13272.668183295398;831.1895901496039;858.5921687198593;863.4905405810571;870.5168631409565;871.1680345270252;874.8862647855769;876.132628697588;876.3602570123813;877.8595424732044;879.4898958604026;912.8904531456235;912.9360944733871;914.9725508234731;916.4501299220481;917.3807679816131;911.2573252798948;911.3210658059721;911.5852287209303;911.7857303533664;912.370464379576;667.1293961380396;667.2926697700404;667.5760891833672;668.2682462703332;670.1455644053822;13692.315384230847;13740.038197326192;13788.448462061606;13814.585562433043;13897.79153312701;12384.81422778659;13767.586972390844;14244;14438.639034024129;14505.202213878232;11810.984315252437;11873;12129.150959432754;12720.618381448572;12775.936120319431;4325.545817689129;4335.653147748204;4353.25994580922;4364.301711726109;4377.7592232427205;65329;66360;68135.97796033113;68847.65576172087;68975.3102468974;10164;10317.535710893027;10327.638532651321;10432.739181520523;10482;19122.904385477985;19410;19769.308074217333;19932.90033549823;20177.39467815968;7526.887096693554;7590.316871481593;7759.612019399007;7951.443398962017;8242.711505097293;4624.630029597624;4625.907481850344;4731.69243999139;4781.187198176319;4832.395950506187;3457.187560923181;3460.636633153533;3495.178633021238;3507.2459421224557;3585;639.7185238495048;641.1248645598724;642.2164958750317;647.1134545672364;683.6581709145428;646.9320721324193;670.580886945659;689.5242282824835;711.548166914003;721.487743701967;8102.797430064295;8327.333813294921;8394.874076888851;8581;8702.869456958151;648.4131860666105;693.1647364925253;693.2478261086777;696.2028477393357;706.8904319830434;3869.2068126034096;4174.463797322636;4188.748675079505;4227.387028880795;4233.661307095425;53837;54881.45118548843;75311;79237.60381198172;94351;49807.750961244965;51861.48138518642;60613;79846.60076699579;80191.59904200559;72360.2763972364;72980;73097;73784;74473.6276318615;8824.5587720615;9025.774355641162;9162.816743665222;9292.16370526656;9498.722781299239;36534.63465365312;44632.33051504295;45476.31785523286;46526;46937;61678;62950;63011.36988630238;63167.684161578894;63828;10916.508757106109;11085.22403431752;11298.4915678793;11381.374024428736;11424.657260282205;12407;12672.429740661508;12696.619101426972;12846.189173538927;12929.612111636667;11670.474828632561;11677.88322116768;11753.647390578297;11829.881701182878;12125.514979401078;11371.886281137082;11504.53981840717;11637.476313565741;11731.35477548743;11799.941000295286;10980.835287470534;11535.480903359201;11548.133889958119;12130.211536250115;12516.87483125157;10269.225048341692;10503.317284376491;10556.102731267621;10691.679249622524;10850.511726972147;10228.795424091626;10670.253082284165;10804.135669146292;10894.782104358026;10937.56249750001 17:09:55 INFO - PROCESS | 14711 | __end_tp_report 17:09:55 INFO - PROCESS | 14711 | __start_cc_report 17:09:55 INFO - PROCESS | 14711 | _x_x_mozilla_cycle_collect,320 17:09:55 INFO - PROCESS | 14711 | __end_cc_report 17:09:55 INFO - PROCESS | 14711 | __startTimestamp1488244195500__endTimestamp 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | ------- Summary: start ------- 17:09:55 INFO - PROCESS | 14711 | Number of tests: 6 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#0] dojo.html Cycles:165 Average:5582.95 Median:5804.74 stddev:628.34 (10.8%) stddev-sans-first:602.02 17:09:55 INFO - PROCESS | 14711 | Values: 3208.4 3219.7 3234.5 3239.5 3240.6 5549.8 5560.6 5592.7 5619.3 5643.7 5563.6 5677.0 5691.1 5691.9 5704.1 5110.7 5138.2 5171.8 5184.0 5188.5 5152.2 5158.5 5182.5 5183.1 5193.5 4962.3 4986.4 5189.6 5201.5 5218.7 5060.6 5066.1 5096.8 5112.4 5184.4 5046.9 5102.5 5114.6 5115.8 5128.9 5554.9 5596.0 5645.9 5664.3 5668.5 5804.7 5850.6 5914.1 5918.6 5923.5 5975.9 5978.2 5980.8 5987.6 6004.2 5610.0 5623.3 5636.5 5637.7 5647.7 6142.3 6144.1 6144.9 6148.1 6203.0 5940.4 5978.0 5995.7 5999.0 6008.0 5810.8 6077.9 6086.3 6090.1 6092.4 5824.9 6010.8 6055.5 6058.2 6071.4 6014.3 6021.8 6031.3 6033.2 6035.6 4654.7 4654.7 4658.3 4673.3 4675.2 4045.3 4074.1 4077.8 4088.1 4124.3 5705.1 5711.7 5714.5 5735.3 5752.6 5991.4 6027.9 6036.2 6044.1 6048.8 5524.6 5568.6 5667.2 5681.0 5727.4 5160.1 5173.5 5173.5 5188.6 5195.0 6139.3 6159.1 6159.5 6160.0 6171.6 5849.4 5865.2 5880.3 6034.4 6060.6 5984.0 6136.4 6142.7 6143.5 6155.3 5982.3 5988.9 5989.6 5993.1 6018.9 6028.2 6065.8 6089.1 6092.8 6093.8 5683.3 5743.7 5845.6 5879.6 5894.0 5874.9 5896.7 5904.9 5933.0 5955.9 5809.8 5841.0 5862.3 5868.4 5879.4 5719.3 5721.4 5848.5 5856.8 5940.5 5744.8 5787.0 5790.0 5819.2 5822.7 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#1] ext.html Cycles:180 Average:61601.41 Median:43088.35 stddev:117724.21 (273.2%) stddev-sans-first:117965.28 17:09:55 INFO - PROCESS | 14711 | Values: 572.4 610.5 635.9 639.1 662.1 44030.7 45451.8 45624.5 48818.5 49050.8 45060.0 46103.0 46177.8 46272.3 46423.5 8886.5 9093.5 9098.8 9148.8 9159.4 8983.0 9131.1 9139.0 9144.0 9151.7 9117.1 9158.4 9176.0 9178.7 9204.7 9103.0 9105.9 9150.6 9158.8 9175.0 9074.1 9168.6 9172.2 9181.7 9193.4 44149.0 44388.1 44511.6 44552.8 44712.3 3572.4 3687.3 3711.4 3830.3 4109.0 32660.8 32947.5 32967.5 32974.0 33209.3 4013.4 4176.1 4228.8 4234.5 4242.7 381062.0 381063.0 381325.0 383456.0 384500.0 65439.7 65948.3 65973.3 65993.7 66173.3 69407.0 69419.0 69527.3 69570.7 69866.3 17440.3 17621.1 17675.0 17692.7 17694.7 13230.0 13334.3 13344.7 13356.5 13363.5 19813.0 20288.5 20425.5 20447.5 20637.2 7400.4 7414.8 7426.3 7499.3 7563.4 1004.4 1051.8 1064.6 1111.1 1128.0 31425.2 31486.8 31508.0 31646.8 32268.7 1170.3 1222.6 1234.0 1260.9 1264.6 16945.0 17165.7 17212.9 17214.2 17480.5 503268.0 506761.0 511177.0 511685.0 512301.0 61121.7 61461.0 61533.7 61614.0 61653.1 1359.3 1378.4 1404.8 1438.3 1452.7 30763.4 31265.2 31986.4 32313.5 32606.0 53205.7 53764.2 54064.7 54095.2 54110.7 431959.0 432961.0 436331.0 437525.0 438472.0 30146.2 30527.5 30534.5 30714.4 30802.5 48252.8 48386.8 48512.8 49003.8 50050.7 39891.0 40178.6 40695.4 41585.8 44928.0 41624.6 41753.2 42307.0 43413.1 43564.8 41437.0 41927.2 42602.1 43051.6 43125.1 34969.5 38028.8 38318.8 38333.4 39016.4 28928.9 28989.0 29349.9 29366.3 29378.6 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#2] jquery.html Cycles:180 Average:29189.90 Median:13022.28 stddev:79742.70 (612.4%) stddev-sans-first:79937.13 17:09:55 INFO - PROCESS | 14711 | Values: 414.2 418.8 424.7 425.2 437.2 18735.3 19354.9 19853.3 19907.9 20253.2 19772.8 20085.9 20538.8 20767.0 20826.2 5863.3 6124.5 6131.2 6133.5 6136.6 5798.6 6002.0 6073.2 6088.1 6098.0 6166.8 6190.8 6194.2 6198.9 6203.0 6016.6 6134.7 6192.6 6196.6 6204.0 5874.4 6031.3 6032.8 6033.1 6050.1 23246.5 23262.7 23665.8 23926.2 24013.0 2201.7 2357.4 2378.8 2476.9 2669.0 10207.7 10639.4 10848.4 10897.6 11245.2 1916.6 1968.1 1999.1 2030.8 2034.5 74944.6 75849.2 77455.6 87928.6 87960.6 11548.6 11782.7 11882.5 11907.7 12288.6 16927.1 16928.2 17065.1 17087.7 17118.7 8515.7 8556.8 8659.0 8670.6 8749.2 8140.4 8220.4 8341.6 8439.8 8481.9 5084.7 5134.4 5149.5 5152.4 5207.7 2005.2 2028.7 2107.3 2132.0 2166.2 947.2 967.2 1023.3 1036.7 1097.5 19943.9 19987.8 20036.3 20364.9 20365.4 1014.2 1026.1 1037.3 1041.0 1041.0 10673.5 11486.8 11522.5 11608.5 11629.4 471344.0 472170.0 487781.0 488141.0 494089.0 87644.6 89321.6 92730.0 99571.0 100056.0 1032.8 1042.9 1092.9 1096.6 1111.3 17722.8 17762.0 17809.2 18108.4 18136.2 44444.3 44604.8 44610.8 45361.5 45791.0 62070.0 62721.0 62913.0 63026.7 63209.7 8393.8 8564.0 8640.0 8713.2 8884.6 10030.4 11869.7 12339.1 12383.1 12530.2 5255.4 5895.7 9692.3 10194.9 10868.1 10297.6 10936.4 10954.7 10990.5 11198.2 10675.4 10855.2 10944.6 10949.8 11148.3 7727.0 8266.5 8345.5 8434.4 8989.2 10068.9 11592.2 11624.4 11774.7 11799.8 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#3] mootools.html Cycles:180 Average:5708.42 Median:4952.57 stddev:3175.93 (64.1%) stddev-sans-first:3169.08 17:09:55 INFO - PROCESS | 14711 | Values: 1498.4 1517.6 1638.6 1786.4 1807.2 7642.5 7805.3 8201.8 8706.2 8709.3 8244.7 8476.9 8485.9 8703.7 8707.5 2389.2 2426.8 2447.8 2451.3 2461.4 2389.7 2456.2 2460.8 2464.5 2465.2 2424.8 2427.0 2436.9 2467.1 2493.6 2347.1 2375.5 2381.5 2400.4 2400.9 2358.3 2378.3 2405.8 2406.1 2406.8 8489.9 8656.0 8657.4 8667.4 8718.7 5410.4 5477.9 5508.3 5543.3 5549.5 3439.0 3439.3 3442.7 3458.4 3493.2 1116.5 1116.8 1126.3 1141.4 1198.8 11792.9 11847.1 11936.5 11938.8 11971.5 4749.8 4842.5 4928.8 4957.7 4960.3 10126.4 10156.8 10167.0 10182.2 10200.6 5486.0 5491.0 5491.3 5493.2 5497.8 4918.6 4932.2 5032.5 5040.0 5144.0 3906.6 3973.8 4011.8 4041.8 4044.6 1191.9 1193.3 1193.7 1202.2 1232.5 832.3 966.5 977.6 978.5 989.3 5642.8 5792.2 5820.9 5847.3 5917.5 475.7 480.5 482.6 485.7 1001.7 3785.3 3805.3 3898.7 3966.2 4127.3 10340.6 10727.5 10742.8 10768.7 10770.5 10449.7 10537.2 10575.6 10619.7 10627.3 8053.2 8102.4 8196.3 8272.6 8278.5 5621.2 5669.0 5687.8 5737.7 5808.8 9493.7 9618.8 9659.5 9684.6 9721.5 9784.4 9816.8 9870.9 9910.0 9916.9 7200.7 7345.0 7558.2 7706.4 7737.2 8442.2 8486.2 8499.5 8511.1 8522.4 7352.3 7386.8 7394.0 7552.9 7587.4 7251.5 7283.9 7352.3 7489.0 7546.3 6942.9 6987.3 7017.8 7022.3 7037.2 4926.1 4929.1 4939.6 4947.4 5112.6 4858.8 4887.1 4988.3 4991.7 5000.3 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#4] prototype.html Cycles:180 Average:4941.44 Median:5635.66 stddev:1463.52 (26.0%) stddev-sans-first:1426.05 17:09:55 INFO - PROCESS | 14711 | Values: 326.8 344.6 346.6 356.5 358.6 5665.5 5712.2 5728.9 5758.4 5768.4 5496.5 5591.9 5606.9 5608.4 5630.9 4381.4 4381.5 4382.7 4394.5 4398.1 4179.9 4323.2 4330.5 4332.8 4382.9 4283.8 4291.0 4295.2 4305.3 4307.6 4269.2 4285.3 4320.8 4349.0 4359.5 3756.9 3798.2 3830.7 3847.1 3853.2 5464.7 5465.8 5469.8 5482.7 5504.3 4944.6 4977.9 4984.8 5005.6 5009.1 5677.3 5722.7 5807.9 5808.2 5827.5 4175.5 4178.2 4188.9 4192.3 4209.7 6061.5 6061.7 6076.0 6082.8 6083.5 4197.0 4274.2 4288.4 4300.1 4305.7 4337.5 4344.2 4364.9 4373.3 4377.3 4991.8 4993.5 4993.6 5000.3 5013.4 5640.4 5669.5 5831.9 5835.0 5941.3 1427.5 1433.8 1439.1 1440.5 1440.5 984.6 999.7 1010.7 1018.1 1023.4 5497.5 5511.7 5514.3 5529.0 5530.5 5844.5 5867.4 5869.9 5891.0 5907.6 5384.8 5556.5 5558.5 5718.2 5724.7 3115.9 3116.0 3123.4 3127.7 3130.5 5917.7 6035.6 6073.3 6085.8 6086.2 6161.4 6167.5 6184.8 6190.6 6206.4 6241.6 6246.7 6248.2 6248.8 6290.7 6003.6 6033.9 6043.2 6099.8 6119.8 6024.8 6054.8 6074.5 6082.1 6092.7 6088.8 6216.4 6228.2 6262.9 6291.4 4326.8 4353.8 4355.6 4359.1 4360.6 5871.9 6052.5 6080.6 6082.8 6094.3 5844.2 5893.3 5903.5 5907.6 5925.6 5899.9 5931.3 5937.6 5949.2 5967.5 5692.7 5809.8 5851.4 5864.8 5879.9 5969.8 5970.8 5989.9 6001.0 6002.6 5659.4 5825.2 5833.0 5843.3 5851.1 17:09:55 INFO - PROCESS | 14711 | 17:09:55 INFO - PROCESS | 14711 | [#5] yui.html Cycles:180 Average:16950.77 Median:46731.50 stddev:22299.24 (47.7%) stddev-sans-first:22328.89 17:09:55 INFO - PROCESS | 14711 | Values: 818.0 839.3 860.0 868.7 903.7 13067.9 13739.4 13796.0 13825.2 13904.9 13118.1 13217.3 13232.0 13234.9 13272.7 831.2 858.6 863.5 870.5 871.2 874.9 876.1 876.4 877.9 879.5 912.9 912.9 915.0 916.5 917.4 911.3 911.3 911.6 911.8 912.4 667.1 667.3 667.6 668.3 670.1 13692.3 13740.0 13788.4 13814.6 13897.8 12384.8 13767.6 14244.0 14438.6 14505.2 11811.0 11873.0 12129.2 12720.6 12775.9 4325.5 4335.7 4353.3 4364.3 4377.8 65329.0 66360.0 68136.0 68847.7 68975.3 10164.0 10317.5 10327.6 10432.7 10482.0 19122.9 19410.0 19769.3 19932.9 20177.4 7526.9 7590.3 7759.6 7951.4 8242.7 4624.6 4625.9 4731.7 4781.2 4832.4 3457.2 3460.6 3495.2 3507.2 3585.0 639.7 641.1 642.2 647.1 683.7 646.9 670.6 689.5 711.5 721.5 8102.8 8327.3 8394.9 8581.0 8702.9 648.4 693.2 693.2 696.2 706.9 3869.2 4174.5 4188.7 4227.4 4233.7 53837.0 54881.5 75311.0 79237.6 94351.0 49807.8 51861.5 60613.0 79846.6 80191.6 72360.3 72980.0 73097.0 73784.0 74473.6 8824.6 9025.8 9162.8 9292.2 9498.7 36534.6 44632.3 45476.3 46526.0 46937.0 61678.0 62950.0 63011.4 63167.7 63828.0 10916.5 11085.2 11298.5 11381.4 11424.7 12407.0 12672.4 12696.6 12846.2 12929.6 11670.5 11677.9 11753.6 11829.9 12125.5 11371.9 11504.5 11637.5 11731.4 11799.9 10980.8 11535.5 11548.1 12130.2 12516.9 10269.2 10503.3 10556.1 10691.7 10850.5 10228.8 10670.3 10804.1 10894.8 10937.6 17:09:55 INFO - PROCESS | 14711 | -------- Summary: end -------- 17:09:55 INFO - PROCESS | 14711 | 17:09:56 INFO - TEST-INFO | 14711: exit 0 17:09:56 INFO - TEST-OK | dromaeo_css | took 1113033ms 17:09:56 INFO - TEST-START | kraken 17:09:56 INFO - operating with platform_type : linux_ 17:09:56 INFO - Initialising browser for kraken test... 17:09:56 INFO - TEST-INFO | started process 15066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNuuQn7/profile http://localhost:36281/getInfo.html) 17:10:00 INFO - PROCESS | 15066 | __metrics Screen width/height:1600/1200 17:10:00 INFO - PROCESS | 15066 | colorDepth:24 17:10:00 INFO - PROCESS | 15066 | Browser inner width/height: 1024/697 17:10:00 INFO - PROCESS | 15066 | __metrics 17:10:01 ERROR - PROCESS | 15066 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 17:10:02 INFO - TEST-INFO | 15066: exit 0 17:10:02 INFO - Browser initialized. 17:10:02 INFO - Running cycle 1/1 for kraken test... 17:10:02 INFO - TEST-INFO | started process 15200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNuuQn7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:14 INFO - PROCESS | 15200 | RSS: Main: 146460672 17:10:14 INFO - PROCESS | 15200 | 17:10:16 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:17 INFO - PROCESS | 15200 | RSS: Main: 153251840 17:10:17 INFO - PROCESS | 15200 | 17:10:20 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-dft) 17:10:20 INFO - PROCESS | 15200 | RSS: Main: 152731648 17:10:20 INFO - PROCESS | 15200 | 17:10:23 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-fft) 17:10:24 INFO - PROCESS | 15200 | RSS: Main: 152645632 17:10:24 INFO - PROCESS | 15200 | 17:10:26 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36281/tests/kraken/driver.html?testName=audio-oscillator) 17:10:26 INFO - PROCESS | 15200 | RSS: Main: 152358912 17:10:26 INFO - PROCESS | 15200 | 17:10:29 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:29 INFO - PROCESS | 15200 | RSS: Main: 152408064 17:10:29 INFO - PROCESS | 15200 | 17:10:32 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:33 INFO - PROCESS | 15200 | RSS: Main: 154697728 17:10:33 INFO - PROCESS | 15200 | 17:10:36 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36281/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:37 INFO - PROCESS | 15200 | RSS: Main: 155602944 17:10:37 INFO - PROCESS | 15200 | 17:10:40 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36281/tests/kraken/driver.html?testName=json-parse-financial) 17:10:40 INFO - PROCESS | 15200 | RSS: Main: 155062272 17:10:40 INFO - PROCESS | 15200 | 17:10:42 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:42 INFO - PROCESS | 15200 | RSS: Main: 154505216 17:10:42 INFO - PROCESS | 15200 | 17:10:44 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:45 INFO - PROCESS | 15200 | RSS: Main: 154697728 17:10:45 INFO - PROCESS | 15200 | 17:10:47 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:47 INFO - PROCESS | 15200 | RSS: Main: 154173440 17:10:47 INFO - PROCESS | 15200 | 17:10:50 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:51 INFO - PROCESS | 15200 | RSS: Main: 155107328 17:10:51 INFO - PROCESS | 15200 | 17:10:53 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:54 INFO - PROCESS | 15200 | RSS: Main: 155049984 17:10:54 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | Cycle 1(1): loaded http://localhost:36281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36281/tests/kraken/driver.html?testName=ai-astar) 17:10:56 INFO - PROCESS | 15200 | RSS: Main: 156803072 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | __start_tp_report 17:10:56 INFO - PROCESS | 15200 | _x_x_mozilla_page_load 17:10:56 INFO - PROCESS | 15200 | _x_x_mozilla_page_load_details 17:10:56 INFO - PROCESS | 15200 | |i|pagename|runs| 17:10:56 INFO - PROCESS | 15200 | |0;ai-astar;102;110;112;113;115;114;112;112;112;111 17:10:56 INFO - PROCESS | 15200 | |1;audio-beat-detection;150;120;119;161;120;127;118;123;153;122 17:10:56 INFO - PROCESS | 15200 | |2;audio-dft;163;162;162;162;160;164;164;162;162;161 17:10:56 INFO - PROCESS | 15200 | |3;audio-fft;74;76;77;114;76;75;75;76;121;75 17:10:56 INFO - PROCESS | 15200 | |4;audio-oscillator;81;81;112;84;84;87;93;83;83;102 17:10:56 INFO - PROCESS | 15200 | |5;imaging-gaussian-blur;117;118;118;117;117;116;117;118;117;117 17:10:56 INFO - PROCESS | 15200 | |6;imaging-darkroom;147;147;146;147;146;150;147;146;148;146 17:10:56 INFO - PROCESS | 15200 | |7;imaging-desaturate;85;86;85;85;85;84;87;85;84;84 17:10:56 INFO - PROCESS | 15200 | |8;json-parse-financial;57;57;54;55;56;55;55;54;55;53 17:10:56 INFO - PROCESS | 15200 | |9;json-stringify-tinderbox;58;59;59;59;60;58;59;59;63;58 17:10:56 INFO - PROCESS | 15200 | |10;stanford-crypto-aes;75;76;75;75;74;74;75;74;74;83 17:10:56 INFO - PROCESS | 15200 | |11;stanford-crypto-ccm;126;125;132;131;126;121;131;127;163;127 17:10:56 INFO - PROCESS | 15200 | |12;stanford-crypto-pbkdf2;153;155;154;161;154;154;162;159;154;155 17:10:56 INFO - PROCESS | 15200 | |13;stanford-crypto-sha256-iterative;63;63;65;65;69;63;62;63;66;63 17:10:56 INFO - PROCESS | 15200 | __end_tp_report 17:10:56 INFO - PROCESS | 15200 | __start_cc_report 17:10:56 INFO - PROCESS | 15200 | _x_x_mozilla_cycle_collect,801 17:10:56 INFO - PROCESS | 15200 | __end_cc_report 17:10:56 INFO - PROCESS | 15200 | __startTimestamp1488244256294__endTimestamp 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | ------- Summary: start ------- 17:10:56 INFO - PROCESS | 15200 | Number of tests: 14 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.56 (3.2%) stddev-sans-first:1.50 17:10:56 INFO - PROCESS | 15200 | Values: 102.0 110.0 112.0 113.0 115.0 114.0 112.0 112.0 112.0 111.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:125.00 stddev:16.53 (13.2%) stddev-sans-first:16.09 17:10:56 INFO - PROCESS | 15200 | Values: 150.0 120.0 119.0 161.0 120.0 127.0 118.0 123.0 153.0 122.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 17:10:56 INFO - PROCESS | 15200 | Values: 163.0 162.0 162.0 162.0 160.0 164.0 164.0 162.0 162.0 161.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.50 stddev:17.80 (23.6%) stddev-sans-first:18.52 17:10:56 INFO - PROCESS | 15200 | Values: 74.0 76.0 77.0 114.0 76.0 75.0 75.0 76.0 121.0 75.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.50 stddev:10.37 (12.4%) stddev-sans-first:10.59 17:10:56 INFO - PROCESS | 15200 | Values: 81.0 81.0 112.0 84.0 84.0 87.0 93.0 83.0 83.0 102.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 17:10:56 INFO - PROCESS | 15200 | Values: 117.0 118.0 118.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 17:10:56 INFO - PROCESS | 15200 | Values: 147.0 147.0 146.0 147.0 146.0 150.0 147.0 146.0 148.0 146.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 17:10:56 INFO - PROCESS | 15200 | Values: 85.0 86.0 85.0 85.0 85.0 84.0 87.0 85.0 84.0 84.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.17 17:10:56 INFO - PROCESS | 15200 | Values: 57.0 57.0 54.0 55.0 56.0 55.0 55.0 54.0 55.0 53.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.48 (2.5%) stddev-sans-first:1.50 17:10:56 INFO - PROCESS | 15200 | Values: 58.0 59.0 59.0 59.0 60.0 58.0 59.0 59.0 63.0 58.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.72 (3.6%) stddev-sans-first:2.88 17:10:56 INFO - PROCESS | 15200 | Values: 75.0 76.0 75.0 75.0 74.0 74.0 75.0 74.0 74.0 83.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:129.00 stddev:11.75 (9.1%) stddev-sans-first:12.33 17:10:56 INFO - PROCESS | 15200 | Values: 126.0 125.0 132.0 131.0 126.0 121.0 131.0 127.0 163.0 127.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:155.00 stddev:3.28 (2.1%) stddev-sans-first:3.28 17:10:56 INFO - PROCESS | 15200 | Values: 153.0 155.0 154.0 161.0 154.0 154.0 162.0 159.0 154.0 155.0 17:10:56 INFO - PROCESS | 15200 | 17:10:56 INFO - PROCESS | 15200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:2.10 (3.3%) stddev-sans-first:2.18 17:10:56 INFO - PROCESS | 15200 | Values: 63.0 63.0 65.0 65.0 69.0 63.0 62.0 63.0 66.0 63.0 17:10:56 INFO - PROCESS | 15200 | -------- Summary: end -------- 17:10:56 INFO - PROCESS | 15200 | 17:10:57 INFO - TEST-INFO | 15200: exit 0 17:10:57 INFO - TEST-OK | kraken | took 61074ms 17:10:57 INFO - SUITE-END | took 1174s 17:10:57 INFO - Completed test suite (00:19:34) 17:10:57 INFO - javascript benchmark 17:10:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7342.452081628805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.3743669984347, 3219.6619354967743, 3234.4663130583453, 3239.514072889068, 3240.627327857297, 5549.833504994846, 5560.555155587554, 5592.692401917893, 5619.297587801525, 5643.661380317179, 5563.638363506369, 5677.0, 5691.06097493913, 5691.9146212806845, 5704.1443783432505, 5110.667806592569, 5138.203578445328, 5171.818986335479, 5184.040952423814, 5188.455212202721, 5152.175651895697, 5158.484151584849, 5182.481751824806, 5183.118869792125, 5193.506616871391, 4962.280469331963, 4986.376702912136, 5189.558887494549, 5201.479852014806, 5218.712970786605, 5060.569851562622, 5066.088104141253, 5096.770645320951, 5112.36095488064, 5184.377874655065, 5046.899062018739, 5102.464241254689, 5114.590832733373, 5115.8209462669, 5128.871778205537, 5554.888902221933, 5596.048671725816, 5645.858853528694, 5664.348599910981, 5668.518175955049, 5804.738786754606, 5850.5612079094235, 5914.142449344821, 5918.585699001072, 5923.466887980059, 5975.910361344583, 5978.2228310319815, 5980.820575382745, 5987.580869339148, 6004.249468816398, 5609.999999999959, 5623.268975033219, 5636.549076073904, 5637.661740295554, 5647.745851436695, 6142.345304543789, 6144.109104179869, 6144.8771024579255, 6148.077788331697, 6203.0, 5940.376260492672, 5977.970110149421, 5995.730192141364, 5999.0, 6008.0, 5810.767569297181, 6077.908831367533, 6086.300075491286, 6090.116933044772, 6092.421219984094, 5824.854378640568, 6010.759569617167, 6055.485283750842, 6058.1518587397795, 6071.423214794588, 6014.308354539196, 6021.7591296347655, 6031.336552979169, 6033.215681961317, 6035.6076855004285, 4654.650901182425, 4654.743989080633, 4658.34783130362, 4673.345731597579, 4675.18184317743, 4045.292073887058, 4074.0629655179473, 4077.7757223353, 4088.0597462583773, 4124.298869192185, 5705.144228365695, 5711.714414279352, 5714.485696287354, 5735.254416925773, 5752.626079304916, 5991.430814072656, 6027.939720602825, 6036.185115009417, 6044.093385992136, 6048.758049677964, 5524.558035357162, 5568.582356323292, 5667.234923285386, 5681.0, 5727.3699893011735, 5160.071187186268, 5173.508516690984, 5173.534381905646, 5188.610854185876, 5194.97402512985, 6139.26328840542, 6159.076138579159, 6159.5072394208355, 6160.014397696436, 6171.629702217791, 5849.3858144894175, 5865.237519122486, 5880.323762767336, 6034.366391528826, 6060.636361818305, 5984.042553191643, 6136.447719705248, 6142.652254521207, 6143.450468055707, 6155.322914479493, 5982.252218472691, 5988.850278743066, 5989.610675306091, 5993.101034844633, 6018.9398106020135, 6028.216331876828, 6065.757369705162, 6089.147519347383, 6092.847678807888, 6093.847653808691, 5683.318001839641, 5743.712814359349, 5845.561582881216, 5879.559033072622, 5894.0274854650215, 5874.882502350015, 5896.734646940984, 5904.852378690567, 5932.970335148297, 5955.880882382415, 5809.82570522885, 5841.036229022334, 5862.296524416926, 5868.413158684098, 5879.412058794086, 5719.342275638189, 5721.427857214246, 5848.473637372486, 5856.765729370777, 5940.495057920125, 5744.798932037359, 5787.016207244863, 5790.044642633919, 5819.243498345358, 5822.650640961556], "value": 5540.4990092718135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.4189947203587, 610.5451438678184, 635.856932190257, 639.1499305923122, 662.0697919423212, 44030.67907962758, 45451.77274113629, 45624.54375456249, 48818.511814881844, 49050.75474622631, 45060.0, 46103.0, 46177.769111154485, 46272.30591541129, 46423.53576464234, 8886.51124188171, 9093.454392736425, 9098.77253068672, 9148.771280718001, 9159.404638698497, 8982.955085224565, 9131.13254240846, 9139.040400757924, 9144.0, 9151.725448236564, 9117.133872282157, 9158.404703694272, 9176.0, 9178.678746243882, 9204.72385828423, 9102.954485227565, 9105.863412048791, 9150.588223529958, 9158.816823663556, 9175.0, 9074.13795689415, 9168.633254669805, 9172.2203612693, 9181.67864124759, 9193.35646504745, 44149.0, 44388.112237755384, 44511.55488445106, 44552.77723611361, 44712.3293150603, 3572.374834403995, 3687.2625474905126, 3711.3876210425246, 3830.291396091732, 4108.972756810797, 32660.836695816608, 32947.50578741321, 32967.50548741771, 32974.0, 33209.3358132836, 4013.4381186633896, 4176.102138040305, 4228.809703563347, 4234.491860976703, 4242.745435273862, 381062.0, 381063.0, 381325.0, 383456.0, 384500.0, 65439.67280163569, 65948.34051659518, 65973.34026659768, 65993.67003164954, 66173.33826661672, 69407.0, 69419.0, 69527.30472695208, 69570.65214673894, 69866.25334366682, 17440.302387904594, 17621.118944052745, 17675.0, 17692.734608980874, 17694.734578981326, 13230.0, 13334.33328333599, 13344.666383340495, 13356.465741370237, 13363.53227637028, 19813.0, 20288.49278768013, 20425.48936276605, 20447.488812779502, 20637.174513019312, 7400.444966627417, 7414.777556673308, 7426.257374262531, 7499.2500749924575, 7563.394928405714, 1004.4324956399611, 1051.75283808305, 1064.6167379743285, 1111.050052205369, 1128.0129886349443, 31425.214369640486, 31486.842565787025, 31508.0, 31646.841765791025, 32268.677313227035, 1170.2861254634665, 1222.6332100370032, 1234.0, 1260.9156125731863, 1264.595329494553, 16945.0, 17165.7425138623, 17212.913935430242, 17214.225359858836, 17480.47558573245, 503268.0, 506761.0, 511177.0, 511685.0, 512301.0, 61121.69439152865, 61461.0, 61533.69233153895, 61614.0, 61653.07520387198, 1359.25241117387, 1378.3866179550005, 1404.768213244803, 1438.26648409312, 1452.7021960498073, 30763.384732305676, 31265.218369540944, 31986.36027279488, 32313.51529727009, 32606.0, 53205.73397133144, 53764.193537096195, 54064.729676351366, 54095.188572172236, 54110.72944635252, 431959.0, 432961.0, 436331.0, 437525.0, 438472.0, 30146.246343840703, 30527.54208686827, 30534.541981869846, 30714.38571228518, 30802.537961930142, 48252.758736206095, 48386.75806620944, 48512.757436212596, 49003.754981226295, 50050.74974625104, 39891.0, 40178.59821401865, 40695.38956915708, 41585.792071039454, 44928.0, 41624.58375416207, 41753.1649367017, 42307.0, 43413.13173736444, 43564.78217608892, 41437.049491849575, 41927.161456771304, 42602.14795704131, 43051.56948430601, 43125.13749724925, 34969.475457867644, 38028.809855950545, 38318.80840595779, 38333.4249986256, 39016.41475377928, 28928.855355723088, 28988.99398537506, 29349.85325073361, 29366.265843354086, 29378.559321609766], "value": 20936.85294606937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.15305699843816, 418.78432607207276, 424.6623933972493, 425.1560652105571, 437.1519252649859, 18735.2505899764, 19354.90322548387, 19853.3051343203, 19907.900460497676, 20253.189872405106, 19772.802271977274, 20085.899570502163, 20538.794612053876, 20767.0, 20826.16695332189, 5863.2670916135485, 6124.5100391968535, 6131.172291740625, 6133.509319254449, 6136.6011209271255, 5798.565107616924, 6002.0, 6073.240844894388, 6088.086786981944, 6098.024316109423, 6166.7533298667995, 6190.752369905198, 6194.225721784777, 6198.876022479548, 6203.0, 6016.608920420181, 6134.723937422827, 6192.566520343577, 6196.628202307876, 6203.968980155116, 5874.383189765099, 6031.306399764039, 6032.758689652409, 6033.125196846477, 6050.092486127072, 23246.53506929852, 23262.65106023411, 23665.76334236653, 23926.16258430964, 24013.039478420844, 2201.6587428948537, 2357.387079359362, 2378.797802186816, 2476.876156192201, 2669.0391459074717, 10207.693769186937, 10639.361638301727, 10848.403337816417, 10897.564097436092, 11245.15661325404, 1916.5879335942839, 1968.0946764488353, 1999.1103958738368, 2030.7664618568906, 2034.4608678700156, 74944.62527687327, 75849.24150758532, 77455.61272193659, 87928.5603571978, 87960.56019719924, 11548.556430446195, 11782.705432364088, 11882.524699012116, 11907.70230744221, 12288.569900053455, 16927.0690112045, 16928.153592320334, 17065.14674266282, 17087.658246834995, 17118.743218851727, 8515.659373624985, 8556.844825948541, 8658.95670521656, 8670.566471676391, 8749.212570868525, 8140.389470789596, 8220.424570280024, 8341.624626891804, 8439.789005274795, 8481.872771908425, 5084.669496482791, 5134.358205224347, 5149.536541711264, 5152.355955505562, 5207.6875387476875, 2005.2179649936536, 2028.695695645665, 2107.315122585166, 2131.9573608528053, 2166.230987999269, 947.1522986926662, 967.2068903499204, 1023.3194925374692, 1036.72008557689, 1097.4951522299673, 19943.900280498503, 19987.800121998593, 20036.298729544396, 20364.898175509028, 20365.389038328874, 1014.2190513304714, 1026.1124127629546, 1037.2998226197287, 1040.953157107932, 1040.9635662751768, 10673.519691613896, 11486.827697584376, 11522.481488333045, 11608.535658573732, 11629.418529073513, 471344.0, 472170.0, 487781.0, 488141.0, 494089.0, 87644.56177719071, 89321.55339223263, 92730.0, 99571.0, 100056.0, 1032.7831155457438, 1042.926995110335, 1092.9180311476512, 1096.5668560918393, 1111.3220935229342, 17722.822771772633, 17762.0, 17809.198586063918, 18108.366207182684, 18136.18387172607, 44444.333334999355, 44604.77697611491, 44610.77694611636, 45361.546384537054, 45791.0, 62070.0, 62721.0, 62913.0, 63026.68486657537, 63209.68395157995, 8393.790155246168, 8564.0, 8640.04959454472, 8713.172248636369, 8884.60019299146, 10030.398176109456, 11869.703257418289, 12339.13626046168, 12383.133180677267, 12530.248185108923, 5255.369355677343, 5895.734691938787, 9692.321537492307, 10194.898051019394, 10868.130549555859, 10297.588096476056, 10936.398498082364, 10954.671359859218, 10990.505427255952, 11198.21612487118, 10675.412852292888, 10855.18586106061, 10944.562217511211, 10949.83575246388, 11148.275362101438, 7726.961365193138, 8266.462679925786, 8345.457545259538, 8434.409591328547, 8989.235914947303, 10068.899311006797, 11592.188546801643, 11624.418779060845, 11774.705632358917, 11799.764004719686], "value": 9439.970657355532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.4380857178555, 1517.5674932644195, 1638.5903524118971, 1786.392626506989, 1807.2228941555127, 7642.503237289572, 7805.336546393563, 8201.794955126124, 8706.1729135732, 8709.346798990076, 8244.67021319148, 8476.91523084769, 8485.91514084859, 8703.695370662028, 8707.521086340248, 2389.199618127929, 2426.8301218914685, 2447.8041756659422, 2451.3013791069548, 2461.4092617771785, 2389.7490763469846, 2456.1771806444863, 2460.753924607534, 2464.494778570389, 2465.161844972709, 2424.781769640732, 2427.0, 2436.8537887726793, 2467.1365022242253, 2493.6259561065804, 2347.1080989224156, 2375.524895020994, 2381.4879800842727, 2400.3879010852297, 2400.855948643078, 2358.304300231419, 2378.2865140457793, 2405.8436201647014, 2406.1097393964346, 2406.8074554035634, 8489.915100848973, 8655.956720216358, 8657.350698697623, 8667.39328247023, 8718.694845680435, 5410.431904649994, 5477.917831232535, 5508.283923090013, 5543.279373681396, 5549.528290095347, 3438.985499277719, 3439.2949445363643, 3442.707369873564, 3458.39478091333, 3493.2489514754197, 1116.4696769034645, 1116.8393446546254, 1126.2679258481971, 1141.3779490177874, 1198.8201769734521, 11792.88207117935, 11847.0522358212, 11936.462859171359, 11938.761224775455, 11971.46128424223, 4749.762511874393, 4842.539958703917, 4928.827491037797, 4957.702537847741, 4960.330355402047, 10126.392416455037, 10156.796864062677, 10167.034131757471, 10182.18542516597, 10200.591976320864, 5485.972570137204, 5491.0, 5491.341039075257, 5493.23094766733, 5497.835064948058, 4918.5819205367225, 4932.161532539477, 5032.547070763649, 5040.0, 5144.022635699205, 3906.5507466641134, 3973.7814420207164, 4011.819468123883, 4041.7574945503366, 4044.595540445932, 1191.9344436055926, 1193.2840295822436, 1193.7493126443544, 1202.2005366431226, 1232.5193174661888, 832.2759199496477, 966.5167416291854, 977.6285011695652, 978.5058545434653, 989.3223142147652, 5642.802501912413, 5792.247007888947, 5820.883582328414, 5847.3275573308765, 5917.497012753965, 475.6860472088405, 480.538682864454, 482.6187312023532, 485.66003797341295, 1001.7495626093477, 3785.2618739346112, 3805.315043292234, 3898.7270891037924, 3966.2067586482817, 4127.2570937231585, 10340.638077667245, 10727.517261723242, 10742.838857417146, 10768.676939691823, 10770.515326810313, 10449.68650940473, 10537.209709271681, 10575.576976920991, 10619.681409557727, 10627.309224900357, 8053.1946805319, 8102.432829701865, 8196.30331421824, 8272.627731751965, 8278.503289802631, 5621.213030175697, 5669.0, 5687.829365119053, 5737.713114344349, 5808.767649293981, 9493.715188544355, 9618.759531011781, 9659.517024148623, 9684.564194611401, 9721.513924303898, 9784.364016338915, 9816.80366392654, 9870.901290986998, 9910.0, 9916.851247231152, 7200.675969581277, 7345.045144131443, 7558.2441755823975, 7706.383489320729, 7737.187595302412, 8442.197991190827, 8486.151384861465, 8499.490030598185, 8511.106333834858, 8522.36082293818, 7352.338289553966, 7386.815329616587, 7393.963030184815, 7552.886706699294, 7587.430942679432, 7251.5286506376915, 7283.927160728537, 7352.264773522605, 7488.9625551871895, 7546.2831031051965, 6942.895856562257, 6987.301269873175, 7017.789466316019, 7022.262662420372, 7037.190723066913, 4926.064047830901, 4929.112759703288, 4939.5554400104165, 4947.431045429822, 5112.565431938327, 4858.805647774049, 4887.1208354052715, 4988.326575912205, 4991.650584459053, 5000.324956131021], "value": 4562.123742642985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.83298834295675, 344.5796128722958, 346.63949492527763, 356.5097990263388, 358.55897246386945, 5665.490105890469, 5712.200291959129, 5728.885422291552, 5758.424157584244, 5768.3943185965445, 5496.5053145216925, 5591.8602034949145, 5606.887862242753, 5608.43915608439, 5630.915536266959, 4381.3647021181905, 4381.53993830648, 4382.715123516961, 4394.450693663292, 4398.120375924812, 4179.9245735407885, 4323.200207961521, 4330.480342358921, 4332.826686932534, 4382.868513944587, 4283.828646854122, 4291.0, 4295.248331541983, 4305.277888844456, 4307.633851122659, 4269.231538323101, 4285.250081235771, 4320.805563749639, 4348.9782551087355, 4359.476862776487, 3756.887293381203, 3798.2023775007283, 3830.693544516432, 3847.076701591598, 3853.2486165197797, 5464.6994415307145, 5465.754041068161, 5469.753861076261, 5482.698451585161, 5504.321182039476, 4944.615507657862, 4977.875553111201, 4984.750762461862, 5005.624578156617, 5009.123403404426, 5677.261955945742, 5722.656640601577, 5807.854803629901, 5808.1578171165365, 5827.4755272025295, 4175.498940127174, 4178.247915375231, 4188.853390131361, 4192.308269135589, 4209.65291106846, 6061.484628842789, 6061.66660833654, 6075.9670855954155, 6082.776128651777, 6083.536167852027, 4196.979015104905, 4274.2092712848225, 4288.399624052635, 4300.075483771005, 4305.720128191658, 4337.544557821447, 4344.174606824757, 4364.934525982113, 4373.300271956472, 4377.299632058855, 4991.80032798684, 4993.4756850530175, 4993.625478089158, 5000.2749601307605, 5013.373328333958, 5640.405413509831, 5669.489745922887, 5831.941680583224, 5834.970825145847, 5941.346451890288, 1427.5075099090798, 1433.7634290341978, 1439.1293267573176, 1440.4526280013738, 1440.5030264558711, 984.5877599880322, 999.6751055906859, 1010.6614284214724, 1018.1193267823279, 1023.4319952426475, 5497.47773961473, 5511.724413779295, 5514.338279406497, 5529.0, 5530.529904958124, 5844.532437404998, 5867.354590994987, 5869.882602348014, 5891.0, 5907.556933230025, 5384.784608615611, 5556.472135147154, 5558.471945165203, 5718.170865224519, 5724.685142317129, 3115.8909438169553, 3115.968840311568, 3123.406552754969, 3127.702868227515, 3130.4521708700886, 5917.733701983421, 6035.607685500516, 6073.301570319381, 6085.847853803691, 6086.2087928569, 6161.353057928853, 6167.506599472032, 6184.752609895554, 6190.628562286277, 6206.441420272197, 6241.625502469776, 6246.656433896089, 6248.187735594343, 6248.812535623939, 6290.716917738713, 6003.589156548295, 6033.879322413615, 6043.184170136975, 6099.817005489843, 6119.84700382494, 6024.789132380346, 6054.788082417271, 6074.542109893506, 6082.148499210026, 6092.725827337869, 6088.847778805565, 6216.409441103088, 6228.22147231596, 6262.93530099875, 6291.420517587767, 4326.805293761851, 4353.782310884507, 4355.564443555619, 4359.128174365203, 4360.56101486515, 5871.911921321098, 6052.515798736179, 6080.604760690541, 6082.787102451393, 6094.299155597163, 5844.181814545882, 5893.263342082239, 5903.468687818117, 5907.556933230111, 5925.644461332334, 5899.882002359843, 5931.3178984417345, 5937.554683398676, 5949.19685842423, 5967.522598192048, 5692.743826527733, 5809.796657116981, 5851.444112809277, 5864.765409383577, 5879.853003674943, 5969.791057312973, 5970.805618993817, 5989.940100598938, 6001.0, 6002.579819412599, 5659.405762395054, 5825.2135961644635, 5833.0, 5843.2695913010875, 5851.063829787214], "value": 4471.528698833511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.9550124743137, 839.3075712537159, 860.0238729042536, 868.7273144842812, 903.7198468474771, 13067.869321306784, 13739.381727822247, 13796.03427760056, 13825.17048977062, 13904.930475347623, 13118.081734278605, 13217.339133043333, 13231.999999999976, 13234.93382533086, 13272.668183295398, 831.1895901496039, 858.5921687198593, 863.4905405810571, 870.5168631409565, 871.1680345270252, 874.8862647855769, 876.132628697588, 876.3602570123813, 877.8595424732044, 879.4898958604026, 912.8904531456235, 912.9360944733871, 914.9725508234731, 916.4501299220481, 917.3807679816131, 911.2573252798948, 911.3210658059721, 911.5852287209303, 911.7857303533664, 912.370464379576, 667.1293961380396, 667.2926697700404, 667.5760891833672, 668.2682462703332, 670.1455644053822, 13692.315384230847, 13740.038197326192, 13788.448462061606, 13814.585562433043, 13897.79153312701, 12384.81422778659, 13767.586972390844, 14244.0, 14438.639034024129, 14505.202213878232, 11810.984315252437, 11873.0, 12129.150959432754, 12720.618381448572, 12775.936120319431, 4325.545817689129, 4335.653147748204, 4353.25994580922, 4364.301711726109, 4377.7592232427205, 65329.0, 66360.0, 68135.97796033113, 68847.65576172087, 68975.3102468974, 10164.0, 10317.535710893027, 10327.638532651321, 10432.739181520523, 10482.0, 19122.904385477985, 19410.0, 19769.308074217333, 19932.90033549823, 20177.39467815968, 7526.887096693554, 7590.316871481593, 7759.612019399007, 7951.443398962017, 8242.711505097293, 4624.630029597624, 4625.907481850344, 4731.69243999139, 4781.187198176319, 4832.395950506187, 3457.187560923181, 3460.636633153533, 3495.178633021238, 3507.2459421224557, 3585.0, 639.7185238495048, 641.1248645598724, 642.2164958750317, 647.1134545672364, 683.6581709145428, 646.9320721324193, 670.580886945659, 689.5242282824835, 711.548166914003, 721.487743701967, 8102.797430064295, 8327.333813294921, 8394.874076888851, 8581.0, 8702.869456958151, 648.4131860666105, 693.1647364925253, 693.2478261086777, 696.2028477393357, 706.8904319830434, 3869.2068126034096, 4174.463797322636, 4188.748675079505, 4227.387028880795, 4233.661307095425, 53837.0, 54881.45118548843, 75311.0, 79237.60381198172, 94351.0, 49807.750961244965, 51861.48138518642, 60613.0, 79846.60076699579, 80191.59904200559, 72360.2763972364, 72980.0, 73097.0, 73784.0, 74473.6276318615, 8824.5587720615, 9025.774355641162, 9162.816743665222, 9292.16370526656, 9498.722781299239, 36534.63465365312, 44632.33051504295, 45476.31785523286, 46526.0, 46937.0, 61678.0, 62950.0, 63011.36988630238, 63167.684161578894, 63828.0, 10916.508757106109, 11085.22403431752, 11298.4915678793, 11381.374024428736, 11424.657260282205, 12407.0, 12672.429740661508, 12696.619101426972, 12846.189173538927, 12929.612111636667, 11670.474828632561, 11677.88322116768, 11753.647390578297, 11829.881701182878, 12125.514979401078, 11371.886281137082, 11504.53981840717, 11637.476313565741, 11731.35477548743, 11799.941000295286, 10980.835287470534, 11535.480903359201, 11548.133889958119, 12130.211536250115, 12516.87483125157, 10269.225048341692, 10503.317284376491, 10556.102731267621, 10691.679249622524, 10850.511726972147, 10228.795424091626, 10670.253082284165, 10804.135669146292, 10894.782104358026, 10937.56249750001], "value": 7013.71703303174, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 112.0, 113.0, 115.0, 114.0, 112.0, 112.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 119.0, 161.0, 120.0, 127.0, 118.0, 123.0, 153.0, 122.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 160.0, 164.0, 164.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 114.0, 76.0, 75.0, 75.0, 76.0, 121.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 112.0, 84.0, 84.0, 87.0, 93.0, 83.0, 83.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 150.0, 147.0, 146.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 85.0, 84.0, 87.0, 85.0, 84.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 53.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 59.0, 63.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 74.0, 74.0, 75.0, 74.0, 74.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 132.0, 131.0, 126.0, 121.0, 131.0, 127.0, 163.0, 127.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 154.0, 161.0, 154.0, 154.0, 162.0, 159.0, 154.0, 155.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 65.0, 69.0, 63.0, 62.0, 63.0, 66.0, 63.0], "value": 64.2, "unit": "score"}]}]} 17:10:57 INFO - Return code: 0 17:10:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:10:57 ERROR - # TBPL SUCCESS # 17:10:57 INFO - Running post-action listener: _resource_record_post_action 17:10:57 INFO - [mozharness: 2017-02-28 01:10:57.638462Z] Finished run-tests step (success) 17:10:57 INFO - Running post-run listener: _resource_record_post_run 17:10:57 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 319078400; Read time: 0; Write time: 235132 17:10:57 INFO - TinderboxPrint: CPU usage
13.2% 17:10:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:10:57 INFO - TinderboxPrint: I/O write bytes / time
319,078,400 / 235,132 17:10:57 INFO - TinderboxPrint: CPU idle
8,225.2 (86.8%) 17:10:57 INFO - TinderboxPrint: CPU user
1,200.4 (12.7%) 17:10:57 INFO - TinderboxPrint: Swap in / out
0 / 0 17:10:57 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101076992; Read time: 0; Write time: 76828 17:10:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 218001408; Read time: 0; Write time: 158304 17:10:58 INFO - Running post-run listener: _upload_blobber_files 17:10:58 INFO - Blob upload gear active. 17:10:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:10:58 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 17:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:10:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:10:59 INFO - (blobuploader) - INFO - Done attempting. 17:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:00 INFO - (blobuploader) - INFO - Done attempting. 17:11:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:04 INFO - (blobuploader) - INFO - Done attempting. 17:11:04 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:04 INFO - Return code: 0 17:11:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:11:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f4c250da12038385a809ea28c9aae1fa2accf19333f54e53161060ade95562307d74b34eda591b82faf91ed4bf885450da50c91b7217e0bc99f50cebf21f828", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92df21e28909223cdaa9fac704ce1ca067ccccb5f7337dbcb4363ae8b3b10675993577e523e444ffd8e781015031b3bf35dd0b81264a156d6c175f24133c9f03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afce73e25c8569c01666cdf7b9e4823c9d8b0a212bf5dc51fc88efe47dd37a370aea199a4ab6fea54035f986505f3227a6ddec1f971189c9f8b479b09272c6d1"} 17:11:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:11:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:11:04 INFO - Contents: 17:11:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f4c250da12038385a809ea28c9aae1fa2accf19333f54e53161060ade95562307d74b34eda591b82faf91ed4bf885450da50c91b7217e0bc99f50cebf21f828", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92df21e28909223cdaa9fac704ce1ca067ccccb5f7337dbcb4363ae8b3b10675993577e523e444ffd8e781015031b3bf35dd0b81264a156d6c175f24133c9f03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afce73e25c8569c01666cdf7b9e4823c9d8b0a212bf5dc51fc88efe47dd37a370aea199a4ab6fea54035f986505f3227a6ddec1f971189c9f8b479b09272c6d1"} 17:11:04 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:04 INFO - Copying logs to upload dir... 17:11:04 INFO - mkdir: /builds/slave/test/build/upload/logs 17:11:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.136999 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-27 17:11:03.532971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 17:11:03.535931) ========= 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=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 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-Beta/sha512/1f4c250da12038385a809ea28c9aae1fa2accf19333f54e53161060ade95562307d74b34eda591b82faf91ed4bf885450da50c91b7217e0bc99f50cebf21f828", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92df21e28909223cdaa9fac704ce1ca067ccccb5f7337dbcb4363ae8b3b10675993577e523e444ffd8e781015031b3bf35dd0b81264a156d6c175f24133c9f03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afce73e25c8569c01666cdf7b9e4823c9d8b0a212bf5dc51fc88efe47dd37a370aea199a4ab6fea54035f986505f3227a6ddec1f971189c9f8b479b09272c6d1"} build_url:https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/eKx5qcc8SI6JDJmxfE-Z1Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f4c250da12038385a809ea28c9aae1fa2accf19333f54e53161060ade95562307d74b34eda591b82faf91ed4bf885450da50c91b7217e0bc99f50cebf21f828", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92df21e28909223cdaa9fac704ce1ca067ccccb5f7337dbcb4363ae8b3b10675993577e523e444ffd8e781015031b3bf35dd0b81264a156d6c175f24133c9f03", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/afce73e25c8569c01666cdf7b9e4823c9d8b0a212bf5dc51fc88efe47dd37a370aea199a4ab6fea54035f986505f3227a6ddec1f971189c9f8b479b09272c6d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 17:11:03.563636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 17:11:03.564033) ========= 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=1258088b6da462a47ba2cd90000001a2-1488242783.874392-407480808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 17:11:03.613261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 17:11:03.613563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 17:11:03.616889) ========= ========= Total master_lag: 0.74 =========