builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1479814828.17 results: success (0) buildid: 20161122004020 builduid: 09d32a9756d54391941d142cf829c7d0 revision: 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.170701) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.171218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.171513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.196823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.197214) ========= 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=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 03:40:28-- 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% 42.8M=0s 2016-11-22 03:40:28 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.386805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.387134) ========= 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=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.438705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:28.439056) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb --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=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 03:40:28,544 truncating revision to first 12 chars 2016-11-22 03:40:28,544 Setting DEBUG logging. 2016-11-22 03:40:28,544 attempt 1/10 2016-11-22 03:40:28,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b59b8da8f75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 03:40:28,867 unpacking tar archive at: mozilla-aurora-0b59b8da8f75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659540 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:29.112197) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:29.112547) ========= script_repo_revision: 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:29.113012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:29.113297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 03:40:29.123370) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-22 03:40:29.123762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:29 INFO - MultiFileLogger online at 20161122 03:40:29 in /builds/slave/test 03:40:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:40:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:29 INFO - {'append_to_log': False, 03:40:29 INFO - 'base_work_dir': '/builds/slave/test', 03:40:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:29 INFO - 'branch': 'Mozilla-Aurora', 03:40:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:29 INFO - 'config_files': ('talos/linux_config.py',), 03:40:29 INFO - 'default_actions': ('clobber', 03:40:29 INFO - 'read-buildbot-config', 03:40:29 INFO - 'download-and-extract', 03:40:29 INFO - 'populate-webroot', 03:40:29 INFO - 'create-virtualenv', 03:40:29 INFO - 'install', 03:40:29 INFO - 'run-tests'), 03:40:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:29 INFO - 'download_minidump_stackwalk': True, 03:40:29 INFO - 'download_symbols': 'ondemand', 03:40:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:29 INFO - 'installer_path': 'installer.exe', 03:40:29 INFO - 'log_level': 'info', 03:40:29 INFO - 'log_name': 'talos', 03:40:29 INFO - 'log_to_console': True, 03:40:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:29 INFO - 'opt_config_files': (), 03:40:29 INFO - 'pip_index': False, 03:40:29 INFO - 'sps_profile': False, 03:40:29 INFO - 'sps_profile_interval': 0, 03:40:29 INFO - 'suite': 'dromaeojs-e10s', 03:40:29 INFO - 'system_bits': '32', 03:40:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:29 INFO - 'title': 'talos-linux64-ix-001', 03:40:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:29 INFO - 'use_talos_json': True, 03:40:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:29 INFO - 'work_dir': 'build'} 03:40:29 INFO - [mozharness: 2016-11-22 11:40:29.327923Z] Running clobber step. 03:40:29 INFO - Running pre-action listener: _resource_record_pre_action 03:40:29 INFO - Running main action method: clobber 03:40:29 INFO - rmtree: /builds/slave/test/build 03:40:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:29 INFO - Running post-action listener: _resource_record_post_action 03:40:29 INFO - [mozharness: 2016-11-22 11:40:29.781722Z] Finished clobber step (success) 03:40:29 INFO - [mozharness: 2016-11-22 11:40:29.781821Z] Running read-buildbot-config step. 03:40:29 INFO - Running pre-action listener: _resource_record_pre_action 03:40:29 INFO - Running main action method: read_buildbot_config 03:40:29 INFO - Using buildbot properties: 03:40:29 INFO - { 03:40:29 INFO - "project": "", 03:40:29 INFO - "product": "firefox", 03:40:29 INFO - "script_repo_revision": "production", 03:40:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:40:29 INFO - "repository": "", 03:40:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:40:29 INFO - "buildid": "20161122004020", 03:40:29 INFO - "stage_platform": "linux64-pgo", 03:40:29 INFO - "basedir": "/builds/slave/test", 03:40:29 INFO - "nightly_build": "True", 03:40:29 INFO - "buildnumber": 651, 03:40:29 INFO - "slavename": "talos-linux64-ix-001", 03:40:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:40:29 INFO - "platform": "ubuntu64_hw", 03:40:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:29 INFO - "branch": "mozilla-aurora", 03:40:29 INFO - "repo_path": "releases/mozilla-aurora", 03:40:29 INFO - "revision": "0b59b8da8f7566f70eb2ac013e60192d1d1c6adb", 03:40:29 INFO - "pgo_build": "True", 03:40:29 INFO - "builduid": "09d32a9756d54391941d142cf829c7d0", 03:40:29 INFO - "slavebuilddir": "test" 03:40:29 INFO - } 03:40:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:40:29 INFO - Running post-action listener: _resource_record_post_action 03:40:29 INFO - [mozharness: 2016-11-22 11:40:29.784295Z] Finished read-buildbot-config step (success) 03:40:29 INFO - [mozharness: 2016-11-22 11:40:29.784383Z] Running download-and-extract step. 03:40:29 INFO - Running pre-action listener: _resource_record_pre_action 03:40:29 INFO - Running main action method: download_and_extract 03:40:29 INFO - mkdir: /builds/slave/test/build/tests 03:40: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')]} 03:40:29 INFO - trying https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:40:30 INFO - Downloaded 1361 bytes. 03:40:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:40:30 INFO - Using the following test package requirements: 03:40:30 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:30 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:30 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:30 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'jsshell-linux-x86_64.zip'], 03:40:30 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:30 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:30 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:30 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:30 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:30 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:31 INFO - Http code: 200 03:40:31 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 03:40:31 INFO - x-amz-cf-id: onf2HYn967jGcylkm1Yl8gV1xwvwmXwXpB1a1cejtR2tX1NX0ZR5CQ== 03:40:31 INFO - x-amz-version-id: cKGxszBKcl0TlzexDbibh59uOLo1C3I7 03:40:31 INFO - Expected file size: 21949595 03:40:31 INFO - Obtained file size: 21949595 03:40:35 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:36 INFO - Http code: 200 03:40:36 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 03:40:36 INFO - x-amz-cf-id: Rq0wnnsYlTREYEKURl7ecmvZmJ48IUtaHkb6Gq5ytS7eG0N3idefAQ== 03:40:36 INFO - x-amz-version-id: cKGxszBKcl0TlzexDbibh59uOLo1C3I7 03:40:36 INFO - Expected file size: 21949595 03:40:36 INFO - Obtained file size: 21949595 03:40:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:41 INFO - Fetch https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:40:41 INFO - Http code: 200 03:40:41 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 03:40:41 INFO - x-amz-cf-id: qE9M7nrG2r6Rye4PVnWbcmprX_IadwpgRDB-UgCYWtzw3sXJmMOwJw== 03:40:41 INFO - x-amz-version-id: ao5luqrsEm5K8eqxuNBprL2SUuZ7l4ta 03:40:41 INFO - Expected file size: 14409038 03:40:41 INFO - Obtained file size: 14409038 03:40: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')]} 03:40:42 INFO - trying https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:40:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:43 INFO - Downloaded 63864710 bytes. 03:40:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:40:43 INFO - mkdir: /builds/slave/test/properties 03:40:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:43 INFO - Contents: 03:40:43 INFO - build_url:https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:40:43 INFO - Running post-action listener: _resource_record_post_action 03:40:43 INFO - Running post-action listener: set_extra_try_arguments 03:40:43 INFO - [mozharness: 2016-11-22 11:40:43.985614Z] Finished download-and-extract step (success) 03:40:43 INFO - [mozharness: 2016-11-22 11:40:43.985840Z] Running populate-webroot step. 03:40:43 INFO - Running pre-action listener: _resource_record_pre_action 03:40:43 INFO - Running main action method: populate_webroot 03:40:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:43 INFO - '--tppagecycles', 03:40:43 INFO - '7'], 03:40:43 INFO - 'tests': ['tsvgm']}}, 03:40:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:43 INFO - 'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:43 INFO - 'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['damp', 'tps']}, 03:40:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:43 INFO - 'tests': ['damp', 'tps']}, 03:40:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['dromaeo_dom']}, 03:40:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['basic_compositor_video']}, 03:40:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:40:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['a11yr', 03:40:43 INFO - 'ts_paint', 03:40:43 INFO - 'tpaint', 03:40:43 INFO - 'sessionrestore', 03:40:43 INFO - 'sessionrestore_no_auto_restore', 03:40:43 INFO - 'tabpaint']}, 03:40:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:43 INFO - 'tests': ['tsvgx', 03:40:43 INFO - 'tsvgr_opacity', 03:40:43 INFO - 'tart', 03:40:43 INFO - 'tscrollx', 03:40:43 INFO - 'cart']}, 03:40:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:43 INFO - 'tsvgr_opacity', 03:40:43 INFO - 'tart', 03:40:43 INFO - 'tscrollx', 03:40:43 INFO - 'cart']}, 03:40:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:44 INFO - 'talos_options': ['--disable-e10s'], 03:40:44 INFO - 'tests': ['tp5o']}, 03:40:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:44 INFO - 'tests': ['tp5o']}, 03:40:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:44 INFO - 'talos_options': ['--disable-e10s', 03:40:44 INFO - '--xperf_path', 03:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:44 INFO - 'tests': ['tp5n']}, 03:40:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:44 INFO - 'talos_options': ['--xperf_path', 03:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:44 INFO - 'tests': ['tp5n']}}, 03:40:44 INFO - 'talos.zip': {'path': '', 03:40:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:44 INFO - Running post-action listener: _resource_record_post_action 03:40:44 INFO - [mozharness: 2016-11-22 11:40:44.001343Z] Finished populate-webroot step (success) 03:40:44 INFO - [mozharness: 2016-11-22 11:40:44.001433Z] Running create-virtualenv step. 03:40:44 INFO - Running pre-action listener: _resource_record_pre_action 03:40:44 INFO - Running main action method: create_virtualenv 03:40:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:44 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 03:40:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:44 INFO - Using real prefix '/usr' 03:40:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:46 INFO - Installing pip.................done. 03:40:46 INFO - Return code: 0 03:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:40:46 INFO - Reading from file tmpfile_stdout 03:40:46 INFO - Output received: 03:40:46 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) 03:40:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:46 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')]} 03:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:46 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')]} 03:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:46 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40:46 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 03:40:46 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 03:40:46 INFO - Using env: {'DISPLAY': ':0', 03:40:46 INFO - 'HOME': '/home/cltbld', 03:40:46 INFO - 'LANG': 'en_US.UTF-8', 03:40:46 INFO - 'LANGUAGE': 'en_US:en', 03:40:46 INFO - 'LOGNAME': 'cltbld', 03:40:46 INFO - 'MAIL': '/var/mail/cltbld', 03:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:46 INFO - 'MOZ_NO_REMOTE': '1', 03:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:46 INFO - 'NO_EM_RESTART': '1', 03:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:46 INFO - 'PWD': '/builds/slave/test', 03:40:46 INFO - 'SHELL': '/bin/bash', 03:40:46 INFO - 'SHLVL': '1', 03:40:46 INFO - 'TERM': 'linux', 03:40:46 INFO - 'TMOUT': '86400', 03:40:46 INFO - 'USER': 'cltbld', 03:40:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:46 INFO - '_': '/tools/buildbot/bin/python'} 03:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:46 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 03:40:46 INFO - Cleaning up... 03:40:47 INFO - Return code: 0 03:40:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40:47 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')]} 03:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 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')]} 03:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40:47 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 03:40:47 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 03:40:47 INFO - Using env: {'DISPLAY': ':0', 03:40:47 INFO - 'HOME': '/home/cltbld', 03:40:47 INFO - 'LANG': 'en_US.UTF-8', 03:40:47 INFO - 'LANGUAGE': 'en_US:en', 03:40:47 INFO - 'LOGNAME': 'cltbld', 03:40:47 INFO - 'MAIL': '/var/mail/cltbld', 03:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:47 INFO - 'MOZ_NO_REMOTE': '1', 03:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:47 INFO - 'NO_EM_RESTART': '1', 03:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:47 INFO - 'PWD': '/builds/slave/test', 03:40:47 INFO - 'SHELL': '/bin/bash', 03:40:47 INFO - 'SHLVL': '1', 03:40:47 INFO - 'TERM': 'linux', 03:40:47 INFO - 'TMOUT': '86400', 03:40:47 INFO - 'USER': 'cltbld', 03:40:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:47 INFO - '_': '/tools/buildbot/bin/python'} 03:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:47 INFO - Downloading/unpacking psutil>=3.1.1 03:40:47 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 03:40:47 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 03:40:47 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 03:40:47 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 03:40:47 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 03:40:47 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 03:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:49 INFO - Installing collected packages: psutil 03:40:49 INFO - Running setup.py install for psutil 03:40:49 INFO - building 'psutil._psutil_linux' extension 03:40:49 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 03:40:49 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 03:40:49 INFO - building 'psutil._psutil_posix' extension 03:40:49 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 03:40:49 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 03:40:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:49 INFO - Successfully installed psutil 03:40:49 INFO - Cleaning up... 03:40:49 INFO - Return code: 0 03:40:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:40: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 mozsystemmonitor==0.3 03:40:49 INFO - Using env: {'DISPLAY': ':0', 03:40:49 INFO - 'HOME': '/home/cltbld', 03:40:49 INFO - 'LANG': 'en_US.UTF-8', 03:40:49 INFO - 'LANGUAGE': 'en_US:en', 03:40:49 INFO - 'LOGNAME': 'cltbld', 03:40:49 INFO - 'MAIL': '/var/mail/cltbld', 03:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:49 INFO - 'MOZ_NO_REMOTE': '1', 03:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:49 INFO - 'NO_EM_RESTART': '1', 03:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:49 INFO - 'PWD': '/builds/slave/test', 03:40:49 INFO - 'SHELL': '/bin/bash', 03:40:49 INFO - 'SHLVL': '1', 03:40:49 INFO - 'TERM': 'linux', 03:40:49 INFO - 'TMOUT': '86400', 03:40:49 INFO - 'USER': 'cltbld', 03:40:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:49 INFO - '_': '/tools/buildbot/bin/python'} 03:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:52 INFO - Installing collected packages: mozsystemmonitor 03:40:52 INFO - Running setup.py install for mozsystemmonitor 03:40:52 INFO - Successfully installed mozsystemmonitor 03:40:52 INFO - Cleaning up... 03:40:52 INFO - Return code: 0 03:40:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', '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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:40: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 jsonschema==2.5.1 03:40:52 INFO - Using env: {'DISPLAY': ':0', 03:40:52 INFO - 'HOME': '/home/cltbld', 03:40:52 INFO - 'LANG': 'en_US.UTF-8', 03:40:52 INFO - 'LANGUAGE': 'en_US:en', 03:40:52 INFO - 'LOGNAME': 'cltbld', 03:40:52 INFO - 'MAIL': '/var/mail/cltbld', 03:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:52 INFO - 'MOZ_NO_REMOTE': '1', 03:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:52 INFO - 'NO_EM_RESTART': '1', 03:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:52 INFO - 'PWD': '/builds/slave/test', 03:40:52 INFO - 'SHELL': '/bin/bash', 03:40:52 INFO - 'SHLVL': '1', 03:40:52 INFO - 'TERM': 'linux', 03:40:52 INFO - 'TMOUT': '86400', 03:40:52 INFO - 'USER': 'cltbld', 03:40:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:52 INFO - '_': '/tools/buildbot/bin/python'} 03:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:54 INFO - warning: no files found matching '*.txt' 03:40:54 INFO - no previously-included directories found matching 'build' 03:40:54 INFO - no previously-included directories found matching 'dist' 03:40:54 INFO - no previously-included directories found matching '.git*' 03:40:54 INFO - Installing collected packages: jsonschema, functools32 03:40:54 INFO - Running setup.py install for functools32 03:40:54 INFO - warning: no files found matching '*.txt' 03:40:54 INFO - no previously-included directories found matching 'build' 03:40:54 INFO - no previously-included directories found matching 'dist' 03:40:54 INFO - no previously-included directories found matching '.git*' 03:40:54 INFO - Successfully installed jsonschema functools32 03:40:54 INFO - Cleaning up... 03:40:54 INFO - Return code: 0 03:40:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', '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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:40: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 functools32==3.2.3-2 03:40:54 INFO - Using env: {'DISPLAY': ':0', 03:40:54 INFO - 'HOME': '/home/cltbld', 03:40:54 INFO - 'LANG': 'en_US.UTF-8', 03:40:54 INFO - 'LANGUAGE': 'en_US:en', 03:40:54 INFO - 'LOGNAME': 'cltbld', 03:40:54 INFO - 'MAIL': '/var/mail/cltbld', 03:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:54 INFO - 'MOZ_NO_REMOTE': '1', 03:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:54 INFO - 'NO_EM_RESTART': '1', 03:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:54 INFO - 'PWD': '/builds/slave/test', 03:40:54 INFO - 'SHELL': '/bin/bash', 03:40:54 INFO - 'SHLVL': '1', 03:40:54 INFO - 'TERM': 'linux', 03:40:54 INFO - 'TMOUT': '86400', 03:40:54 INFO - 'USER': 'cltbld', 03:40:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:54 INFO - '_': '/tools/buildbot/bin/python'} 03:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:55 INFO - Cleaning up... 03:40:55 INFO - Return code: 0 03:40:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40:55 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 03:40:55 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 03:40:55 INFO - Using env: {'DISPLAY': ':0', 03:40:55 INFO - 'HOME': '/home/cltbld', 03:40:55 INFO - 'LANG': 'en_US.UTF-8', 03:40:55 INFO - 'LANGUAGE': 'en_US:en', 03:40:55 INFO - 'LOGNAME': 'cltbld', 03:40:55 INFO - 'MAIL': '/var/mail/cltbld', 03:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:55 INFO - 'MOZ_NO_REMOTE': '1', 03:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:55 INFO - 'NO_EM_RESTART': '1', 03:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:55 INFO - 'PWD': '/builds/slave/test', 03:40:55 INFO - 'SHELL': '/bin/bash', 03:40:55 INFO - 'SHLVL': '1', 03:40:55 INFO - 'TERM': 'linux', 03:40:55 INFO - 'TMOUT': '86400', 03:40:55 INFO - 'USER': 'cltbld', 03:40:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:55 INFO - '_': '/tools/buildbot/bin/python'} 03:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:55 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 03:40:55 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 03:40:55 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 03:40:55 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 03:40:55 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 03:40:55 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 03:40:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:57 INFO - Downloading docopt-0.6.1.tar.gz 03:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:57 INFO - Running setup.py install for blobuploader 03:40:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:58 INFO - Running setup.py install for requests 03:40:58 INFO - Running setup.py install for docopt 03:40:58 INFO - Successfully installed blobuploader requests docopt 03:40:58 INFO - Cleaning up... 03:40:58 INFO - Return code: 0 03:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:58 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')]} 03:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:58 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')]} 03:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:58 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:40:58 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 03:40:58 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 03:40:58 INFO - Using env: {'DISPLAY': ':0', 03:40:58 INFO - 'HOME': '/home/cltbld', 03:40:58 INFO - 'LANG': 'en_US.UTF-8', 03:40:58 INFO - 'LANGUAGE': 'en_US:en', 03:40:58 INFO - 'LOGNAME': 'cltbld', 03:40:58 INFO - 'MAIL': '/var/mail/cltbld', 03:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:58 INFO - 'MOZ_NO_REMOTE': '1', 03:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:58 INFO - 'NO_EM_RESTART': '1', 03:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:58 INFO - 'PWD': '/builds/slave/test', 03:40:58 INFO - 'SHELL': '/bin/bash', 03:40:58 INFO - 'SHLVL': '1', 03:40:58 INFO - 'TERM': 'linux', 03:40:58 INFO - 'TMOUT': '86400', 03:40:58 INFO - 'USER': 'cltbld', 03:40:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:58 INFO - '_': '/tools/buildbot/bin/python'} 03:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:58 INFO - Running setup.py (path:/tmp/pip-ICVVYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:58 INFO - Running setup.py (path:/tmp/pip-UTDTRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:58 INFO - Running setup.py (path:/tmp/pip-MNokUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:59 INFO - Running setup.py (path:/tmp/pip-Y5Z42C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:59 INFO - Running setup.py (path:/tmp/pip-jjWcKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:59 INFO - Running setup.py (path:/tmp/pip-imiHav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:59 INFO - Running setup.py (path:/tmp/pip-dj9KWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:59 INFO - Running setup.py (path:/tmp/pip-wr0Fzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:59 INFO - Running setup.py (path:/tmp/pip-GUw00F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:59 INFO - Running setup.py (path:/tmp/pip-6I6qae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:59 INFO - Running setup.py (path:/tmp/pip-PDY4Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:59 INFO - Running setup.py (path:/tmp/pip-iG49J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:59 INFO - Running setup.py (path:/tmp/pip-i18faX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:59 INFO - Running setup.py (path:/tmp/pip-tIz6Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:59 INFO - Running setup.py (path:/tmp/pip-YZPzSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:59 INFO - Running setup.py (path:/tmp/pip-XD0n1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:59 INFO - Running setup.py (path:/tmp/pip-GqJijh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:00 INFO - Running setup.py install for manifestparser 03:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Running setup.py install for mozcrash 03:41:00 INFO - Running setup.py install for mozdebug 03:41:00 INFO - Running setup.py install for mozdevice 03:41:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Running setup.py install for mozfile 03:41:00 INFO - Running setup.py install for mozhttpd 03:41:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Running setup.py install for mozinfo 03:41:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Running setup.py install for mozInstall 03:41:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:00 INFO - Running setup.py install for mozleak 03:41:00 INFO - Running setup.py install for mozlog 03:41:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Running setup.py install for moznetwork 03:41:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Running setup.py install for mozprocess 03:41:01 INFO - Running setup.py install for mozprofile 03:41:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Running setup.py install for mozrunner 03:41:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Running setup.py install for mozscreenshot 03:41:01 INFO - Running setup.py install for moztest 03:41:01 INFO - Running setup.py install for mozversion 03:41:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:01 INFO - Cleaning up... 03:41:01 INFO - Return code: 0 03:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41: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')]} 03:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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')]} 03:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:01 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:41:01 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 03:41:01 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 03:41:01 INFO - Using env: {'DISPLAY': ':0', 03:41:01 INFO - 'HOME': '/home/cltbld', 03:41:01 INFO - 'LANG': 'en_US.UTF-8', 03:41:01 INFO - 'LANGUAGE': 'en_US:en', 03:41:01 INFO - 'LOGNAME': 'cltbld', 03:41:01 INFO - 'MAIL': '/var/mail/cltbld', 03:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:01 INFO - 'MOZ_NO_REMOTE': '1', 03:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:01 INFO - 'NO_EM_RESTART': '1', 03:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:01 INFO - 'PWD': '/builds/slave/test', 03:41:01 INFO - 'SHELL': '/bin/bash', 03:41:01 INFO - 'SHLVL': '1', 03:41:01 INFO - 'TERM': 'linux', 03:41:01 INFO - 'TMOUT': '86400', 03:41:01 INFO - 'USER': 'cltbld', 03:41:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:01 INFO - '_': '/tools/buildbot/bin/python'} 03:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:02 INFO - Running setup.py (path:/tmp/pip-UXcWlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:02 INFO - Running setup.py (path:/tmp/pip-5kxDRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:02 INFO - Running setup.py (path:/tmp/pip-sRCY6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:02 INFO - Running setup.py (path:/tmp/pip-kSOupU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:02 INFO - Running setup.py (path:/tmp/pip-dha8I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:02 INFO - Running setup.py (path:/tmp/pip-ruDDWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:02 INFO - Running setup.py (path:/tmp/pip-eYQtHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:02 INFO - Running setup.py (path:/tmp/pip-svdDLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:02 INFO - Running setup.py (path:/tmp/pip-_spLjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:02 INFO - Running setup.py (path:/tmp/pip-ONzhoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:02 INFO - Running setup.py (path:/tmp/pip-DyRskp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:02 INFO - Running setup.py (path:/tmp/pip-m8Pc4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:02 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)) 03:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:02 INFO - Running setup.py (path:/tmp/pip-iWUmUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:03 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)) 03:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:03 INFO - Running setup.py (path:/tmp/pip-UhycHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:03 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)) 03:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:03 INFO - Running setup.py (path:/tmp/pip-7l0z_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:03 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)) 03:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:03 INFO - Running setup.py (path:/tmp/pip-fc8QH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:03 INFO - Running setup.py (path:/tmp/pip-tlg3Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:03 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)) 03:41:03 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)) 03:41:03 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)) 03:41:03 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)) 03:41:03 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)) 03:41:03 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)) 03:41:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:03 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 03:41:03 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 03:41:03 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 03:41:03 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 03:41:03 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 03:41:03 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 03:41:05 INFO - Downloading blessings-1.6.tar.gz 03:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:05 INFO - Installing collected packages: blessings 03:41:05 INFO - Running setup.py install for blessings 03:41:05 INFO - Successfully installed blessings 03:41:05 INFO - Cleaning up... 03:41:05 INFO - Return code: 0 03:41:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:05 INFO - Reading from file tmpfile_stdout 03:41:05 INFO - Current package versions: 03:41:05 INFO - argparse == 1.2.1 03:41:05 INFO - blessings == 1.6 03:41:05 INFO - blobuploader == 1.2.4 03:41:05 INFO - docopt == 0.6.1 03:41:05 INFO - functools32 == 3.2.3-2 03:41:05 INFO - jsonschema == 2.5.1 03:41:05 INFO - manifestparser == 1.1 03:41:05 INFO - mozInstall == 1.12 03:41:05 INFO - mozcrash == 1.0 03:41:05 INFO - mozdebug == 0.1 03:41:05 INFO - mozdevice == 0.48 03:41:05 INFO - mozfile == 1.2 03:41:05 INFO - mozhttpd == 0.7 03:41:05 INFO - mozinfo == 0.9 03:41:05 INFO - mozleak == 0.1 03:41:05 INFO - mozlog == 3.4 03:41:05 INFO - moznetwork == 0.27 03:41:05 INFO - mozprocess == 0.23 03:41:05 INFO - mozprofile == 0.28 03:41:05 INFO - mozrunner == 6.13 03:41:05 INFO - mozscreenshot == 0.1 03:41:05 INFO - mozsystemmonitor == 0.3 03:41:05 INFO - moztest == 0.7 03:41:05 INFO - mozversion == 1.4 03:41:05 INFO - psutil == 3.1.1 03:41:05 INFO - requests == 1.2.3 03:41:05 INFO - wsgiref == 0.1.2 03:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:05 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')]} 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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')]} 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:41:05 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 03:41:05 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 03:41:05 INFO - Using env: {'DISPLAY': ':0', 03:41:05 INFO - 'HOME': '/home/cltbld', 03:41:05 INFO - 'LANG': 'en_US.UTF-8', 03:41:05 INFO - 'LANGUAGE': 'en_US:en', 03:41:05 INFO - 'LOGNAME': 'cltbld', 03:41:05 INFO - 'MAIL': '/var/mail/cltbld', 03:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:05 INFO - 'MOZ_NO_REMOTE': '1', 03:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:05 INFO - 'NO_EM_RESTART': '1', 03:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:05 INFO - 'PWD': '/builds/slave/test', 03:41:05 INFO - 'SHELL': '/bin/bash', 03:41:05 INFO - 'SHLVL': '1', 03:41:05 INFO - 'TERM': 'linux', 03:41:05 INFO - 'TMOUT': '86400', 03:41:05 INFO - 'USER': 'cltbld', 03:41:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:05 INFO - '_': '/tools/buildbot/bin/python'} 03:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 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)) 03:41:05 INFO - Cleaning up... 03:41:05 INFO - Return code: 0 03:41:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:05 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')]} 03:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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')]} 03:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:05 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 0x7f5b40e1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', '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 03:41:05 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 03:41:05 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 03:41:05 INFO - Using env: {'DISPLAY': ':0', 03:41:05 INFO - 'HOME': '/home/cltbld', 03:41:05 INFO - 'LANG': 'en_US.UTF-8', 03:41:05 INFO - 'LANGUAGE': 'en_US:en', 03:41:05 INFO - 'LOGNAME': 'cltbld', 03:41:05 INFO - 'MAIL': '/var/mail/cltbld', 03:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:05 INFO - 'MOZ_NO_REMOTE': '1', 03:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:05 INFO - 'NO_EM_RESTART': '1', 03:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:05 INFO - 'PWD': '/builds/slave/test', 03:41:05 INFO - 'SHELL': '/bin/bash', 03:41:05 INFO - 'SHLVL': '1', 03:41:05 INFO - 'TERM': 'linux', 03:41:05 INFO - 'TMOUT': '86400', 03:41:05 INFO - 'USER': 'cltbld', 03:41:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:05 INFO - '_': '/tools/buildbot/bin/python'} 03:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:41:06 INFO - Cleaning up... 03:41:06 INFO - Return code: 0 03:41:06 INFO - Running post-action listener: _resource_record_post_action 03:41:06 INFO - Running post-action listener: _start_resource_monitoring 03:41:06 INFO - Starting resource monitoring. 03:41:06 INFO - [mozharness: 2016-11-22 11:41:06.193560Z] Finished create-virtualenv step (success) 03:41:06 INFO - [mozharness: 2016-11-22 11:41:06.194065Z] Running install step. 03:41:06 INFO - Running pre-action listener: _resource_record_pre_action 03:41:06 INFO - Running main action method: install 03:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:06 INFO - Reading from file tmpfile_stdout 03:41:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:06 INFO - Reading from file tmpfile_stdout 03:41:06 INFO - Output received: 03:41:06 INFO - Usage: mozinstall [options] installer 03:41:06 INFO - Options: 03:41:06 INFO - -h, --help show this help message and exit 03:41:06 INFO - -d DEST, --destination=DEST 03:41:06 INFO - Directory to install application into. [default: 03:41:06 INFO - "/builds/slave/test"] 03:41:06 INFO - --app=APP Application being installed. [default: firefox] 03:41:06 INFO - mkdir: /builds/slave/test/build/application 03:41:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:22 INFO - Reading from file tmpfile_stdout 03:41:22 INFO - Output received: 03:41:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:22 INFO - Running post-action listener: _resource_record_post_action 03:41:22 INFO - [mozharness: 2016-11-22 11:41:22.377221Z] Finished install step (success) 03:41:22 INFO - [mozharness: 2016-11-22 11:41:22.377555Z] Running run-tests step. 03:41:22 INFO - Running pre-action listener: _resource_record_pre_action 03:41:22 INFO - Running main action method: run_tests 03:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:22 INFO - Python 2.7.3 03:41:22 INFO - Return code: 0 03:41:22 INFO - grabbing minidump binary from tooltool 03:41: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')]} 03:41: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 0x1e1af60>, '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 0x1e1bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41: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 03:41: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 03:41: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 03:41:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:22 INFO - Return code: 0 03:41:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 03:41:22 INFO - Using env: {'DISPLAY': ':0', 03:41:22 INFO - 'HOME': '/home/cltbld', 03:41:22 INFO - 'LANG': 'en_US.UTF-8', 03:41:22 INFO - 'LANGUAGE': 'en_US:en', 03:41:22 INFO - 'LOGNAME': 'cltbld', 03:41:22 INFO - 'MAIL': '/var/mail/cltbld', 03:41:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:22 INFO - 'MOZ_NO_REMOTE': '1', 03:41:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:22 INFO - 'NO_EM_RESTART': '1', 03:41:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:22 INFO - 'PWD': '/builds/slave/test', 03:41:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:22 INFO - 'SHELL': '/bin/bash', 03:41:22 INFO - 'SHLVL': '1', 03:41:22 INFO - 'TERM': 'linux', 03:41:22 INFO - 'TMOUT': '86400', 03:41:22 INFO - 'USER': 'cltbld', 03:41:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277', 03:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:22 INFO - '_': '/tools/buildbot/bin/python'} 03:41:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:41:22 INFO - mozversion application_buildid: 20161122004020 03:41:22 INFO - mozversion application_changeset: 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb 03:41:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:22 INFO - mozversion application_name: Firefox 03:41:22 INFO - mozversion application_remotingname: firefox-dev 03:41:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:22 INFO - mozversion application_vendor: Mozilla 03:41:22 INFO - mozversion application_version: 52.0a2 03:41:22 INFO - mozversion platform_buildid: 20161122004020 03:41:22 INFO - mozversion platform_changeset: 0b59b8da8f7566f70eb2ac013e60192d1d1c6adb 03:41:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:22 INFO - mozversion platform_version: 52.0a2 03:41:22 INFO - using testdate: 1479814882 03:41:22 INFO - actual date: 1479814882 03:41:22 INFO - starting webserver on 'localhost:41240' 03:41:22 INFO - SUITE-START | Running 2 tests 03:41:22 INFO - TEST-START | dromaeo_css 03:41:22 INFO - operating with platform_type : linux_ 03:41:22 INFO - Initialising browser for dromaeo_css test... 03:41:22 INFO - TEST-INFO | started process 7035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCOUl8/profile http://localhost:41240/getInfo.html) 03:41:25 ERROR - PROCESS | 7035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 03:41:27 INFO - PROCESS | 7035 | __metrics Screen width/height:1600/1200 03:41:27 INFO - PROCESS | 7035 | colorDepth:24 03:41:27 INFO - PROCESS | 7035 | Browser inner width/height: 1024/697 03:41:27 INFO - PROCESS | 7035 | __metrics 03:41:27 ERROR - PROCESS | 7035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:41:28 INFO - TEST-INFO | 7035: exit 0 03:41:28 INFO - Browser initialized. 03:41:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:28 INFO - TEST-INFO | started process 7166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCOUl8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:40 INFO - PROCESS | 7166 | RSS: Main: 151945216 03:41:40 INFO - PROCESS | 7166 | 03:42:30 INFO - PROCESS | 7166 | 1479814950027 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:44:40 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41240/tests/dromaeo/cssquery-ext.html) 03:44:42 INFO - PROCESS | 7166 | RSS: Main: 157253632 03:44:42 INFO - PROCESS | 7166 | 03:47:43 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-ext.html (next: http://localhost:41240/tests/dromaeo/cssquery-jquery.html) 03:47:44 INFO - PROCESS | 7166 | RSS: Main: 152698880 03:47:44 INFO - PROCESS | 7166 | 03:50:46 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41240/tests/dromaeo/cssquery-mootools.html) 03:50:47 INFO - PROCESS | 7166 | RSS: Main: 152854528 03:50:47 INFO - PROCESS | 7166 | 03:53:48 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41240/tests/dromaeo/cssquery-prototype.html) 03:53:49 INFO - PROCESS | 7166 | RSS: Main: 152281088 03:53:49 INFO - PROCESS | 7166 | 03:56:51 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41240/tests/dromaeo/cssquery-yui.html) 03:56:52 INFO - PROCESS | 7166 | RSS: Main: 154120192 03:56:52 INFO - PROCESS | 7166 | 03:59:54 INFO - PROCESS | 7166 | Cycle 1(1): loaded http://localhost:41240/tests/dromaeo/cssquery-yui.html (next: http://localhost:41240/tests/dromaeo/cssquery-dojo.html) 03:59:55 INFO - PROCESS | 7166 | RSS: Main: 156065792 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | __start_tp_report 03:59:55 INFO - PROCESS | 7166 | _x_x_mozilla_page_load 03:59:55 INFO - PROCESS | 7166 | _x_x_mozilla_page_load_details 03:59:55 INFO - PROCESS | 7166 | |i|pagename|runs| 03:59:55 INFO - PROCESS | 7166 | |0;dojo.html;3349.4305967985442;3398.7281017518603;3407.335569563935;3414.743894207932;3425.640307767684;5748.080307150852;5771;5801.941980580193;5806.042003069499;5818.098194779811;5618.859528511779;5708.800191993281;5709.77160913564;5725.341585717643;5747.051736463479;5226.111561034624;5228.633995620289;5265.736713164346;5276.3668359796875;5285.867853303679;5233.921491177635;5236.895262094756;5266.420693723688;5271.815486457975;5304.496072873071;5185.870353241162;5211.973940130294;5254.185601231815;5279;5293.126634105368;5235.764390602432;5256.500632439912;5320.65415747979;5322.2548843161985;5372.731363431852;5194.22086687;5265.052290587692;5283.022640811462;5284.445133261029;5303.443138470482;5603.3836278009385;5752.309722833245;5785.797497087624;5848.824535263949;5857.062869940832;6007.849803754897;6031;6034.818955431344;6059.969700151471;6108.602940808878;6140.0789881517685;6142.385761423822;6150.630962142286;6183.5884005237995;6223.782167624111;5768.7980920668;5777.566682498829;5780.653160810322;5784.219130417424;5804.59367844251;6103.755849765959;6125.356837532084;6135.01831721223;6175.907361389583;6192.102145188923;5930.466258036711;5939.940600594025;5957.523398128139;5963.373845746221;5964.850878728066;6016.2479690038745;6057.697115144313;6060.454559089615;6061.121137435047;6074.453299203093;5942.494887934487;5986.461218490357;6015.248093988252;6030.939690603038;6105.8473538161015;6034.09488576717;6043;6050.42520960508;6080.878382432326;6101.938980610226;4583.266677331678;4689.577937985529;4709.317149013374;4710.29345598163;4731.4795372509;4122.0107174278555;4139.855105071308;4155.709100362946;4197.076643138505;4265.97867010663;5850.912236316373;5872;5892.882142357214;5934.584579079423;5975.223220981245;6087.756489740449;6108.694565271808;6155.353687862799;6160.414760597736;6164.383561643889;5695.601307908407;5713.457221563945;5860.238169037998;5876.588638795329;5904.114382842608;5282.31329927107;5293.391260005149;5300.390455097636;5302.09864323066;5319.734013299397;6341.143945567289;6356.237251529846;6370.936290637127;6397.168368112116;6400.51996100285;6090.817275481742;6111.694415279308;6123.069106197319;6125.326214116532;6169.074638804215;6401.743930242738;6431.646259455775;6453.741850325934;6464.515161362822;6479.4816414685765;6080.300765411857;6087.817365479043;6100.786472473442;6102.0541816018585;6104.145419641342;5871.1486834409625;5941.910871336847;6066.666333351708;6176.722047507783;6189.319174890848;5909.409059094056;5992.790252341147;6010.9699451502465;6055.909161362495;6057;5986.521078313637;5999.100134979788;6004.42957918997;6008.068749343859;6020.367861374668;5746.080627099644;5797.884042319214;5939.376365481562;5948.672822994604;5954.7320370582565;5974.850628734316;5980.461758441761;5996.790112346047;6006.129111278928;6018.518518518596;5832.066869300891;5842.2405087338375;5864.501517371071;5880.529557635465;5894.793682221101 03:59:55 INFO - PROCESS | 7166 | |1;ext.html;580.2775544447164;610.5756499233032;642.6786606696652;652.6508318049841;684.8390628202375;43688.34467482987;44374.44689435866;44736.776316118456;47377.52622473774;47622.76188619052;44018;44109.558904410944;44195.558044419544;44218;44686;8757.781055473632;8803.823923521526;8823.426477278956;8873.290136789074;8892.244159246471;8724.956375218115;8731.650733970633;8744.256738177231;8810.955945220265;8822.206001459866;8801.647934082628;8806.295496360275;8860.291176705849;8875.423097498675;8909.821803563926;8771.868421973675;8775.605097770616;8822.779430514256;8838.160374764419;8845.292376609856;8736.825263494695;8825.867611985825;8834.293256539526;8837.955810220908;8868.201861832402;42271.1545769086;42302.36546451806;42506.36240456396;42564.148717025484;42653.78673106646;3430.9828450857835;3502.159481724393;3514.525539052246;3518.964810351915;3550.6271841456532;32642.347153056806;32733.83633081843;32768.83615581931;32880.67119328824;34144.48783268253;4493.887652808673;4504.346869703907;4506.324051392317;4521.321801729767;4535.886602834922;343391;344211;345593;346425;347634;56767.71616141893;56993.43006569881;57190.42809571934;57299.42700573024;57474.7126264366;60388.396116039155;60456.39543604507;60621;60809.695951520844;60972.69513652403;15693.450729224422;15903.920480397755;16046.197690115447;16066.598335041717;16073.357065717475;11222.55109795599;11247.156463265288;11249.325040497597;11264.94367528157;11305.321680699184;15404;16244.675106497803;16263.837361626469;16321.347146114022;16328.591785205228;5806.390329015477;5863.442972917566;5963.403659634088;6021.9051045289625;6085.5189223476855;967.3422072990434;1016.6289304403839;1052.4053909541237;1092.8852470490483;1112.6620139581257;31978.68021319757;32091.197720057186;32236.355272894412;32311.838440808115;32532.349353012807;1078.8112080385902;1103.6964834670368;1111.9833202501968;1141.2581821815886;1195.318668359027;16233.918830405772;17130.229139688745;17226.569335766457;17503.73744393835;17580.824191757918;569394;572169;572400;573283;574692;44867.32699009518;44909.32636010463;45047.774761125984;45185.54814451879;45849.08301833944;1337.8461476930083;1359.327133069137;1382.8271466066742;1390.0547627613523;1393.0875276693782;30870.228244294074;31483.527747083353;32082.679173208904;32164.356712865145;32523.18692032718;51143.744281278356;51846;51954;52004;52150.21774673307;482301;484157;485138;488197;488326;29142.854285728437;29360.41279174362;29361.265968350963;29834.701652983193;29840.10479685613;47621.52378476171;47669.52330476651;48199.277010845566;48542.27186592275;48744.2688359682;40186.79906600565;40378.59621403748;41223.793881030404;42109;42125.789371052946;41760;41976.59220532266;42065.57934420739;42281.32059767785;42803.35794963016;40905.59094409018;41381.37927931023;41795.582044179166;41832.3725144117;41870;35217.295654087284;37016.62983370132;37166.47389622363;37316.25367492689;37482.437763434114;28324.291892702848;28361.43277134487;28399.85800071069;28484;28492 03:59:55 INFO - PROCESS | 7166 | |2;jquery.html;428.49865657181095;428.86490755412024;437.245751079388;440.4324967761134;446.62483513848343;19104;20468.590628187427;20925.581488370244;21071.47321316968;21269.893650531765;17828.841125326846;17886.28454861804;17904.731429028543;18066.096695165255;18100;5360.544353729938;5488.91766623501;5511.724413779295;5522.22688823565;5523.143912693539;5424.674519528821;5449.3188351456065;5477.20580515825;5494.835154945358;5635.3237611486675;5841.8831623367505;5878.647281163123;5887.293524777033;5897.4692277695;5899.675517846516;5628;5864.6187997780435;5869.618474799125;5876.9118463223085;5892.852678683024;5807.680577568232;5811.360750317462;5823.650580965155;5827.125931110325;5831.9416805831825;13364;13491.257980811051;13645.727085458335;13859.099158554762;13936.372863221079;2428.9271321860374;2472.7403622619727;2540.8983640654537;2689.865506724656;2760.4617099665575;10115.848262276071;10270.435126068063;10364.067233948981;10636.30863993838;10997.945010274978;2028.4320390290743;2057.19769289977;2074.782147874482;2093.455701517601;2124.968125478119;86689.56655216747;90256.09743902543;90931.54534227353;91436;93303;11554.826677599844;12035.819462708067;12067.939660301818;12083.335416551998;12365.134440589072;17414.912925435292;17433.12834358277;17445.82554174442;17447.825521744875;17477.563060923578;8024.830192074098;8378.036525799489;8506.829863402698;8569.871451928226;8623.698170564001;7899;8166.510009399455;8186.918130818615;8314;8350.62422191003;5040.647154699209;5126.615503837153;5165.974170129125;5214.869628259324;5294.126469132627;2067.638163321413;2129.4995676016124;2147.860389074705;2175.856781070676;2227.721534808149;955.4028732042474;1022.9641962531275;1036.2746077745608;1050.810854046279;1076.4617691154422;19490.415287541397;20410;20480.180792768122;20491.38525844227;20661.896690516453;987.1954357199004;994.9602015919427;1020.6529779874878;1021.6883850425692;1023.4626820919077;10726.678199654023;11423.257488263236;11474.598389056342;11518.481668324945;11683.299002059903;465651;473138;477702;481217;482597;99820.50089749505;102869;104937.47531262448;105202;106430.46784766181;1020.7039958411978;1063.771289172816;1064.7657515346611;1076.5627886771092;1077.1329080090602;18219.362322318655;18599.53501162482;18626.720599191292;18759.624807504046;18797.68625544428;43218.35172472353;44644.33033504565;45234.32148517709;46076.539234608565;46241.53758462507;63519.6824015877;64272.67863660652;64645.67677161584;65005;65803;8008.439409241297;8592.570371481526;8909.376343655882;9053.321000924825;9159.542022898962;12525.812112818132;14204.644883877985;14263.714725705635;14483.348249329016;14492.927535362256;12273.447694853932;12652.493900243888;12653.620391387905;12667.619971400873;12691.492340306284;7290.817729556804;8597.796308516938;12011.579594714143;12412.317322547347;12471;11743.88256117428;11975;12330.075244356529;12874.935625322189;13113.278769667379;8490.490570565786;8557.786055348666;8607.967043954766;8612.48325100496;8828.161324674145;12546.560870369492;12555.183913045623;12751.17117387404;12777.105602607728;12777.297248651414 03:59:55 INFO - PROCESS | 7166 | |3;mootools.html;1504.7291487532243;1536.1474381718147;1681.8234085421032;1783.9821601783979;1808.620189760151;8235.299999500035;8494.40539162259;8769.429987050846;9303.813923721522;9332.720018399443;8600.91399086009;8881.333899957497;8902.421342612726;9107.134822191898;9118.042605526423;2513.8868750906254;2563.218218443374;2569.524637941987;2578.445634188649;2593.1701855406277;2513.49730053989;2565.8203925725206;2581.9612705809427;2586.030238660502;2591.235585502272;2494.052260141144;2497.5379554782335;2501.8123640726926;2519.395345117168;2521.319243804181;2364.255259593231;2377.2036367816804;2383.809295256384;2397.0771253067696;2411.0958390603523;2408.903643854244;2424.5029768897334;2440.9267721968367;2444.9022039118413;2445.5231229910173;9083.909160908439;9086.909130908673;9096.226820720181;9147.451152930846;9161.267098632094;5485.807996720096;5741.282339707536;5745.368009518949;5768.6250393724695;5800.24596802413;3678.4850120983083;3744.1949980754;3787.5265591801026;3818.4654148419245;3843.5003449551377;1142.3374442823142;1143.1654891928938;1170.5259369955181;1201.7296108375633;1232.975340493185;12933.805992910115;13032.218066916015;13091.214527128403;13141.211527308296;13174.86825131746;4826.831060912921;5073.467285934998;5147.845564633067;5258.07983602868;5278.947210527922;10943.781124377469;11032.393218373067;11051.281666691639;11082.944585277184;11109.388983605979;5803.82588522345;5813.7383817728305;5819;5838.562107841929;5866.677332746654;4591.517890621503;4981.950180498221;5174.172132458789;5217.843464696065;5259.815906443333;4267.615914567704;4283.293256612624;4371.125774845043;4399.956000440018;4432.29083346663;1417.6243295526695;1420.2614640386942;1440.7694768836936;1461.1306272767686;1467.486379767073;811.3387589114852;818.7625588579245;879.7228872905015;925.0194793518891;975.5561219645186;5936.940630593639;5937.317208520989;5959.64242145464;5960.225170727777;6248.968755156195;948.2271948362063;957.8084383123403;962.9085236902483;974.7027156717269;982.749398903275;3860.9806950965067;4036.3340048891605;4040.919181616351;4068.532118806316;4085.7344272622186;11588.76822463546;11884.227525210834;12005.63983080509;12011.099167562468;12013.579524716593;11732.530698772125;11815.11386646005;11830.112741544419;11883.10876684252;11899.16705830601;8397.244248017707;8713.651453941771;8733.912660873437;8880.289576833839;8890.377673562789;5857.560682948882;5977.282726072899;6055.878882422415;6095.146679464967;6276.497880169667;10528.578856845641;10703.946480267548;10722.142228621535;10766.73083172927;10816.837747433952;10698.518566664363;10756.354618722902;10815.459227038775;10860.131189504978;10932.781344373227;7223.205447400676;7827;8033.718819841278;8170.387220958571;8332.583370831555;9034.864477032981;9071.591778369857;9078.636854525745;9098.272138229058;9120.859892513436;8108.067572229269;8152;8162.510249385056;8183.468074575134;8198.508089514648;7791.5325080493085;7845.686172553034;7907.683692652229;8062.959685201537;8126.228008339198;7033.542819716702;7205.387542058774;7242.02232698579;7284.235155308828;7286.963565182352;5260.421353651019;5292.259083728358;5303.098473259478;5417.783288668409;5431.402545720047;5085.160948443466;5131.409887862795;5197.584193264605;5201.843944681666;5276.314079169837 03:59:55 INFO - PROCESS | 7166 | |4;prototype.html;357.15710922223553;360.18957345971563;361.87696183297675;363.1792149741584;365.31868066056796;5615.775368985246;5635.436456354362;5653.575981801366;5654.378018417976;5680.289963754531;5529.0324193266215;5543.556515478762;5546.417626149247;5603.80386686466;5608.859778505539;4246.405503229543;4365.908522869283;4366.607005369516;4386.583274588925;4414.4923333816705;4377.102693947733;4406.383106365111;4407.889802754925;4414.889627759299;4420.270655341865;4343.457067866517;4355.738655680653;4370.5410931852175;4387.978060109695;4390.121975604876;4134.772587507671;4317.84887528935;4343.804528796211;4370.803313850868;4378.233809083397;3843.7501562398356;3854.5181852268465;3858.3633700439395;3862.9613703862883;3872.6901847852387;5408.4050754416985;5418;5450.618456708032;5483.958047970873;5490.780368785284;4875.780589873464;4933.901321973576;4959.429665588431;4966.652334336598;5004.699718016931;5828.621139625953;5839.503642190419;5841.707914604252;5855.506845754348;5865.472107510344;4192.11965487248;4197.622214000755;4216.409702641633;4225.936610950807;4233.153369326147;5874.97062514689;5911.9113213301835;6052.425019623129;6075.33171351151;6121.326654068004;4235.830566777356;4240.257954857888;4254.553271906467;4254.936175957363;4261.659067274611;4292.7424354538825;4293.549177336397;4297.871063868089;4301.462317210348;4314;4866.513348665105;4917.877053073702;4945.208766597327;4958.181899986534;4991.151504244287;5868.413158684098;5869;5870.618409803435;5880.235569375954;5894.440028197314;1440.5678296511005;1444.50886698523;1448.4351103069812;1453.774664926938;1459.737247295497;954.2413781044087;996.2030375699411;999.3104757717152;1011.7875246198381;1014.2342531388902;5552.86117847049;5580.4330008195875;5589.043834657838;5613.063493094875;5616.494515493625;5865.178874957509;5890;5894.764209431574;5898.8820223595285;5899.76400943966;5381.78472861089;5582.310858878562;5586.826766379106;5605.271314729141;5660.943390566042;3052.916554280193;3076.8769249230227;3090.3201295714907;3120.422721796475;3123.3909387669187;5939.524838012949;6051.641339056866;6104.511639068864;6112.724927378279;6117;5832.358440571618;5846.444587764156;5917.822465326047;5919.668074683248;5946.910796338058;6011.595361855293;6031.004884194059;6052.12244224585;6054.3945605439985;6096;5551.22282880389;5721.645110244696;5733.509287585174;5780.5953583248765;5782.45066718661;5693.402192769865;5747;5756.625819321731;5756.971215143897;5763.827085187451;6061.969690151697;6064.241969753781;6293.772714320664;6312.968435157794;6333.556651034568;4263.850765223202;4335.371371151228;4342.544032876503;4343.478782546114;4367.3885656008815;5823.417658234142;6083.908741368795;6101.420365065312;6118.195132436031;6128.601640893327;5937.179839576167;5943.613665111754;5945.583809133492;5946.851328716643;5953.839001394686;5902.498287645427;5921.61509501881;5922.60818707612;5934.6735929522565;5958.288978514679;5717.828465145886;5834.737436815439;5858.179854820243;5891.675957822361;5904.350521442724;5876.41235876409;5894.734736936934;5943.632964418121;5955.731992060281;5967.403259674172;5683.914741278802;5797.0724783983815;5825.184474173534;5830;5832.600175957825 03:59:55 INFO - PROCESS | 7166 | |5;yui.html;796.7889405695051;820.2535692519805;843.9282660973817;868.179570306061;886.2068448738378;14966.102033877962;15092.320845561948;15211.771823422658;15396.538103856888;15574.14342211178;14529.491467798629;14769.852301476982;14782.408703651841;14792.482263120766;14824.036437631574;828.8300898315846;865.0441262405046;876.7808047988003;878.1701292278799;878.6046279174365;831.8627426474625;853.2193043365313;866.9523176225305;872.0538216035609;874.9737507874773;919.0350132361027;924.36219008884;926.735880274122;932.9720108396759;934.8083642853198;916.839553078212;917.1882883647986;919.7700574856286;920.0569416348296;922.2760133295398;675.8952362383839;677.7661706711177;679.3308591037824;679.49038221334;680.7038938061959;14520.636984075378;14529.78205326921;14708.852911470854;14737.705245895022;15192.924035379863;12764.361781910868;13467.595972120853;13558.389872455664;13625.25061121638;14078.436862525588;11194.888051119466;11374.431278436128;11413.258138221072;11476.770464590662;11768.529258829636;3332.866685332584;3336.51620515024;3339.0650617827046;3410.3179364127272;3487.668671476206;64084.3591564083;64321.67839160821;64618.353816461706;65431.67284163549;66812;9991.350562213433;10092.848607270897;10229.897701023043;10315.381077135396;10383.013613706686;19416.514587135436;19435;19514.31699890497;19588.412347629594;19599.412017639494;7974.641141148662;8045.798855028554;8194.795130121676;8250.051244106884;8299.875501867476;4714.787834547454;4736.668433209711;4746.264329029006;4771.188897887368;4884.95115048852;3669.2661467706566;3755.342815007363;3756.1736417988;3788.1666033472593;3788.7726736395903;637.9170707808048;638.7987783848073;645.7287939065603;666.0542030316961;667.6194569095666;647.0391468669022;736.9263073692588;762.8855671649186;767.7619937819294;787.3779714025856;9026.593803278869;9036.8644470333;9116.954415228014;9432.726581911491;9470.987638968312;663.2902794010363;751.2412463411994;788.5820515126992;809.6478032056075;809.6923169195668;4142.668586513072;4227.387028880795;4299.849505267363;4335.349697545394;4343.131373725204;73779.63110184415;74471;77412.61293693609;82771;90505;46285.76857115693;61371.69314153401;62710.0593491098;73427.26572734311;74414.25585744073;56407.15389269246;65503.344966549725;68596.31403685999;68885.65557172282;69409.65295173491;8109.878351824846;9298.907010929805;9957.153641940517;10004.549795259376;10034.548445319831;41938.37092443677;43023.56976430196;44115;45011.774941125084;46830;54763;58159;63037;64202.67898660477;65789.67105164443;12278.263304201777;12706.555270565486;12749.298788566717;13021.218726876417;13034.739305214032;13654.317284135555;13987.580372588838;14586.85413145855;14777.408903643734;14913.179775112472;13010.716761334143;13289.80065299002;13298.933505332412;13354.599362019155;13507.545086492737;13345.66635834112;13506.189628622315;13689.726205476034;13833.239171845646;14932.402703891723;12298.938505307417;12416.255024698547;12429.614181438856;12564;12948.417321220379;10926.399048052433;10979.835302470628;11188.832167517656;11295.096392288762;11558.248713833575;11175.385353805294;11225.270357427067;11453.427328633701;11599.304041757521;11625.941870290595 03:59:55 INFO - PROCESS | 7166 | __end_tp_report 03:59:55 INFO - PROCESS | 7166 | __start_cc_report 03:59:55 INFO - PROCESS | 7166 | _x_x_mozilla_cycle_collect,308 03:59:55 INFO - PROCESS | 7166 | __end_cc_report 03:59:55 INFO - PROCESS | 7166 | __startTimestamp1479815995109__endTimestamp 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | ------- Summary: start ------- 03:59:55 INFO - PROCESS | 7166 | Number of tests: 6 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#0] dojo.html Cycles:165 Average:5698.91 Median:5930.47 stddev:625.71 (10.6%) stddev-sans-first:599.87 03:59:55 INFO - PROCESS | 7166 | Values: 3349.4 3398.7 3407.3 3414.7 3425.6 5748.1 5771.0 5801.9 5806.0 5818.1 5618.9 5708.8 5709.8 5725.3 5747.1 5226.1 5228.6 5265.7 5276.4 5285.9 5233.9 5236.9 5266.4 5271.8 5304.5 5185.9 5212.0 5254.2 5279.0 5293.1 5235.8 5256.5 5320.7 5322.3 5372.7 5194.2 5265.1 5283.0 5284.4 5303.4 5603.4 5752.3 5785.8 5848.8 5857.1 6007.8 6031.0 6034.8 6060.0 6108.6 6140.1 6142.4 6150.6 6183.6 6223.8 5768.8 5777.6 5780.7 5784.2 5804.6 6103.8 6125.4 6135.0 6175.9 6192.1 5930.5 5939.9 5957.5 5963.4 5964.9 6016.2 6057.7 6060.5 6061.1 6074.5 5942.5 5986.5 6015.2 6030.9 6105.8 6034.1 6043.0 6050.4 6080.9 6101.9 4583.3 4689.6 4709.3 4710.3 4731.5 4122.0 4139.9 4155.7 4197.1 4266.0 5850.9 5872.0 5892.9 5934.6 5975.2 6087.8 6108.7 6155.4 6160.4 6164.4 5695.6 5713.5 5860.2 5876.6 5904.1 5282.3 5293.4 5300.4 5302.1 5319.7 6341.1 6356.2 6370.9 6397.2 6400.5 6090.8 6111.7 6123.1 6125.3 6169.1 6401.7 6431.6 6453.7 6464.5 6479.5 6080.3 6087.8 6100.8 6102.1 6104.1 5871.1 5941.9 6066.7 6176.7 6189.3 5909.4 5992.8 6011.0 6055.9 6057.0 5986.5 5999.1 6004.4 6008.1 6020.4 5746.1 5797.9 5939.4 5948.7 5954.7 5974.9 5980.5 5996.8 6006.1 6018.5 5832.1 5842.2 5864.5 5880.5 5894.8 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#1] ext.html Cycles:180 Average:62170.65 Median:42535.26 stddev:126873.31 (298.3%) stddev-sans-first:127144.95 03:59:55 INFO - PROCESS | 7166 | Values: 580.3 610.6 642.7 652.7 684.8 43688.3 44374.4 44736.8 47377.5 47622.8 44018.0 44109.6 44195.6 44218.0 44686.0 8757.8 8803.8 8823.4 8873.3 8892.2 8725.0 8731.7 8744.3 8811.0 8822.2 8801.6 8806.3 8860.3 8875.4 8909.8 8771.9 8775.6 8822.8 8838.2 8845.3 8736.8 8825.9 8834.3 8838.0 8868.2 42271.2 42302.4 42506.4 42564.1 42653.8 3431.0 3502.2 3514.5 3519.0 3550.6 32642.3 32733.8 32768.8 32880.7 34144.5 4493.9 4504.3 4506.3 4521.3 4535.9 343391.0 344211.0 345593.0 346425.0 347634.0 56767.7 56993.4 57190.4 57299.4 57474.7 60388.4 60456.4 60621.0 60809.7 60972.7 15693.5 15903.9 16046.2 16066.6 16073.4 11222.6 11247.2 11249.3 11264.9 11305.3 15404.0 16244.7 16263.8 16321.3 16328.6 5806.4 5863.4 5963.4 6021.9 6085.5 967.3 1016.6 1052.4 1092.9 1112.7 31978.7 32091.2 32236.4 32311.8 32532.3 1078.8 1103.7 1112.0 1141.3 1195.3 16233.9 17130.2 17226.6 17503.7 17580.8 569394.0 572169.0 572400.0 573283.0 574692.0 44867.3 44909.3 45047.8 45185.5 45849.1 1337.8 1359.3 1382.8 1390.1 1393.1 30870.2 31483.5 32082.7 32164.4 32523.2 51143.7 51846.0 51954.0 52004.0 52150.2 482301.0 484157.0 485138.0 488197.0 488326.0 29142.9 29360.4 29361.3 29834.7 29840.1 47621.5 47669.5 48199.3 48542.3 48744.3 40186.8 40378.6 41223.8 42109.0 42125.8 41760.0 41976.6 42065.6 42281.3 42803.4 40905.6 41381.4 41795.6 41832.4 41870.0 35217.3 37016.6 37166.5 37316.3 37482.4 28324.3 28361.4 28399.9 28484.0 28492.0 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#2] jquery.html Cycles:180 Average:29521.55 Median:2138.68 stddev:79129.92 (3699.9%) stddev-sans-first:79321.75 03:59:55 INFO - PROCESS | 7166 | Values: 428.5 428.9 437.2 440.4 446.6 19104.0 20468.6 20925.6 21071.5 21269.9 17828.8 17886.3 17904.7 18066.1 18100.0 5360.5 5488.9 5511.7 5522.2 5523.1 5424.7 5449.3 5477.2 5494.8 5635.3 5841.9 5878.6 5887.3 5897.5 5899.7 5628.0 5864.6 5869.6 5876.9 5892.9 5807.7 5811.4 5823.7 5827.1 5831.9 13364.0 13491.3 13645.7 13859.1 13936.4 2428.9 2472.7 2540.9 2689.9 2760.5 10115.8 10270.4 10364.1 10636.3 10997.9 2028.4 2057.2 2074.8 2093.5 2125.0 86689.6 90256.1 90931.5 91436.0 93303.0 11554.8 12035.8 12067.9 12083.3 12365.1 17414.9 17433.1 17445.8 17447.8 17477.6 8024.8 8378.0 8506.8 8569.9 8623.7 7899.0 8166.5 8186.9 8314.0 8350.6 5040.6 5126.6 5166.0 5214.9 5294.1 2067.6 2129.5 2147.9 2175.9 2227.7 955.4 1023.0 1036.3 1050.8 1076.5 19490.4 20410.0 20480.2 20491.4 20661.9 987.2 995.0 1020.7 1021.7 1023.5 10726.7 11423.3 11474.6 11518.5 11683.3 465651.0 473138.0 477702.0 481217.0 482597.0 99820.5 102869.0 104937.5 105202.0 106430.5 1020.7 1063.8 1064.8 1076.6 1077.1 18219.4 18599.5 18626.7 18759.6 18797.7 43218.4 44644.3 45234.3 46076.5 46241.5 63519.7 64272.7 64645.7 65005.0 65803.0 8008.4 8592.6 8909.4 9053.3 9159.5 12525.8 14204.6 14263.7 14483.3 14492.9 12273.4 12652.5 12653.6 12667.6 12691.5 7290.8 8597.8 12011.6 12412.3 12471.0 11743.9 11975.0 12330.1 12874.9 13113.3 8490.5 8557.8 8608.0 8612.5 8828.2 12546.6 12555.2 12751.2 12777.1 12777.3 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#3] mootools.html Cycles:180 Average:6119.06 Median:5139.63 stddev:3493.88 (68.0%) stddev-sans-first:3486.48 03:59:55 INFO - PROCESS | 7166 | Values: 1504.7 1536.1 1681.8 1784.0 1808.6 8235.3 8494.4 8769.4 9303.8 9332.7 8600.9 8881.3 8902.4 9107.1 9118.0 2513.9 2563.2 2569.5 2578.4 2593.2 2513.5 2565.8 2582.0 2586.0 2591.2 2494.1 2497.5 2501.8 2519.4 2521.3 2364.3 2377.2 2383.8 2397.1 2411.1 2408.9 2424.5 2440.9 2444.9 2445.5 9083.9 9086.9 9096.2 9147.5 9161.3 5485.8 5741.3 5745.4 5768.6 5800.2 3678.5 3744.2 3787.5 3818.5 3843.5 1142.3 1143.2 1170.5 1201.7 1233.0 12933.8 13032.2 13091.2 13141.2 13174.9 4826.8 5073.5 5147.8 5258.1 5278.9 10943.8 11032.4 11051.3 11082.9 11109.4 5803.8 5813.7 5819.0 5838.6 5866.7 4591.5 4982.0 5174.2 5217.8 5259.8 4267.6 4283.3 4371.1 4400.0 4432.3 1417.6 1420.3 1440.8 1461.1 1467.5 811.3 818.8 879.7 925.0 975.6 5936.9 5937.3 5959.6 5960.2 6249.0 948.2 957.8 962.9 974.7 982.7 3861.0 4036.3 4040.9 4068.5 4085.7 11588.8 11884.2 12005.6 12011.1 12013.6 11732.5 11815.1 11830.1 11883.1 11899.2 8397.2 8713.7 8733.9 8880.3 8890.4 5857.6 5977.3 6055.9 6095.1 6276.5 10528.6 10703.9 10722.1 10766.7 10816.8 10698.5 10756.4 10815.5 10860.1 10932.8 7223.2 7827.0 8033.7 8170.4 8332.6 9034.9 9071.6 9078.6 9098.3 9120.9 8108.1 8152.0 8162.5 8183.5 8198.5 7791.5 7845.7 7907.7 8063.0 8126.2 7033.5 7205.4 7242.0 7284.2 7287.0 5260.4 5292.3 5303.1 5417.8 5431.4 5085.2 5131.4 5197.6 5201.8 5276.3 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#4] prototype.html Cycles:180 Average:4910.47 Median:5614.42 stddev:1439.67 (25.6%) stddev-sans-first:1402.56 03:59:55 INFO - PROCESS | 7166 | Values: 357.2 360.2 361.9 363.2 365.3 5615.8 5635.4 5653.6 5654.4 5680.3 5529.0 5543.6 5546.4 5603.8 5608.9 4246.4 4365.9 4366.6 4386.6 4414.5 4377.1 4406.4 4407.9 4414.9 4420.3 4343.5 4355.7 4370.5 4388.0 4390.1 4134.8 4317.8 4343.8 4370.8 4378.2 3843.8 3854.5 3858.4 3863.0 3872.7 5408.4 5418.0 5450.6 5484.0 5490.8 4875.8 4933.9 4959.4 4966.7 5004.7 5828.6 5839.5 5841.7 5855.5 5865.5 4192.1 4197.6 4216.4 4225.9 4233.2 5875.0 5911.9 6052.4 6075.3 6121.3 4235.8 4240.3 4254.6 4254.9 4261.7 4292.7 4293.5 4297.9 4301.5 4314.0 4866.5 4917.9 4945.2 4958.2 4991.2 5868.4 5869.0 5870.6 5880.2 5894.4 1440.6 1444.5 1448.4 1453.8 1459.7 954.2 996.2 999.3 1011.8 1014.2 5552.9 5580.4 5589.0 5613.1 5616.5 5865.2 5890.0 5894.8 5898.9 5899.8 5381.8 5582.3 5586.8 5605.3 5660.9 3052.9 3076.9 3090.3 3120.4 3123.4 5939.5 6051.6 6104.5 6112.7 6117.0 5832.4 5846.4 5917.8 5919.7 5946.9 6011.6 6031.0 6052.1 6054.4 6096.0 5551.2 5721.6 5733.5 5780.6 5782.5 5693.4 5747.0 5756.6 5757.0 5763.8 6062.0 6064.2 6293.8 6313.0 6333.6 4263.9 4335.4 4342.5 4343.5 4367.4 5823.4 6083.9 6101.4 6118.2 6128.6 5937.2 5943.6 5945.6 5946.9 5953.8 5902.5 5921.6 5922.6 5934.7 5958.3 5717.8 5834.7 5858.2 5891.7 5904.4 5876.4 5894.7 5943.6 5955.7 5967.4 5683.9 5797.1 5825.2 5830.0 5832.6 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - PROCESS | 7166 | [#5] yui.html Cycles:180 Average:17186.33 Median:46557.88 stddev:21889.99 (47.0%) stddev-sans-first:21916.80 03:59:55 INFO - PROCESS | 7166 | Values: 796.8 820.3 843.9 868.2 886.2 14966.1 15092.3 15211.8 15396.5 15574.1 14529.5 14769.9 14782.4 14792.5 14824.0 828.8 865.0 876.8 878.2 878.6 831.9 853.2 867.0 872.1 875.0 919.0 924.4 926.7 933.0 934.8 916.8 917.2 919.8 920.1 922.3 675.9 677.8 679.3 679.5 680.7 14520.6 14529.8 14708.9 14737.7 15192.9 12764.4 13467.6 13558.4 13625.3 14078.4 11194.9 11374.4 11413.3 11476.8 11768.5 3332.9 3336.5 3339.1 3410.3 3487.7 64084.4 64321.7 64618.4 65431.7 66812.0 9991.4 10092.8 10229.9 10315.4 10383.0 19416.5 19435.0 19514.3 19588.4 19599.4 7974.6 8045.8 8194.8 8250.1 8299.9 4714.8 4736.7 4746.3 4771.2 4885.0 3669.3 3755.3 3756.2 3788.2 3788.8 637.9 638.8 645.7 666.1 667.6 647.0 736.9 762.9 767.8 787.4 9026.6 9036.9 9117.0 9432.7 9471.0 663.3 751.2 788.6 809.6 809.7 4142.7 4227.4 4299.8 4335.3 4343.1 73779.6 74471.0 77412.6 82771.0 90505.0 46285.8 61371.7 62710.1 73427.3 74414.3 56407.2 65503.3 68596.3 68885.7 69409.7 8109.9 9298.9 9957.2 10004.5 10034.5 41938.4 43023.6 44115.0 45011.8 46830.0 54763.0 58159.0 63037.0 64202.7 65789.7 12278.3 12706.6 12749.3 13021.2 13034.7 13654.3 13987.6 14586.9 14777.4 14913.2 13010.7 13289.8 13298.9 13354.6 13507.5 13345.7 13506.2 13689.7 13833.2 14932.4 12298.9 12416.3 12429.6 12564.0 12948.4 10926.4 10979.8 11188.8 11295.1 11558.2 11175.4 11225.3 11453.4 11599.3 11625.9 03:59:55 INFO - PROCESS | 7166 | -------- Summary: end -------- 03:59:55 INFO - PROCESS | 7166 | 03:59:55 INFO - TEST-INFO | 7166: exit 0 03:59:55 INFO - TEST-OK | dromaeo_css | took 1113198ms 03:59:55 INFO - TEST-START | kraken 03:59:55 INFO - operating with platform_type : linux_ 03:59:55 INFO - Initialising browser for kraken test... 03:59:55 INFO - TEST-INFO | started process 7543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrfmfr/profile http://localhost:41240/getInfo.html) 03:59:58 ERROR - PROCESS | 7543 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 04:00:00 INFO - PROCESS | 7543 | __metrics Screen width/height:1600/1200 04:00:00 INFO - PROCESS | 7543 | colorDepth:24 04:00:00 INFO - PROCESS | 7543 | Browser inner width/height: 1024/697 04:00:00 INFO - PROCESS | 7543 | __metrics 04:00:00 ERROR - PROCESS | 7543 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 04:00:01 INFO - TEST-INFO | 7543: exit 0 04:00:01 INFO - Browser initialized. 04:00:01 INFO - Running cycle 1/1 for kraken test... 04:00:01 INFO - TEST-INFO | started process 7674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxrfmfr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:13 INFO - PROCESS | 7674 | RSS: Main: 151822336 04:00:13 INFO - PROCESS | 7674 | 04:00:16 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41240/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:16 INFO - PROCESS | 7674 | RSS: Main: 157011968 04:00:16 INFO - PROCESS | 7674 | 04:00:19 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41240/tests/kraken/driver.html?testName=audio-dft) 04:00:20 INFO - PROCESS | 7674 | RSS: Main: 155041792 04:00:20 INFO - PROCESS | 7674 | 04:00:23 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41240/tests/kraken/driver.html?testName=audio-fft) 04:00:23 INFO - PROCESS | 7674 | RSS: Main: 155717632 04:00:23 INFO - PROCESS | 7674 | 04:00:25 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41240/tests/kraken/driver.html?testName=audio-oscillator) 04:00:26 INFO - PROCESS | 7674 | RSS: Main: 155455488 04:00:26 INFO - PROCESS | 7674 | 04:00:28 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:29 INFO - PROCESS | 7674 | RSS: Main: 155521024 04:00:29 INFO - PROCESS | 7674 | 04:00:32 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41240/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:32 INFO - PROCESS | 7674 | RSS: Main: 157679616 04:00:32 INFO - PROCESS | 7674 | 04:00:36 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41240/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:36 INFO - PROCESS | 7674 | RSS: Main: 158064640 04:00:36 INFO - PROCESS | 7674 | 04:00:39 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41240/tests/kraken/driver.html?testName=json-parse-financial) 04:00:39 INFO - PROCESS | 7674 | RSS: Main: 158220288 04:00:39 INFO - PROCESS | 7674 | 04:00:41 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:42 INFO - PROCESS | 7674 | RSS: Main: 157794304 04:00:42 INFO - PROCESS | 7674 | 04:00:43 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:44 INFO - PROCESS | 7674 | RSS: Main: 157777920 04:00:44 INFO - PROCESS | 7674 | 04:00:46 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:47 INFO - PROCESS | 7674 | RSS: Main: 157790208 04:00:47 INFO - PROCESS | 7674 | 04:00:49 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:50 INFO - PROCESS | 7674 | RSS: Main: 158154752 04:00:50 INFO - PROCESS | 7674 | 04:00:53 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:53 INFO - PROCESS | 7674 | RSS: Main: 158650368 04:00:53 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | Cycle 1(1): loaded http://localhost:41240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41240/tests/kraken/driver.html?testName=ai-astar) 04:00:55 INFO - PROCESS | 7674 | RSS: Main: 159776768 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | __start_tp_report 04:00:55 INFO - PROCESS | 7674 | _x_x_mozilla_page_load 04:00:55 INFO - PROCESS | 7674 | _x_x_mozilla_page_load_details 04:00:55 INFO - PROCESS | 7674 | |i|pagename|runs| 04:00:55 INFO - PROCESS | 7674 | |0;ai-astar;103;112;114;113;113;112;112;113;111;111 04:00:55 INFO - PROCESS | 7674 | |1;audio-beat-detection;148;124;124;163;131;127;127;125;158;131 04:00:55 INFO - PROCESS | 7674 | |2;audio-dft;161;165;163;160;162;162;161;164;168;162 04:00:55 INFO - PROCESS | 7674 | |3;audio-fft;76;76;76;106;77;76;77;75;101;75 04:00:55 INFO - PROCESS | 7674 | |4;audio-oscillator;82;81;117;82;82;82;96;82;82;105 04:00:55 INFO - PROCESS | 7674 | |5;imaging-gaussian-blur;117;118;118;117;117;118;118;117;117;120 04:00:55 INFO - PROCESS | 7674 | |6;imaging-darkroom;147;148;149;147;146;146;149;147;147;150 04:00:55 INFO - PROCESS | 7674 | |7;imaging-desaturate;85;85;85;85;86;86;90;85;85;86 04:00:55 INFO - PROCESS | 7674 | |8;json-parse-financial;51;56;53;52;52;55;52;51;51;53 04:00:55 INFO - PROCESS | 7674 | |9;json-stringify-tinderbox;59;60;59;59;60;60;60;59;60;60 04:00:55 INFO - PROCESS | 7674 | |10;stanford-crypto-aes;76;84;76;78;76;83;74;76;76;74 04:00:55 INFO - PROCESS | 7674 | |11;stanford-crypto-ccm;131;128;128;130;126;138;128;140;170;126 04:00:55 INFO - PROCESS | 7674 | |12;stanford-crypto-pbkdf2;156;159;159;154;154;157;156;160;156;156 04:00:55 INFO - PROCESS | 7674 | |13;stanford-crypto-sha256-iterative;62;63;63;67;61;62;62;61;62;61 04:00:55 INFO - PROCESS | 7674 | __end_tp_report 04:00:55 INFO - PROCESS | 7674 | __start_cc_report 04:00:55 INFO - PROCESS | 7674 | _x_x_mozilla_cycle_collect,792 04:00:55 INFO - PROCESS | 7674 | __end_cc_report 04:00:55 INFO - PROCESS | 7674 | __startTimestamp1479816055686__endTimestamp 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | ------- Summary: start ------- 04:00:55 INFO - PROCESS | 7674 | Number of tests: 14 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 04:00:55 INFO - PROCESS | 7674 | Values: 103.0 112.0 114.0 113.0 113.0 112.0 112.0 113.0 111.0 111.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:131.00 stddev:14.82 (11.3%) stddev-sans-first:15.05 04:00:55 INFO - PROCESS | 7674 | Values: 148.0 124.0 124.0 163.0 131.0 127.0 127.0 125.0 158.0 131.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.35 (1.4%) stddev-sans-first:2.40 04:00:55 INFO - PROCESS | 7674 | Values: 161.0 165.0 163.0 160.0 162.0 162.0 161.0 164.0 168.0 162.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.67 (15.4%) stddev-sans-first:12.21 04:00:55 INFO - PROCESS | 7674 | Values: 76.0 76.0 76.0 106.0 77.0 76.0 77.0 75.0 101.0 75.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:12.68 (15.5%) stddev-sans-first:13.19 04:00:55 INFO - PROCESS | 7674 | Values: 82.0 81.0 117.0 82.0 82.0 82.0 96.0 82.0 82.0 105.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 04:00:55 INFO - PROCESS | 7674 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 120.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 04:00:55 INFO - PROCESS | 7674 | Values: 147.0 148.0 149.0 147.0 146.0 146.0 149.0 147.0 147.0 150.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:1.55 (1.8%) stddev-sans-first:1.62 04:00:55 INFO - PROCESS | 7674 | Values: 85.0 85.0 85.0 85.0 86.0 86.0 90.0 85.0 85.0 86.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.71 (3.3%) stddev-sans-first:1.72 04:00:55 INFO - PROCESS | 7674 | Values: 51.0 56.0 53.0 52.0 52.0 55.0 52.0 51.0 51.0 53.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:00:55 INFO - PROCESS | 7674 | Values: 59.0 60.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.00 stddev:3.47 (4.6%) stddev-sans-first:3.64 04:00:55 INFO - PROCESS | 7674 | Values: 76.0 84.0 76.0 78.0 76.0 83.0 74.0 76.0 76.0 74.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:130.50 stddev:13.36 (10.2%) stddev-sans-first:14.11 04:00:55 INFO - PROCESS | 7674 | Values: 131.0 128.0 128.0 130.0 126.0 138.0 128.0 140.0 170.0 126.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.50 stddev:2.06 (1.3%) stddev-sans-first:2.17 04:00:55 INFO - PROCESS | 7674 | Values: 156.0 159.0 159.0 154.0 154.0 157.0 156.0 160.0 156.0 156.0 04:00:55 INFO - PROCESS | 7674 | 04:00:55 INFO - PROCESS | 7674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.78 (2.9%) stddev-sans-first:1.88 04:00:55 INFO - PROCESS | 7674 | Values: 62.0 63.0 63.0 67.0 61.0 62.0 62.0 61.0 62.0 61.0 04:00:55 INFO - PROCESS | 7674 | -------- Summary: end -------- 04:00:55 INFO - PROCESS | 7674 | 04:00:56 INFO - TEST-INFO | 7674: exit 0 04:00:56 INFO - TEST-OK | kraken | took 60834ms 04:00:56 INFO - SUITE-END | took 1174s 04:00:56 INFO - Completed test suite (00:19:34) 04:00:56 INFO - javascript benchmark 04:00:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7433.24245209789, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.4305967985442, 3398.7281017518603, 3407.335569563935, 3414.743894207932, 3425.640307767684, 5748.080307150852, 5771.0, 5801.941980580193, 5806.042003069499, 5818.098194779811, 5618.859528511779, 5708.800191993281, 5709.77160913564, 5725.341585717643, 5747.051736463479, 5226.111561034624, 5228.633995620289, 5265.736713164346, 5276.3668359796875, 5285.867853303679, 5233.921491177635, 5236.895262094756, 5266.420693723688, 5271.815486457975, 5304.496072873071, 5185.870353241162, 5211.973940130294, 5254.185601231815, 5279.0, 5293.126634105368, 5235.764390602432, 5256.500632439912, 5320.65415747979, 5322.2548843161985, 5372.731363431852, 5194.22086687, 5265.052290587692, 5283.022640811462, 5284.445133261029, 5303.443138470482, 5603.3836278009385, 5752.309722833245, 5785.797497087624, 5848.824535263949, 5857.062869940832, 6007.849803754897, 6031.0, 6034.818955431344, 6059.969700151471, 6108.602940808878, 6140.0789881517685, 6142.385761423822, 6150.630962142286, 6183.5884005237995, 6223.782167624111, 5768.7980920668, 5777.566682498829, 5780.653160810322, 5784.219130417424, 5804.59367844251, 6103.755849765959, 6125.356837532084, 6135.01831721223, 6175.907361389583, 6192.102145188923, 5930.466258036711, 5939.940600594025, 5957.523398128139, 5963.373845746221, 5964.850878728066, 6016.2479690038745, 6057.697115144313, 6060.454559089615, 6061.121137435047, 6074.453299203093, 5942.494887934487, 5986.461218490357, 6015.248093988252, 6030.939690603038, 6105.8473538161015, 6034.09488576717, 6043.0, 6050.42520960508, 6080.878382432326, 6101.938980610226, 4583.266677331678, 4689.577937985529, 4709.317149013374, 4710.29345598163, 4731.4795372509, 4122.0107174278555, 4139.855105071308, 4155.709100362946, 4197.076643138505, 4265.97867010663, 5850.912236316373, 5872.0, 5892.882142357214, 5934.584579079423, 5975.223220981245, 6087.756489740449, 6108.694565271808, 6155.353687862799, 6160.414760597736, 6164.383561643889, 5695.601307908407, 5713.457221563945, 5860.238169037998, 5876.588638795329, 5904.114382842608, 5282.31329927107, 5293.391260005149, 5300.390455097636, 5302.09864323066, 5319.734013299397, 6341.143945567289, 6356.237251529846, 6370.936290637127, 6397.168368112116, 6400.51996100285, 6090.817275481742, 6111.694415279308, 6123.069106197319, 6125.326214116532, 6169.074638804215, 6401.743930242738, 6431.646259455775, 6453.741850325934, 6464.515161362822, 6479.4816414685765, 6080.300765411857, 6087.817365479043, 6100.786472473442, 6102.0541816018585, 6104.145419641342, 5871.1486834409625, 5941.910871336847, 6066.666333351708, 6176.722047507783, 6189.319174890848, 5909.409059094056, 5992.790252341147, 6010.9699451502465, 6055.909161362495, 6057.0, 5986.521078313637, 5999.100134979788, 6004.42957918997, 6008.068749343859, 6020.367861374668, 5746.080627099644, 5797.884042319214, 5939.376365481562, 5948.672822994604, 5954.7320370582565, 5974.850628734316, 5980.461758441761, 5996.790112346047, 6006.129111278928, 6018.518518518596, 5832.066869300891, 5842.2405087338375, 5864.501517371071, 5880.529557635465, 5894.793682221101], "value": 5658.141034020266, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2775544447164, 610.5756499233032, 642.6786606696652, 652.6508318049841, 684.8390628202375, 43688.34467482987, 44374.44689435866, 44736.776316118456, 47377.52622473774, 47622.76188619052, 44018.0, 44109.558904410944, 44195.558044419544, 44218.0, 44686.0, 8757.781055473632, 8803.823923521526, 8823.426477278956, 8873.290136789074, 8892.244159246471, 8724.956375218115, 8731.650733970633, 8744.256738177231, 8810.955945220265, 8822.206001459866, 8801.647934082628, 8806.295496360275, 8860.291176705849, 8875.423097498675, 8909.821803563926, 8771.868421973675, 8775.605097770616, 8822.779430514256, 8838.160374764419, 8845.292376609856, 8736.825263494695, 8825.867611985825, 8834.293256539526, 8837.955810220908, 8868.201861832402, 42271.1545769086, 42302.36546451806, 42506.36240456396, 42564.148717025484, 42653.78673106646, 3430.9828450857835, 3502.159481724393, 3514.525539052246, 3518.964810351915, 3550.6271841456532, 32642.347153056806, 32733.83633081843, 32768.83615581931, 32880.67119328824, 34144.48783268253, 4493.887652808673, 4504.346869703907, 4506.324051392317, 4521.321801729767, 4535.886602834922, 343391.0, 344211.0, 345593.0, 346425.0, 347634.0, 56767.71616141893, 56993.43006569881, 57190.42809571934, 57299.42700573024, 57474.7126264366, 60388.396116039155, 60456.39543604507, 60621.0, 60809.695951520844, 60972.69513652403, 15693.450729224422, 15903.920480397755, 16046.197690115447, 16066.598335041717, 16073.357065717475, 11222.55109795599, 11247.156463265288, 11249.325040497597, 11264.94367528157, 11305.321680699184, 15404.0, 16244.675106497803, 16263.837361626469, 16321.347146114022, 16328.591785205228, 5806.390329015477, 5863.442972917566, 5963.403659634088, 6021.9051045289625, 6085.5189223476855, 967.3422072990434, 1016.6289304403839, 1052.4053909541237, 1092.8852470490483, 1112.6620139581257, 31978.68021319757, 32091.197720057186, 32236.355272894412, 32311.838440808115, 32532.349353012807, 1078.8112080385902, 1103.6964834670368, 1111.9833202501968, 1141.2581821815886, 1195.318668359027, 16233.918830405772, 17130.229139688745, 17226.569335766457, 17503.73744393835, 17580.824191757918, 569394.0, 572169.0, 572400.0, 573283.0, 574692.0, 44867.32699009518, 44909.32636010463, 45047.774761125984, 45185.54814451879, 45849.08301833944, 1337.8461476930083, 1359.327133069137, 1382.8271466066742, 1390.0547627613523, 1393.0875276693782, 30870.228244294074, 31483.527747083353, 32082.679173208904, 32164.356712865145, 32523.18692032718, 51143.744281278356, 51846.0, 51954.0, 52004.0, 52150.21774673307, 482301.0, 484157.0, 485138.0, 488197.0, 488326.0, 29142.854285728437, 29360.41279174362, 29361.265968350963, 29834.701652983193, 29840.10479685613, 47621.52378476171, 47669.52330476651, 48199.277010845566, 48542.27186592275, 48744.2688359682, 40186.79906600565, 40378.59621403748, 41223.793881030404, 42109.0, 42125.789371052946, 41760.0, 41976.59220532266, 42065.57934420739, 42281.32059767785, 42803.35794963016, 40905.59094409018, 41381.37927931023, 41795.582044179166, 41832.3725144117, 41870.0, 35217.295654087284, 37016.62983370132, 37166.47389622363, 37316.25367492689, 37482.437763434114, 28324.291892702848, 28361.43277134487, 28399.85800071069, 28484.0, 28492.0], "value": 19944.774399507234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.49865657181095, 428.86490755412024, 437.245751079388, 440.4324967761134, 446.62483513848343, 19104.0, 20468.590628187427, 20925.581488370244, 21071.47321316968, 21269.893650531765, 17828.841125326846, 17886.28454861804, 17904.731429028543, 18066.096695165255, 18100.0, 5360.544353729938, 5488.91766623501, 5511.724413779295, 5522.22688823565, 5523.143912693539, 5424.674519528821, 5449.3188351456065, 5477.20580515825, 5494.835154945358, 5635.3237611486675, 5841.8831623367505, 5878.647281163123, 5887.293524777033, 5897.4692277695, 5899.675517846516, 5628.0, 5864.6187997780435, 5869.618474799125, 5876.9118463223085, 5892.852678683024, 5807.680577568232, 5811.360750317462, 5823.650580965155, 5827.125931110325, 5831.9416805831825, 13364.0, 13491.257980811051, 13645.727085458335, 13859.099158554762, 13936.372863221079, 2428.9271321860374, 2472.7403622619727, 2540.8983640654537, 2689.865506724656, 2760.4617099665575, 10115.848262276071, 10270.435126068063, 10364.067233948981, 10636.30863993838, 10997.945010274978, 2028.4320390290743, 2057.19769289977, 2074.782147874482, 2093.455701517601, 2124.968125478119, 86689.56655216747, 90256.09743902543, 90931.54534227353, 91436.0, 93303.0, 11554.826677599844, 12035.819462708067, 12067.939660301818, 12083.335416551998, 12365.134440589072, 17414.912925435292, 17433.12834358277, 17445.82554174442, 17447.825521744875, 17477.563060923578, 8024.830192074098, 8378.036525799489, 8506.829863402698, 8569.871451928226, 8623.698170564001, 7899.0, 8166.510009399455, 8186.918130818615, 8314.0, 8350.62422191003, 5040.647154699209, 5126.615503837153, 5165.974170129125, 5214.869628259324, 5294.126469132627, 2067.638163321413, 2129.4995676016124, 2147.860389074705, 2175.856781070676, 2227.721534808149, 955.4028732042474, 1022.9641962531275, 1036.2746077745608, 1050.810854046279, 1076.4617691154422, 19490.415287541397, 20410.0, 20480.180792768122, 20491.38525844227, 20661.896690516453, 987.1954357199004, 994.9602015919427, 1020.6529779874878, 1021.6883850425692, 1023.4626820919077, 10726.678199654023, 11423.257488263236, 11474.598389056342, 11518.481668324945, 11683.299002059903, 465651.0, 473138.0, 477702.0, 481217.0, 482597.0, 99820.50089749505, 102869.0, 104937.47531262448, 105202.0, 106430.46784766181, 1020.7039958411978, 1063.771289172816, 1064.7657515346611, 1076.5627886771092, 1077.1329080090602, 18219.362322318655, 18599.53501162482, 18626.720599191292, 18759.624807504046, 18797.68625544428, 43218.35172472353, 44644.33033504565, 45234.32148517709, 46076.539234608565, 46241.53758462507, 63519.6824015877, 64272.67863660652, 64645.67677161584, 65005.0, 65803.0, 8008.439409241297, 8592.570371481526, 8909.376343655882, 9053.321000924825, 9159.542022898962, 12525.812112818132, 14204.644883877985, 14263.714725705635, 14483.348249329016, 14492.927535362256, 12273.447694853932, 12652.493900243888, 12653.620391387905, 12667.619971400873, 12691.492340306284, 7290.817729556804, 8597.796308516938, 12011.579594714143, 12412.317322547347, 12471.0, 11743.88256117428, 11975.0, 12330.075244356529, 12874.935625322189, 13113.278769667379, 8490.490570565786, 8557.786055348666, 8607.967043954766, 8612.48325100496, 8828.161324674145, 12546.560870369492, 12555.183913045623, 12751.17117387404, 12777.105602607728, 12777.297248651414], "value": 9508.27520223371, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.7291487532243, 1536.1474381718147, 1681.8234085421032, 1783.9821601783979, 1808.620189760151, 8235.299999500035, 8494.40539162259, 8769.429987050846, 9303.813923721522, 9332.720018399443, 8600.91399086009, 8881.333899957497, 8902.421342612726, 9107.134822191898, 9118.042605526423, 2513.8868750906254, 2563.218218443374, 2569.524637941987, 2578.445634188649, 2593.1701855406277, 2513.49730053989, 2565.8203925725206, 2581.9612705809427, 2586.030238660502, 2591.235585502272, 2494.052260141144, 2497.5379554782335, 2501.8123640726926, 2519.395345117168, 2521.319243804181, 2364.255259593231, 2377.2036367816804, 2383.809295256384, 2397.0771253067696, 2411.0958390603523, 2408.903643854244, 2424.5029768897334, 2440.9267721968367, 2444.9022039118413, 2445.5231229910173, 9083.909160908439, 9086.909130908673, 9096.226820720181, 9147.451152930846, 9161.267098632094, 5485.807996720096, 5741.282339707536, 5745.368009518949, 5768.6250393724695, 5800.24596802413, 3678.4850120983083, 3744.1949980754, 3787.5265591801026, 3818.4654148419245, 3843.5003449551377, 1142.3374442823142, 1143.1654891928938, 1170.5259369955181, 1201.7296108375633, 1232.975340493185, 12933.805992910115, 13032.218066916015, 13091.214527128403, 13141.211527308296, 13174.86825131746, 4826.831060912921, 5073.467285934998, 5147.845564633067, 5258.07983602868, 5278.947210527922, 10943.781124377469, 11032.393218373067, 11051.281666691639, 11082.944585277184, 11109.388983605979, 5803.82588522345, 5813.7383817728305, 5819.0, 5838.562107841929, 5866.677332746654, 4591.517890621503, 4981.950180498221, 5174.172132458789, 5217.843464696065, 5259.815906443333, 4267.615914567704, 4283.293256612624, 4371.125774845043, 4399.956000440018, 4432.29083346663, 1417.6243295526695, 1420.2614640386942, 1440.7694768836936, 1461.1306272767686, 1467.486379767073, 811.3387589114852, 818.7625588579245, 879.7228872905015, 925.0194793518891, 975.5561219645186, 5936.940630593639, 5937.317208520989, 5959.64242145464, 5960.225170727777, 6248.968755156195, 948.2271948362063, 957.8084383123403, 962.9085236902483, 974.7027156717269, 982.749398903275, 3860.9806950965067, 4036.3340048891605, 4040.919181616351, 4068.532118806316, 4085.7344272622186, 11588.76822463546, 11884.227525210834, 12005.63983080509, 12011.099167562468, 12013.579524716593, 11732.530698772125, 11815.11386646005, 11830.112741544419, 11883.10876684252, 11899.16705830601, 8397.244248017707, 8713.651453941771, 8733.912660873437, 8880.289576833839, 8890.377673562789, 5857.560682948882, 5977.282726072899, 6055.878882422415, 6095.146679464967, 6276.497880169667, 10528.578856845641, 10703.946480267548, 10722.142228621535, 10766.73083172927, 10816.837747433952, 10698.518566664363, 10756.354618722902, 10815.459227038775, 10860.131189504978, 10932.781344373227, 7223.205447400676, 7827.0, 8033.718819841278, 8170.387220958571, 8332.583370831555, 9034.864477032981, 9071.591778369857, 9078.636854525745, 9098.272138229058, 9120.859892513436, 8108.067572229269, 8152.0, 8162.510249385056, 8183.468074575134, 8198.508089514648, 7791.5325080493085, 7845.686172553034, 7907.683692652229, 8062.959685201537, 8126.228008339198, 7033.542819716702, 7205.387542058774, 7242.02232698579, 7284.235155308828, 7286.963565182352, 5260.421353651019, 5292.259083728358, 5303.098473259478, 5417.783288668409, 5431.402545720047, 5085.160948443466, 5131.409887862795, 5197.584193264605, 5201.843944681666, 5276.314079169837], "value": 4889.901288272339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.15710922223553, 360.18957345971563, 361.87696183297675, 363.1792149741584, 365.31868066056796, 5615.775368985246, 5635.436456354362, 5653.575981801366, 5654.378018417976, 5680.289963754531, 5529.0324193266215, 5543.556515478762, 5546.417626149247, 5603.80386686466, 5608.859778505539, 4246.405503229543, 4365.908522869283, 4366.607005369516, 4386.583274588925, 4414.4923333816705, 4377.102693947733, 4406.383106365111, 4407.889802754925, 4414.889627759299, 4420.270655341865, 4343.457067866517, 4355.738655680653, 4370.5410931852175, 4387.978060109695, 4390.121975604876, 4134.772587507671, 4317.84887528935, 4343.804528796211, 4370.803313850868, 4378.233809083397, 3843.7501562398356, 3854.5181852268465, 3858.3633700439395, 3862.9613703862883, 3872.6901847852387, 5408.4050754416985, 5418.0, 5450.618456708032, 5483.958047970873, 5490.780368785284, 4875.780589873464, 4933.901321973576, 4959.429665588431, 4966.652334336598, 5004.699718016931, 5828.621139625953, 5839.503642190419, 5841.707914604252, 5855.506845754348, 5865.472107510344, 4192.11965487248, 4197.622214000755, 4216.409702641633, 4225.936610950807, 4233.153369326147, 5874.97062514689, 5911.9113213301835, 6052.425019623129, 6075.33171351151, 6121.326654068004, 4235.830566777356, 4240.257954857888, 4254.553271906467, 4254.936175957363, 4261.659067274611, 4292.7424354538825, 4293.549177336397, 4297.871063868089, 4301.462317210348, 4314.0, 4866.513348665105, 4917.877053073702, 4945.208766597327, 4958.181899986534, 4991.151504244287, 5868.413158684098, 5869.0, 5870.618409803435, 5880.235569375954, 5894.440028197314, 1440.5678296511005, 1444.50886698523, 1448.4351103069812, 1453.774664926938, 1459.737247295497, 954.2413781044087, 996.2030375699411, 999.3104757717152, 1011.7875246198381, 1014.2342531388902, 5552.86117847049, 5580.4330008195875, 5589.043834657838, 5613.063493094875, 5616.494515493625, 5865.178874957509, 5890.0, 5894.764209431574, 5898.8820223595285, 5899.76400943966, 5381.78472861089, 5582.310858878562, 5586.826766379106, 5605.271314729141, 5660.943390566042, 3052.916554280193, 3076.8769249230227, 3090.3201295714907, 3120.422721796475, 3123.3909387669187, 5939.524838012949, 6051.641339056866, 6104.511639068864, 6112.724927378279, 6117.0, 5832.358440571618, 5846.444587764156, 5917.822465326047, 5919.668074683248, 5946.910796338058, 6011.595361855293, 6031.004884194059, 6052.12244224585, 6054.3945605439985, 6096.0, 5551.22282880389, 5721.645110244696, 5733.509287585174, 5780.5953583248765, 5782.45066718661, 5693.402192769865, 5747.0, 5756.625819321731, 5756.971215143897, 5763.827085187451, 6061.969690151697, 6064.241969753781, 6293.772714320664, 6312.968435157794, 6333.556651034568, 4263.850765223202, 4335.371371151228, 4342.544032876503, 4343.478782546114, 4367.3885656008815, 5823.417658234142, 6083.908741368795, 6101.420365065312, 6118.195132436031, 6128.601640893327, 5937.179839576167, 5943.613665111754, 5945.583809133492, 5946.851328716643, 5953.839001394686, 5902.498287645427, 5921.61509501881, 5922.60818707612, 5934.6735929522565, 5958.288978514679, 5717.828465145886, 5834.737436815439, 5858.179854820243, 5891.675957822361, 5904.350521442724, 5876.41235876409, 5894.734736936934, 5943.632964418121, 5955.731992060281, 5967.403259674172, 5683.914741278802, 5797.0724783983815, 5825.184474173534, 5830.0, 5832.600175957825], "value": 4452.802073415748, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.7889405695051, 820.2535692519805, 843.9282660973817, 868.179570306061, 886.2068448738378, 14966.102033877962, 15092.320845561948, 15211.771823422658, 15396.538103856888, 15574.14342211178, 14529.491467798629, 14769.852301476982, 14782.408703651841, 14792.482263120766, 14824.036437631574, 828.8300898315846, 865.0441262405046, 876.7808047988003, 878.1701292278799, 878.6046279174365, 831.8627426474625, 853.2193043365313, 866.9523176225305, 872.0538216035609, 874.9737507874773, 919.0350132361027, 924.36219008884, 926.735880274122, 932.9720108396759, 934.8083642853198, 916.839553078212, 917.1882883647986, 919.7700574856286, 920.0569416348296, 922.2760133295398, 675.8952362383839, 677.7661706711177, 679.3308591037824, 679.49038221334, 680.7038938061959, 14520.636984075378, 14529.78205326921, 14708.852911470854, 14737.705245895022, 15192.924035379863, 12764.361781910868, 13467.595972120853, 13558.389872455664, 13625.25061121638, 14078.436862525588, 11194.888051119466, 11374.431278436128, 11413.258138221072, 11476.770464590662, 11768.529258829636, 3332.866685332584, 3336.51620515024, 3339.0650617827046, 3410.3179364127272, 3487.668671476206, 64084.3591564083, 64321.67839160821, 64618.353816461706, 65431.67284163549, 66812.0, 9991.350562213433, 10092.848607270897, 10229.897701023043, 10315.381077135396, 10383.013613706686, 19416.514587135436, 19435.0, 19514.31699890497, 19588.412347629594, 19599.412017639494, 7974.641141148662, 8045.798855028554, 8194.795130121676, 8250.051244106884, 8299.875501867476, 4714.787834547454, 4736.668433209711, 4746.264329029006, 4771.188897887368, 4884.95115048852, 3669.2661467706566, 3755.342815007363, 3756.1736417988, 3788.1666033472593, 3788.7726736395903, 637.9170707808048, 638.7987783848073, 645.7287939065603, 666.0542030316961, 667.6194569095666, 647.0391468669022, 736.9263073692588, 762.8855671649186, 767.7619937819294, 787.3779714025856, 9026.593803278869, 9036.8644470333, 9116.954415228014, 9432.726581911491, 9470.987638968312, 663.2902794010363, 751.2412463411994, 788.5820515126992, 809.6478032056075, 809.6923169195668, 4142.668586513072, 4227.387028880795, 4299.849505267363, 4335.349697545394, 4343.131373725204, 73779.63110184415, 74471.0, 77412.61293693609, 82771.0, 90505.0, 46285.76857115693, 61371.69314153401, 62710.0593491098, 73427.26572734311, 74414.25585744073, 56407.15389269246, 65503.344966549725, 68596.31403685999, 68885.65557172282, 69409.65295173491, 8109.878351824846, 9298.907010929805, 9957.153641940517, 10004.549795259376, 10034.548445319831, 41938.37092443677, 43023.56976430196, 44115.0, 45011.774941125084, 46830.0, 54763.0, 58159.0, 63037.0, 64202.67898660477, 65789.67105164443, 12278.263304201777, 12706.555270565486, 12749.298788566717, 13021.218726876417, 13034.739305214032, 13654.317284135555, 13987.580372588838, 14586.85413145855, 14777.408903643734, 14913.179775112472, 13010.716761334143, 13289.80065299002, 13298.933505332412, 13354.599362019155, 13507.545086492737, 13345.66635834112, 13506.189628622315, 13689.726205476034, 13833.239171845646, 14932.402703891723, 12298.938505307417, 12416.255024698547, 12429.614181438856, 12564.0, 12948.417321220379, 10926.399048052433, 10979.835302470628, 11188.832167517656, 11295.096392288762, 11558.248713833575, 11175.385353805294, 11225.270357427067, 11453.427328633701, 11599.304041757521, 11625.941870290595], "value": 7219.24071342986, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 114.0, 113.0, 113.0, 112.0, 112.0, 113.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 124.0, 163.0, 131.0, 127.0, 127.0, 125.0, 158.0, 131.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 163.0, 160.0, 162.0, 162.0, 161.0, 164.0, 168.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 77.0, 76.0, 77.0, 75.0, 101.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 82.0, 82.0, 82.0, 96.0, 82.0, 82.0, 105.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 146.0, 146.0, 149.0, 147.0, 147.0, 150.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 86.0, 90.0, 85.0, 85.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 56.0, 53.0, 52.0, 52.0, 55.0, 52.0, 51.0, 51.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 76.0, 78.0, 76.0, 83.0, 74.0, 76.0, 76.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 128.0, 130.0, 126.0, 138.0, 128.0, 140.0, 170.0, 126.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 159.0, 154.0, 154.0, 157.0, 156.0, 160.0, 156.0, 156.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 67.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.4, "unit": "score"}]}]} 04:00:56 INFO - Return code: 0 04:00:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:57 ERROR - # TBPL SUCCESS # 04:00:57 INFO - Running post-action listener: _resource_record_post_action 04:00:57 INFO - [mozharness: 2016-11-22 12:00:57.027011Z] Finished run-tests step (success) 04:00:57 INFO - Running post-run listener: _resource_record_post_run 04:00:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 365666304; Read time: 32; Write time: 213728 04:00:57 INFO - TinderboxPrint: CPU usage
13.3% 04:00:57 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 04:00:57 INFO - TinderboxPrint: I/O write bytes / time
365,666,304 / 213,728 04:00:57 INFO - TinderboxPrint: CPU idle
8,228.4 (86.7%) 04:00:57 INFO - TinderboxPrint: CPU user
1,206.6 (12.7%) 04:00:57 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108122112; Read time: 0; Write time: 92792 04:00:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246132736; Read time: 12; Write time: 117588 04:00:57 INFO - Running post-run listener: _upload_blobber_files 04:00:57 INFO - Blob upload gear active. 04:00:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:57 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 04:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:01 INFO - (blobuploader) - INFO - Done attempting. 04:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:01:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:02 INFO - (blobuploader) - INFO - Done attempting. 04:01:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:01:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:01:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:03 INFO - (blobuploader) - INFO - Done attempting. 04:01:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:03 INFO - Return code: 0 04:01:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88f687695a138dc0881f8581bf89911cc5900c4b3930a0468ee70adbc8c5df8388c859a44dc4ee31821cc6f990e1cd668a4bc51ace65078b93ab50f280d405b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22b75a50d79fc54f19463f85b4f1175b83b01902b09a8a74209145aed7f578b1b00a138a8fd147d834d4a9a366d64c5532c9abab203ec6e42b542e1d75a6a27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4043df62d2b6e51c1e187f2fac29db63fd468ea713e9b56b294bd10fc53dac26344e468a52e0ca7f6bfb5699c86ae4b1397d4cc4a9ac3dec92f63464c19e8460"} 04:01:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:03 INFO - Contents: 04:01:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88f687695a138dc0881f8581bf89911cc5900c4b3930a0468ee70adbc8c5df8388c859a44dc4ee31821cc6f990e1cd668a4bc51ace65078b93ab50f280d405b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22b75a50d79fc54f19463f85b4f1175b83b01902b09a8a74209145aed7f578b1b00a138a8fd147d834d4a9a366d64c5532c9abab203ec6e42b542e1d75a6a27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4043df62d2b6e51c1e187f2fac29db63fd468ea713e9b56b294bd10fc53dac26344e468a52e0ca7f6bfb5699c86ae4b1397d4cc4a9ac3dec92f63464c19e8460"} 04:01:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:03 INFO - Copying logs to upload dir... 04:01:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.027684 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-22 04:01:03.177545) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 04:01:03.180978) ========= 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=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88f687695a138dc0881f8581bf89911cc5900c4b3930a0468ee70adbc8c5df8388c859a44dc4ee31821cc6f990e1cd668a4bc51ace65078b93ab50f280d405b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22b75a50d79fc54f19463f85b4f1175b83b01902b09a8a74209145aed7f578b1b00a138a8fd147d834d4a9a366d64c5532c9abab203ec6e42b542e1d75a6a27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4043df62d2b6e51c1e187f2fac29db63fd468ea713e9b56b294bd10fc53dac26344e468a52e0ca7f6bfb5699c86ae4b1397d4cc4a9ac3dec92f63464c19e8460"} build_url:https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011684 build_url: 'https://queue.taskcluster.net/v1/task/dyb2ucb8QnGmeagr3oYTBA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c88f687695a138dc0881f8581bf89911cc5900c4b3930a0468ee70adbc8c5df8388c859a44dc4ee31821cc6f990e1cd668a4bc51ace65078b93ab50f280d405b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b22b75a50d79fc54f19463f85b4f1175b83b01902b09a8a74209145aed7f578b1b00a138a8fd147d834d4a9a366d64c5532c9abab203ec6e42b542e1d75a6a27", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4043df62d2b6e51c1e187f2fac29db63fd468ea713e9b56b294bd10fc53dac26344e468a52e0ca7f6bfb5699c86ae4b1397d4cc4a9ac3dec92f63464c19e8460"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 04:01:03.212717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:01:03.213360) ========= 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=8887e36bb8e381bfd44124ac000001a8-1479814827.396033-1150639277 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 04:01:03.296791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 04:01:03.297415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 04:01:03.297994) ========= ========= Total master_lag: 0.18 =========