builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1478547523.92 results: success (0) buildid: 20161107100027 builduid: e4631074dc6d45fbaf9f28f002de049d revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:43.922587) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:43.923056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:43.923358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:43.938666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:43.939146) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-07 11:38:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-11-07 11:38:43 (39.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081549 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.037605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.038154) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015381 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.090523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.091032) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --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 a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --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=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-07 11:38:44,091 truncating revision to first 12 chars 2016-11-07 11:38:44,091 Setting DEBUG logging. 2016-11-07 11:38:44,091 attempt 1/10 2016-11-07 11:38:44,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a1243da2fec4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 11:38:44,529 unpacking tar archive at: mozilla-aurora-a1243da2fec4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.768675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.876778) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.877615) ========= script_repo_revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.878613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.879421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 11:38:44.890530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-07 11:38:44.891484) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:44 INFO - MultiFileLogger online at 20161107 11:38:44 in /builds/slave/test 11:38:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:38:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:44 INFO - {'append_to_log': False, 11:38:44 INFO - 'base_work_dir': '/builds/slave/test', 11:38:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:38:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:44 INFO - 'branch': 'Mozilla-Aurora', 11:38:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:44 INFO - 'config_files': ('talos/linux_config.py',), 11:38:44 INFO - 'default_actions': ('clobber', 11:38:44 INFO - 'read-buildbot-config', 11:38:44 INFO - 'download-and-extract', 11:38:44 INFO - 'populate-webroot', 11:38:44 INFO - 'create-virtualenv', 11:38:44 INFO - 'install', 11:38:44 INFO - 'run-tests'), 11:38:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:44 INFO - 'download_minidump_stackwalk': True, 11:38:44 INFO - 'download_symbols': 'ondemand', 11:38:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:44 INFO - 'installer_path': 'installer.exe', 11:38:44 INFO - 'log_level': 'info', 11:38:44 INFO - 'log_name': 'talos', 11:38:44 INFO - 'log_to_console': True, 11:38:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:44 INFO - 'opt_config_files': (), 11:38:44 INFO - 'pip_index': False, 11:38:44 INFO - 'sps_profile': False, 11:38:44 INFO - 'sps_profile_interval': 0, 11:38:44 INFO - 'suite': 'dromaeojs', 11:38:44 INFO - 'system_bits': '32', 11:38:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:44 INFO - 'title': 'talos-linux64-ix-047', 11:38:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:44 INFO - 'use_talos_json': True, 11:38:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:44 INFO - 'work_dir': 'build'} 11:38:44 INFO - [mozharness: 2016-11-07 19:38:44.983968Z] Running clobber step. 11:38:44 INFO - Running pre-action listener: _resource_record_pre_action 11:38:44 INFO - Running main action method: clobber 11:38:44 INFO - rmtree: /builds/slave/test/build 11:38:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:45 INFO - Running post-action listener: _resource_record_post_action 11:38:45 INFO - [mozharness: 2016-11-07 19:38:45.450435Z] Finished clobber step (success) 11:38:45 INFO - [mozharness: 2016-11-07 19:38:45.450537Z] Running read-buildbot-config step. 11:38:45 INFO - Running pre-action listener: _resource_record_pre_action 11:38:45 INFO - Running main action method: read_buildbot_config 11:38:45 INFO - Using buildbot properties: 11:38:45 INFO - { 11:38:45 INFO - "project": "", 11:38:45 INFO - "product": "firefox", 11:38:45 INFO - "script_repo_revision": "production", 11:38:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:38:45 INFO - "repository": "", 11:38:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:38:45 INFO - "buildid": "20161107100027", 11:38:45 INFO - "pgo_build": "True", 11:38:45 INFO - "basedir": "/builds/slave/test", 11:38:45 INFO - "buildnumber": 866, 11:38:45 INFO - "slavename": "talos-linux64-ix-047", 11:38:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:38:45 INFO - "platform": "ubuntu64_hw", 11:38:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:38:45 INFO - "branch": "mozilla-aurora", 11:38:45 INFO - "repo_path": "releases/mozilla-aurora", 11:38:45 INFO - "revision": "a1243da2fec4f351fa1fc5a2314f704f670fd8e8", 11:38:45 INFO - "stage_platform": "linux64-pgo", 11:38:45 INFO - "builduid": "e4631074dc6d45fbaf9f28f002de049d", 11:38:45 INFO - "slavebuilddir": "test" 11:38:45 INFO - } 11:38:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 11:38:45 INFO - Running post-action listener: _resource_record_post_action 11:38:45 INFO - [mozharness: 2016-11-07 19:38:45.452975Z] Finished read-buildbot-config step (success) 11:38:45 INFO - [mozharness: 2016-11-07 19:38:45.453065Z] Running download-and-extract step. 11:38:45 INFO - Running pre-action listener: _resource_record_pre_action 11:38:45 INFO - Running main action method: download_and_extract 11:38:45 INFO - mkdir: /builds/slave/test/build/tests 11:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:45 INFO - trying https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:38:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:38:46 INFO - Downloaded 1361 bytes. 11:38:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:38:46 INFO - Using the following test package requirements: 11:38:46 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 11:38:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:38:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'jsshell-linux-x86_64.zip'], 11:38:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 11:38:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:38:46 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:38:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:46 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 11:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:38:46 INFO - Expected file size: 21897076 11:38:50 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:38:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 11:38:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:38:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:38:51 INFO - Expected file size: 21897076 11:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 11:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:38:56 INFO - Expected file size: 14414089 11:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:57 INFO - trying https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:38:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:38:58 INFO - Downloaded 63988050 bytes. 11:38:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:38:58 INFO - mkdir: /builds/slave/test/properties 11:38:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:58 INFO - Contents: 11:38:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:38:59 INFO - Running post-action listener: _resource_record_post_action 11:38:59 INFO - Running post-action listener: set_extra_try_arguments 11:38:59 INFO - [mozharness: 2016-11-07 19:38:59.087032Z] Finished download-and-extract step (success) 11:38:59 INFO - [mozharness: 2016-11-07 19:38:59.087260Z] Running populate-webroot step. 11:38:59 INFO - Running pre-action listener: _resource_record_pre_action 11:38:59 INFO - Running main action method: populate_webroot 11:38:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:59 INFO - '--tppagecycles', 11:38:59 INFO - '7'], 11:38:59 INFO - 'tests': ['tsvgm']}}, 11:38:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['damp', 'tps']}, 11:38:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'tests': ['damp', 'tps']}, 11:38:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['dromaeo_dom']}, 11:38:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['basic_compositor_video']}, 11:38:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['a11yr', 11:38:59 INFO - 'ts_paint', 11:38:59 INFO - 'tpaint', 11:38:59 INFO - 'sessionrestore', 11:38:59 INFO - 'sessionrestore_no_auto_restore', 11:38:59 INFO - 'tabpaint']}, 11:38:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['tsvgx', 11:38:59 INFO - 'tsvgr_opacity', 11:38:59 INFO - 'tart', 11:38:59 INFO - 'tscrollx', 11:38:59 INFO - 'cart']}, 11:38:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:59 INFO - 'tsvgr_opacity', 11:38:59 INFO - 'tart', 11:38:59 INFO - 'tscrollx', 11:38:59 INFO - 'cart']}, 11:38:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'talos_options': ['--disable-e10s'], 11:38:59 INFO - 'tests': ['tp5o']}, 11:38:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'tests': ['tp5o']}, 11:38:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'talos_options': ['--disable-e10s', 11:38:59 INFO - '--xperf_path', 11:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:59 INFO - 'tests': ['tp5n']}, 11:38:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:59 INFO - 'talos_options': ['--xperf_path', 11:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:59 INFO - 'tests': ['tp5n']}}, 11:38:59 INFO - 'talos.zip': {'path': '', 11:38:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:59 INFO - Running post-action listener: _resource_record_post_action 11:38:59 INFO - [mozharness: 2016-11-07 19:38:59.104482Z] Finished populate-webroot step (success) 11:38:59 INFO - [mozharness: 2016-11-07 19:38:59.104570Z] Running create-virtualenv step. 11:38:59 INFO - Running pre-action listener: _resource_record_pre_action 11:38:59 INFO - Running main action method: create_virtualenv 11:38:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:59 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 11:38:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:59 INFO - Using real prefix '/usr' 11:38:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:01 INFO - Installing pip.................done. 11:39:01 INFO - Return code: 0 11:39:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:01 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 11:39:01 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 11:39:01 INFO - Using env: {'DISPLAY': ':0', 11:39:01 INFO - 'HOME': '/home/cltbld', 11:39:01 INFO - 'LANG': 'en_US.UTF-8', 11:39:01 INFO - 'LANGUAGE': 'en_US:en', 11:39:01 INFO - 'LOGNAME': 'cltbld', 11:39:01 INFO - 'MAIL': '/var/mail/cltbld', 11:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:01 INFO - 'MOZ_NO_REMOTE': '1', 11:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:01 INFO - 'NO_EM_RESTART': '1', 11:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:01 INFO - 'PWD': '/builds/slave/test', 11:39:01 INFO - 'SHELL': '/bin/bash', 11:39:01 INFO - 'SHLVL': '1', 11:39:01 INFO - 'TERM': 'linux', 11:39:01 INFO - 'TMOUT': '86400', 11:39:01 INFO - 'USER': 'cltbld', 11:39:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:01 INFO - '_': '/tools/buildbot/bin/python'} 11:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:01 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 11:39:01 INFO - Cleaning up... 11:39:01 INFO - Return code: 0 11:39:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:01 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 11:39:01 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 11:39:01 INFO - Using env: {'DISPLAY': ':0', 11:39:01 INFO - 'HOME': '/home/cltbld', 11:39:01 INFO - 'LANG': 'en_US.UTF-8', 11:39:01 INFO - 'LANGUAGE': 'en_US:en', 11:39:01 INFO - 'LOGNAME': 'cltbld', 11:39:01 INFO - 'MAIL': '/var/mail/cltbld', 11:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:01 INFO - 'MOZ_NO_REMOTE': '1', 11:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:01 INFO - 'NO_EM_RESTART': '1', 11:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:01 INFO - 'PWD': '/builds/slave/test', 11:39:01 INFO - 'SHELL': '/bin/bash', 11:39:01 INFO - 'SHLVL': '1', 11:39:01 INFO - 'TERM': 'linux', 11:39:01 INFO - 'TMOUT': '86400', 11:39:01 INFO - 'USER': 'cltbld', 11:39:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:01 INFO - '_': '/tools/buildbot/bin/python'} 11:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:02 INFO - Downloading/unpacking psutil>=3.1.1 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:02 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 11:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:04 INFO - Installing collected packages: psutil 11:39:04 INFO - Running setup.py install for psutil 11:39:04 INFO - building 'psutil._psutil_linux' extension 11:39:04 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 11:39:04 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 11:39:04 INFO - building 'psutil._psutil_posix' extension 11:39:04 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 11:39:04 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 11:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:04 INFO - Successfully installed psutil 11:39:04 INFO - Cleaning up... 11:39:04 INFO - Return code: 0 11:39:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:04 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 11:39:04 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 11:39:04 INFO - Using env: {'DISPLAY': ':0', 11:39:04 INFO - 'HOME': '/home/cltbld', 11:39:04 INFO - 'LANG': 'en_US.UTF-8', 11:39:04 INFO - 'LANGUAGE': 'en_US:en', 11:39:04 INFO - 'LOGNAME': 'cltbld', 11:39:04 INFO - 'MAIL': '/var/mail/cltbld', 11:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:04 INFO - 'MOZ_NO_REMOTE': '1', 11:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:04 INFO - 'NO_EM_RESTART': '1', 11:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:04 INFO - 'PWD': '/builds/slave/test', 11:39:04 INFO - 'SHELL': '/bin/bash', 11:39:04 INFO - 'SHLVL': '1', 11:39:04 INFO - 'TERM': 'linux', 11:39:04 INFO - 'TMOUT': '86400', 11:39:04 INFO - 'USER': 'cltbld', 11:39:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:04 INFO - '_': '/tools/buildbot/bin/python'} 11:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:04 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 11:39:04 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 11:39:04 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 11:39:04 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 11:39:04 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 11:39:04 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 11:39:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:06 INFO - Installing collected packages: mozsystemmonitor 11:39:06 INFO - Running setup.py install for mozsystemmonitor 11:39:06 INFO - Successfully installed mozsystemmonitor 11:39:06 INFO - Cleaning up... 11:39:07 INFO - Return code: 0 11:39:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39:07 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')]} 11:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:07 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')]} 11:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:07 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:07 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 11:39:07 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 11:39:07 INFO - Using env: {'DISPLAY': ':0', 11:39:07 INFO - 'HOME': '/home/cltbld', 11:39:07 INFO - 'LANG': 'en_US.UTF-8', 11:39:07 INFO - 'LANGUAGE': 'en_US:en', 11:39:07 INFO - 'LOGNAME': 'cltbld', 11:39:07 INFO - 'MAIL': '/var/mail/cltbld', 11:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:07 INFO - 'MOZ_NO_REMOTE': '1', 11:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:07 INFO - 'NO_EM_RESTART': '1', 11:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:07 INFO - 'PWD': '/builds/slave/test', 11:39:07 INFO - 'SHELL': '/bin/bash', 11:39:07 INFO - 'SHLVL': '1', 11:39:07 INFO - 'TERM': 'linux', 11:39:07 INFO - 'TMOUT': '86400', 11:39:07 INFO - 'USER': 'cltbld', 11:39:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:07 INFO - '_': '/tools/buildbot/bin/python'} 11:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:07 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 11:39:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:09 INFO - warning: no files found matching '*.txt' 11:39:09 INFO - no previously-included directories found matching 'build' 11:39:09 INFO - no previously-included directories found matching 'dist' 11:39:09 INFO - no previously-included directories found matching '.git*' 11:39:09 INFO - Installing collected packages: jsonschema, functools32 11:39:09 INFO - Running setup.py install for functools32 11:39:09 INFO - warning: no files found matching '*.txt' 11:39:09 INFO - no previously-included directories found matching 'build' 11:39:09 INFO - no previously-included directories found matching 'dist' 11:39:09 INFO - no previously-included directories found matching '.git*' 11:39:09 INFO - Successfully installed jsonschema functools32 11:39:09 INFO - Cleaning up... 11:39:09 INFO - Return code: 0 11:39:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:09 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 11:39:09 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 11:39:09 INFO - Using env: {'DISPLAY': ':0', 11:39:09 INFO - 'HOME': '/home/cltbld', 11:39:09 INFO - 'LANG': 'en_US.UTF-8', 11:39:09 INFO - 'LANGUAGE': 'en_US:en', 11:39:09 INFO - 'LOGNAME': 'cltbld', 11:39:09 INFO - 'MAIL': '/var/mail/cltbld', 11:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:09 INFO - 'MOZ_NO_REMOTE': '1', 11:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:09 INFO - 'NO_EM_RESTART': '1', 11:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:09 INFO - 'PWD': '/builds/slave/test', 11:39:09 INFO - 'SHELL': '/bin/bash', 11:39:09 INFO - 'SHLVL': '1', 11:39:09 INFO - 'TERM': 'linux', 11:39:09 INFO - 'TMOUT': '86400', 11:39:09 INFO - 'USER': 'cltbld', 11:39:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:09 INFO - '_': '/tools/buildbot/bin/python'} 11:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:39:09 INFO - Cleaning up... 11:39:09 INFO - Return code: 0 11:39:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:09 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:09 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 11:39:09 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 11:39:09 INFO - Using env: {'DISPLAY': ':0', 11:39:09 INFO - 'HOME': '/home/cltbld', 11:39:09 INFO - 'LANG': 'en_US.UTF-8', 11:39:09 INFO - 'LANGUAGE': 'en_US:en', 11:39:09 INFO - 'LOGNAME': 'cltbld', 11:39:09 INFO - 'MAIL': '/var/mail/cltbld', 11:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:09 INFO - 'MOZ_NO_REMOTE': '1', 11:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:09 INFO - 'NO_EM_RESTART': '1', 11:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:09 INFO - 'PWD': '/builds/slave/test', 11:39:09 INFO - 'SHELL': '/bin/bash', 11:39:09 INFO - 'SHLVL': '1', 11:39:09 INFO - 'TERM': 'linux', 11:39:09 INFO - 'TMOUT': '86400', 11:39:09 INFO - 'USER': 'cltbld', 11:39:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:09 INFO - '_': '/tools/buildbot/bin/python'} 11:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 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 11:39:12 INFO - Downloading docopt-0.6.1.tar.gz 11:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:12 INFO - Running setup.py install for blobuploader 11:39:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:12 INFO - Running setup.py install for requests 11:39:13 INFO - Running setup.py install for docopt 11:39:13 INFO - Successfully installed blobuploader requests docopt 11:39:13 INFO - Cleaning up... 11:39:13 INFO - Return code: 0 11:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:13 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:13 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 11:39:13 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 11:39:13 INFO - Using env: {'DISPLAY': ':0', 11:39:13 INFO - 'HOME': '/home/cltbld', 11:39:13 INFO - 'LANG': 'en_US.UTF-8', 11:39:13 INFO - 'LANGUAGE': 'en_US:en', 11:39:13 INFO - 'LOGNAME': 'cltbld', 11:39:13 INFO - 'MAIL': '/var/mail/cltbld', 11:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:13 INFO - 'MOZ_NO_REMOTE': '1', 11:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:13 INFO - 'NO_EM_RESTART': '1', 11:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:13 INFO - 'PWD': '/builds/slave/test', 11:39:13 INFO - 'SHELL': '/bin/bash', 11:39:13 INFO - 'SHLVL': '1', 11:39:13 INFO - 'TERM': 'linux', 11:39:13 INFO - 'TMOUT': '86400', 11:39:13 INFO - 'USER': 'cltbld', 11:39:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:13 INFO - '_': '/tools/buildbot/bin/python'} 11:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:13 INFO - Running setup.py (path:/tmp/pip-StxsW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:13 INFO - Running setup.py (path:/tmp/pip-H79sRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:13 INFO - Running setup.py (path:/tmp/pip-CLAyYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:13 INFO - Running setup.py (path:/tmp/pip-DeE1Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:13 INFO - Running setup.py (path:/tmp/pip-TrkHDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:13 INFO - Running setup.py (path:/tmp/pip-dHUPhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:14 INFO - Running setup.py (path:/tmp/pip-OcaO3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:14 INFO - Running setup.py (path:/tmp/pip-kTMvCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:14 INFO - Running setup.py (path:/tmp/pip-fN704u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:14 INFO - Running setup.py (path:/tmp/pip-y_Dmo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:14 INFO - Running setup.py (path:/tmp/pip-kGi4HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:14 INFO - Running setup.py (path:/tmp/pip-gLOEsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:14 INFO - Running setup.py (path:/tmp/pip-lNWAYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:14 INFO - Running setup.py (path:/tmp/pip-p_1An6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:14 INFO - Running setup.py (path:/tmp/pip-oXDeQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:14 INFO - Running setup.py (path:/tmp/pip-NEx_iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:14 INFO - Running setup.py (path:/tmp/pip-dmM5pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:14 INFO - Running setup.py install for manifestparser 11:39:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:14 INFO - Running setup.py install for mozcrash 11:39:15 INFO - Running setup.py install for mozdebug 11:39:15 INFO - Running setup.py install for mozdevice 11:39:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozfile 11:39:15 INFO - Running setup.py install for mozhttpd 11:39:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozinfo 11:39:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozInstall 11:39:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozleak 11:39:15 INFO - Running setup.py install for mozlog 11:39:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for moznetwork 11:39:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:15 INFO - Running setup.py install for mozprocess 11:39:16 INFO - Running setup.py install for mozprofile 11:39:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Running setup.py install for mozrunner 11:39:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Running setup.py install for mozscreenshot 11:39:16 INFO - Running setup.py install for moztest 11:39:16 INFO - Running setup.py install for mozversion 11:39:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:16 INFO - Cleaning up... 11:39:16 INFO - Return code: 0 11:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:16 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:16 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 11:39:16 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 11:39:16 INFO - Using env: {'DISPLAY': ':0', 11:39:16 INFO - 'HOME': '/home/cltbld', 11:39:16 INFO - 'LANG': 'en_US.UTF-8', 11:39:16 INFO - 'LANGUAGE': 'en_US:en', 11:39:16 INFO - 'LOGNAME': 'cltbld', 11:39:16 INFO - 'MAIL': '/var/mail/cltbld', 11:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:16 INFO - 'MOZ_NO_REMOTE': '1', 11:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:16 INFO - 'NO_EM_RESTART': '1', 11:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:16 INFO - 'PWD': '/builds/slave/test', 11:39:16 INFO - 'SHELL': '/bin/bash', 11:39:16 INFO - 'SHLVL': '1', 11:39:16 INFO - 'TERM': 'linux', 11:39:16 INFO - 'TMOUT': '86400', 11:39:16 INFO - 'USER': 'cltbld', 11:39:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:16 INFO - '_': '/tools/buildbot/bin/python'} 11:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:16 INFO - Running setup.py (path:/tmp/pip-jt9nfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:16 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:16 INFO - Running setup.py (path:/tmp/pip-cbmeG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:16 INFO - Running setup.py (path:/tmp/pip-zFYdOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:17 INFO - Running setup.py (path:/tmp/pip-edoVfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:17 INFO - Running setup.py (path:/tmp/pip-kxpqrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:17 INFO - Running setup.py (path:/tmp/pip-9fmKmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:17 INFO - Running setup.py (path:/tmp/pip-owPS9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:17 INFO - Running setup.py (path:/tmp/pip-jEajiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:17 INFO - Running setup.py (path:/tmp/pip-BCnycZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:17 INFO - Running setup.py (path:/tmp/pip-IkMrGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:17 INFO - Running setup.py (path:/tmp/pip-PEoPJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:17 INFO - Running setup.py (path:/tmp/pip-rZ7fhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:17 INFO - Running setup.py (path:/tmp/pip-Sa7aNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:17 INFO - Running setup.py (path:/tmp/pip-2QrHb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:17 INFO - Running setup.py (path:/tmp/pip-oCE4V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:17 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)) 11:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:17 INFO - Running setup.py (path:/tmp/pip-2WJxgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:18 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)) 11:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:18 INFO - Running setup.py (path:/tmp/pip-klIUSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:18 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)) 11:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:39:18 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)) 11:39:18 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)) 11:39:18 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)) 11:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:18 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 11:39:20 INFO - Downloading blessings-1.6.tar.gz 11:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:20 INFO - Installing collected packages: blessings 11:39:20 INFO - Running setup.py install for blessings 11:39:20 INFO - Successfully installed blessings 11:39:20 INFO - Cleaning up... 11:39:20 INFO - Return code: 0 11:39:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:20 INFO - Reading from file tmpfile_stdout 11:39:20 INFO - Current package versions: 11:39:20 INFO - argparse == 1.2.1 11:39:20 INFO - blessings == 1.6 11:39:20 INFO - blobuploader == 1.2.4 11:39:20 INFO - docopt == 0.6.1 11:39:20 INFO - functools32 == 3.2.3-2 11:39:20 INFO - jsonschema == 2.5.1 11:39:20 INFO - manifestparser == 1.1 11:39:20 INFO - mozInstall == 1.12 11:39:20 INFO - mozcrash == 0.17 11:39:20 INFO - mozdebug == 0.1 11:39:20 INFO - mozdevice == 0.48 11:39:20 INFO - mozfile == 1.2 11:39:20 INFO - mozhttpd == 0.7 11:39:20 INFO - mozinfo == 0.9 11:39:20 INFO - mozleak == 0.1 11:39:20 INFO - mozlog == 3.4 11:39:20 INFO - moznetwork == 0.27 11:39:20 INFO - mozprocess == 0.23 11:39:20 INFO - mozprofile == 0.28 11:39:20 INFO - mozrunner == 6.12 11:39:20 INFO - mozscreenshot == 0.1 11:39:20 INFO - mozsystemmonitor == 0.3 11:39:20 INFO - moztest == 0.7 11:39:20 INFO - mozversion == 1.4 11:39:20 INFO - psutil == 3.1.1 11:39:20 INFO - requests == 1.2.3 11:39:20 INFO - wsgiref == 0.1.2 11:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:20 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')]} 11:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 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')]} 11:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:20 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 11:39:20 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 11:39:20 INFO - Using env: {'DISPLAY': ':0', 11:39:20 INFO - 'HOME': '/home/cltbld', 11:39:20 INFO - 'LANG': 'en_US.UTF-8', 11:39:20 INFO - 'LANGUAGE': 'en_US:en', 11:39:20 INFO - 'LOGNAME': 'cltbld', 11:39:20 INFO - 'MAIL': '/var/mail/cltbld', 11:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:20 INFO - 'MOZ_NO_REMOTE': '1', 11:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:20 INFO - 'NO_EM_RESTART': '1', 11:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:20 INFO - 'PWD': '/builds/slave/test', 11:39:20 INFO - 'SHELL': '/bin/bash', 11:39:20 INFO - 'SHLVL': '1', 11:39:20 INFO - 'TERM': 'linux', 11:39:20 INFO - 'TMOUT': '86400', 11:39:20 INFO - 'USER': 'cltbld', 11:39:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:20 INFO - '_': '/tools/buildbot/bin/python'} 11:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 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)) 11:39:20 INFO - Cleaning up... 11:39:20 INFO - Return code: 0 11:39:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:20 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')]} 11:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 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')]} 11:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:20 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 0x7fe1eccc2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1872ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', '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 11:39:20 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 11:39:20 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 11:39:20 INFO - Using env: {'DISPLAY': ':0', 11:39:20 INFO - 'HOME': '/home/cltbld', 11:39:20 INFO - 'LANG': 'en_US.UTF-8', 11:39:20 INFO - 'LANGUAGE': 'en_US:en', 11:39:20 INFO - 'LOGNAME': 'cltbld', 11:39:20 INFO - 'MAIL': '/var/mail/cltbld', 11:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:20 INFO - 'MOZ_NO_REMOTE': '1', 11:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:20 INFO - 'NO_EM_RESTART': '1', 11:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:20 INFO - 'PWD': '/builds/slave/test', 11:39:20 INFO - 'SHELL': '/bin/bash', 11:39:20 INFO - 'SHLVL': '1', 11:39:20 INFO - 'TERM': 'linux', 11:39:20 INFO - 'TMOUT': '86400', 11:39:20 INFO - 'USER': 'cltbld', 11:39:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:20 INFO - '_': '/tools/buildbot/bin/python'} 11:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:20 INFO - Cleaning up... 11:39:20 INFO - Return code: 0 11:39:20 INFO - Running post-action listener: _resource_record_post_action 11:39:20 INFO - Running post-action listener: _start_resource_monitoring 11:39:21 INFO - Starting resource monitoring. 11:39:21 INFO - [mozharness: 2016-11-07 19:39:21.022812Z] Finished create-virtualenv step (success) 11:39:21 INFO - [mozharness: 2016-11-07 19:39:21.023319Z] Running install step. 11:39:21 INFO - Running pre-action listener: _resource_record_pre_action 11:39:21 INFO - Running main action method: install 11:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:21 INFO - Reading from file tmpfile_stdout 11:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:21 INFO - Reading from file tmpfile_stdout 11:39:21 INFO - Output received: 11:39:21 INFO - Usage: mozinstall [options] installer 11:39:21 INFO - Options: 11:39:21 INFO - -h, --help show this help message and exit 11:39:21 INFO - -d DEST, --destination=DEST 11:39:21 INFO - Directory to install application into. [default: 11:39:21 INFO - "/builds/slave/test"] 11:39:21 INFO - --app=APP Application being installed. [default: firefox] 11:39:21 INFO - mkdir: /builds/slave/test/build/application 11:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:39:37 INFO - Reading from file tmpfile_stdout 11:39:37 INFO - Output received: 11:39:37 INFO - /builds/slave/test/build/application/firefox/firefox 11:39:37 INFO - Running post-action listener: _resource_record_post_action 11:39:37 INFO - [mozharness: 2016-11-07 19:39:37.290353Z] Finished install step (success) 11:39:37 INFO - [mozharness: 2016-11-07 19:39:37.290601Z] Running run-tests step. 11:39:37 INFO - Running pre-action listener: _resource_record_pre_action 11:39:37 INFO - Running main action method: run_tests 11:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:37 INFO - Python 2.7.3 11:39:37 INFO - Return code: 0 11:39:37 INFO - grabbing minidump binary from tooltool 11:39:37 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')]} 11:39:37 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 0x186ff60>, '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 0x1870d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18711d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:37 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 11:39:37 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 11:39:37 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 11:39:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:37 INFO - Return code: 0 11:39:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:39:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:39:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:39:37 INFO - Using env: {'DISPLAY': ':0', 11:39:37 INFO - 'HOME': '/home/cltbld', 11:39:37 INFO - 'LANG': 'en_US.UTF-8', 11:39:37 INFO - 'LANGUAGE': 'en_US:en', 11:39:37 INFO - 'LOGNAME': 'cltbld', 11:39:37 INFO - 'MAIL': '/var/mail/cltbld', 11:39:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:37 INFO - 'MOZ_NO_REMOTE': '1', 11:39:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:37 INFO - 'NO_EM_RESTART': '1', 11:39:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:37 INFO - 'PWD': '/builds/slave/test', 11:39:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:37 INFO - 'SHELL': '/bin/bash', 11:39:37 INFO - 'SHLVL': '1', 11:39:37 INFO - 'TERM': 'linux', 11:39:37 INFO - 'TMOUT': '86400', 11:39:37 INFO - 'USER': 'cltbld', 11:39:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597', 11:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:37 INFO - '_': '/tools/buildbot/bin/python'} 11:39:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:39:37 INFO - mozversion application_buildid: 20161107100027 11:39:37 INFO - mozversion application_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 11:39:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:39:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:37 INFO - mozversion application_name: Firefox 11:39:37 INFO - mozversion application_remotingname: firefox-dev 11:39:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:37 INFO - mozversion application_vendor: Mozilla 11:39:37 INFO - mozversion application_version: 51.0a2 11:39:37 INFO - mozversion platform_buildid: 20161107100027 11:39:37 INFO - mozversion platform_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 11:39:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:37 INFO - mozversion platform_version: 51.0a2 11:39:37 INFO - using testdate: 1478547577 11:39:37 INFO - actual date: 1478547577 11:39:37 INFO - starting webserver on 'localhost:49594' 11:39:37 INFO - SUITE-START | Running 2 tests 11:39:37 INFO - TEST-START | dromaeo_css 11:39:37 INFO - operating with platform_type : linux_ 11:39:37 INFO - Initialising browser for dromaeo_css test... 11:39:37 INFO - TEST-INFO | started process 10812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVRyO5/profile http://localhost:49594/getInfo.html) 11:39:41 INFO - PROCESS | 10812 | __metrics Screen width/height:1600/1200 11:39:41 INFO - PROCESS | 10812 | colorDepth:24 11:39:41 INFO - PROCESS | 10812 | Browser inner width/height: 1024/697 11:39:41 INFO - PROCESS | 10812 | __metrics 11:39:42 INFO - PROCESS | 10812 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:39:42 INFO - PROCESS | 10812 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:42 INFO - PROCESS | 10812 | console.error: PushService: 11:39:42 INFO - PROCESS | 10812 | stateChangeProcessEnqueue: Error transitioning state 11:39:42 INFO - PROCESS | 10812 | UnknownError 11:39:43 INFO - TEST-INFO | 10812: exit 0 11:39:43 INFO - Browser initialized. 11:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:43 INFO - TEST-INFO | started process 10904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzVRyO5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:55 INFO - PROCESS | 10904 | RSS: Main: 145178624 11:39:55 INFO - PROCESS | 10904 | 11:40:46 INFO - PROCESS | 10904 | 1478547646493 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] 11:42:55 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49594/tests/dromaeo/cssquery-ext.html) 11:42:57 INFO - PROCESS | 10904 | RSS: Main: 226689024 11:42:57 INFO - PROCESS | 10904 | 11:45:59 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-ext.html (next: http://localhost:49594/tests/dromaeo/cssquery-jquery.html) 11:46:00 INFO - PROCESS | 10904 | RSS: Main: 229978112 11:46:00 INFO - PROCESS | 10904 | 11:49:01 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49594/tests/dromaeo/cssquery-mootools.html) 11:49:02 INFO - PROCESS | 10904 | RSS: Main: 173400064 11:49:02 INFO - PROCESS | 10904 | 11:52:04 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49594/tests/dromaeo/cssquery-prototype.html) 11:52:05 INFO - PROCESS | 10904 | RSS: Main: 173043712 11:52:05 INFO - PROCESS | 10904 | 11:55:07 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49594/tests/dromaeo/cssquery-yui.html) 11:55:08 INFO - PROCESS | 10904 | RSS: Main: 177311744 11:55:08 INFO - PROCESS | 10904 | 11:58:10 INFO - PROCESS | 10904 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-yui.html (next: http://localhost:49594/tests/dromaeo/cssquery-dojo.html) 11:58:11 INFO - PROCESS | 10904 | RSS: Main: 264540160 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | __start_tp_report 11:58:11 INFO - PROCESS | 10904 | _x_x_mozilla_page_load 11:58:11 INFO - PROCESS | 10904 | _x_x_mozilla_page_load_details 11:58:11 INFO - PROCESS | 10904 | |i|pagename|runs| 11:58:11 INFO - PROCESS | 10904 | |0;dojo.html;3213.2609499815044;3247.1395080303714;3258.788178768378;3272;3294.6375898651145;5798.362180160184;5839.182514447975;5858.20914176586;5864.970675146629;5890.440408161223;5806.912896306559;5867.413258674131;5869.618474799135;5870.060790273546;5882.588218824684;5253.60597955152;5281.603879709018;5294.470552944713;5303.867403314909;5362.302900622933;5089.033083714083;5119.411267704206;5350.91973620396;5367.543758780489;5370.516653501184;5186;5234.6335756497065;5239.842804715865;5240;5240.030594340059;5191.792328306863;5205.583553315726;5223.451537588575;5223.634345595772;5279.366476022863;5239.345081864767;5242.528172464458;5243.659162154486;5327.813526526592;5334.91997620036;5569.944300557024;5795.82612521625;5813.069908814569;5854.707264636793;5886.381929897385;6020.939790602081;6028.457438830526;6035.668038257894;6075.088736689532;6106.816795496142;6129.264488261392;6152.815415537541;6159.876802463926;6172.043333283348;6203.8138855834395;5591.944080559224;5770.394108618535;5783.248177736909;5790.160426738099;5803.390643982406;6130.551011451118;6223.066540018943;6263.123162757218;6286.49708023357;6366.140571022853;6119.724612392453;6120.785772497941;6127.20346354971;6130.111133885562;6139.785107521216;5982.970085149546;6209.534284928648;6217.160683307786;6218.657973811393;6221.9377806222265;5996.670183139882;6073.757049717962;6125.754969801247;6127.264728232641;6172.660503672251;6134;6169.290531588835;6182.907256391158;6188.226471691039;6195.101710251988;4757.191277482836;4757.524247575215;4762.285657151455;4766.380370551806;4781.976090119597;4066.5933406659688;4097.8975525612095;4162.41726158338;4214.030772922245;4228.91542169161;5870.119482077723;5908.113782932509;5909.143174239711;5910.527157827363;5931.40685931412;6267.561270711007;6270.2475702915945;6277.7175027123885;6293.056041593798;6293.339199383999;5648.378678345379;5664.660120392789;5724.026915424388;5765.769369225268;5888.676122813286;5245.868853278698;5251.711155886463;5254.448282930313;5275.155975043975;5280.023195708806;6333.714982825876;6359.427651511293;6362.745490180433;6393.073004414427;6395.2645445773405;6068.969655151696;6101.694915254131;6121.056693971993;6139.154842350836;6240.188775459162;6475.481961442979;6479.254885688206;6485.77299794505;6497.18785151856;6505.51208659343;6137.355577664281;6142.2629284484365;6155.784547540815;6156.26124865019;6162.414570615784;5951.672658003851;6054.697265136813;6232.470240029467;6236.75052997875;6240.282367527792;6032.095185722177;6041.728122234598;6062.36345183767;6119.807225076679;6123.4351415035735;6099;6102.755889764359;6108.328083910677;6110.346130329577;6139.785107521216;5821.883562328814;6022.48808851235;6063.363346848694;6064.363241859718;6075.179850720273;5863.824085277449;5886.676232807065;5903.144044113494;5917.792877249276;6022.337542870368;5811.970940145272;5835.095560188178;5837.737301821513;5838;5843.0358990767745 11:58:11 INFO - PROCESS | 10904 | |1;ext.html;592.5022980696215;634.873025394921;650.8503044299814;656.8981807819788;681.781829814459;33564.496532552;34171.14572135698;37408.25183496328;45918;46894.76552617241;47897.28154077683;48040.03919921599;48410;48483.515164848344;48553.51446485534;9251.028641992578;9429.339946203769;9440.480773557452;9444.433333999981;9446.197073248783;8638.740837774845;8803.691870784523;8814.471131732116;9011.639534418615;9098.044705305947;11036.227464077518;11301.660950171508;11304.491297891615;11636.243644163102;11643.825342619868;11116.833247501294;11178.27341222818;11192.384418856918;11193.16051296156;11202.383868887207;11141.944290278496;11199.776004479947;11201.327920324806;11205.159613028974;11206.607768728056;44919.326210106876;45167.322490162675;45221;45232.3215151773;45261.547384526064;3770.3213421584105;3777.7722240272024;4327.831485498898;4374.562543745632;4470.284754439274;34124.82937585321;34270.48594271088;34302;34343.82828085869;34624.30751384983;4573.428321459817;4618;4618.053299073682;4631.467381251132;4653.88365290867;387498;388168.05915970524;391562;391635;392990;61372;61559;61697;62013;62099.37900621026;40151;40930.1813963719;41113;43723.78138109289;43756;19768.505787355432;20018.799812001984;20032.098555565033;20046.198152073754;20051.097700603506;15157.545273641588;15240.314185861664;15246.466373676869;15249;15256.084634921941;18009.18958646864;18710.438686839418;19706;20257.594848102955;20602.27892023772;7412.770376879871;7601.847963040819;7680.462367634212;7842.8431431371055;7879.290863822283;985.3693636072919;1132.105636547135;1185.7509922916113;1198.5728898979637;1203.7050922523863;34126.65873341235;35317.64682353144;35619.38315468927;35791.284174316366;35907.12742980555;1143.8284257361297;1158.177693837368;1205.8311836342918;1211.8666946635863;1260.836091308124;18564.44306670802;18664.81335186631;18699.813001869807;18793.718094228596;18843.246270149313;594848;602842;606084;627487;970117;64767.67616161889;65230.67384663046;65420;65598;65794.34205657883;1346.7037251804588;1391.1513976474141;1457.5190187238186;1466.5893549806071;1495.521433141406;32573.18567035843;35070;35344;37088;37941;59845.40154598398;60110.098348523934;60383.396166039536;60516;60632.69683651553;530772;533067;533496;535274;535926;27952.860235698692;31445.371092577563;32562.185945351557;32585;32610.673893260762;39182;43224.56775432331;48303.27545086897;53391.199132013826;53427.46572534225;42998.78500607602;43782.56217437912;44008.00525718398;44213.33679994867;44531.55468445404;43490;44320.11359772722;44414.77792611016;44536.33195502135;45408.54591454043;45280.547194528954;45417.54582454133;45492;45850;46341.304880427495;36928;40056.59943400645;40371.1925761489;40527.59472405238;40597.98505037398;29538;29870.25324366908;30275.545866812456;30370.54444183295;30408.5438718415 11:58:11 INFO - PROCESS | 10904 | |2;jquery.html;431.64033295120345;441.11996566849143;442.32103720788587;443.99112017759643;448.2290460408097;19028.14373353199;19462.12420441082;20777.16891324349;20892.373228803142;20961.47596310093;19128.904355478204;19448.22207111714;19578.314758983437;19604.31384901529;19690.326322262626;5937.406259374071;6240.750369985195;6243.001119820829;6250.281217659959;6250.812475625716;5766.452187042245;6039.456448919596;6082.908756368658;6092.603980741238;6191.907121393183;6138.355472675372;6139.938600614004;6142.570020098595;6144.5084393248435;6148.969255153718;6025.819225423223;6834.350736680008;6864.622445765481;6895.724171033153;6906.136732908387;5920;6071.696415179224;6195.504359651217;6197.442230199259;6197.597156184878;15150.696986060328;15394.461193858273;15395.923020384938;16391.590210244838;23784.16755413552;2383.988080059606;2434.111549284516;2524.1544082732307;2590.3006188329045;2616.398228407477;10509.159267258678;11071.612493562767;11279.774404511945;11297.096232301396;11501.924779421217;1938.5541325495074;1967.3114409956545;2017.8284845788125;2063.597598468299;2069.9793002069937;64544;87205.56397218037;91515.54242228813;91916.08083919142;93251.53374233085;11721.421287316776;11823.231489953298;11894.312763043485;12038.939805300917;12234;17218.569535761457;17220.31118755261;17220.397286095176;17238.655226895393;17258.741118883227;9053.637854485878;9095.181433670869;9100.362974591715;9168.954155229314;9462.384944978554;8875.689350872688;8983.595738191798;9036.728898132935;9193.080691930754;9276.860847087299;5081.18701007837;5220.773118317193;5225.3207083079715;5239.764210610531;5332.600054995891;2112.3451729963454;2133.445304220914;2139.144342263076;2143.389134096775;2146.8389870759443;956.206348730552;981.7202097402206;1015.4973288222377;1048.528162326956;1107.5625128074366;19577.1190296437;19953.700694489595;20004.89997550032;20307.695384569244;20465.693014604793;1037.1339931157568;1038.2576457832686;1054.852320675106;1075.8924107589178;1105.3312745788842;10572.312799667998;11208;11436.771264574661;11522.36626985507;11573.652790416301;509107;532435;534522;535397;541132;70592;80921.59539202384;97291.51354243325;100709;101067.4946625277;1010.7725761703705;1049.4018409506662;1061.5223149582564;1088.3633074651418;1090.6061195675416;18099.819001809814;18307.267709292013;18367.265309387476;18543.90728046351;18920.43238702841;45009.77495112504;45232.09535809331;45459.77270113628;45711.771441142584;45952.08095837998;60166.39833601608;60192.39807602043;61319.38680613137;61494.385056148865;62091.37908620856;5832.270966129234;7029.437644988287;7563.659635316534;8702.608382622924;8912.28701703875;8366.581670916552;12061.879381206076;13660.453581857011;13685.178889266675;13982.930085349508;12294.385280735749;12460.813087803508;12501.687457813627;12515.56195533152;12561.37193140321;11919.582814601446;11942;12103.33431661267;12362.44369003379;12593.811092833432;11301.773964520498;11694.766104677688;11822.645320640395;12033.097517686034;12536.686582835502;8480.95759521223;8488.490690558587;8589.398742088244;8687.348448866487;8849.380543361904;8994.640214391351;11240.269382490113;11726.413679315829;11877.406129693309;12299 11:58:11 INFO - PROCESS | 10904 | |3;mootools.html;1452.6586252230725;1525.260248779342;1664.6337805682754;1827.3512902919472;1861.1345724238242;9322.48726320053;10104.14114800241;10115.089641932243;10122.696319110439;10125.24060695447;8620.267277281422;8864;9408.059194080588;9676.564554595043;9970.252231082679;2601.895924163036;2625.8424494530295;2630.06632645411;2633.552296109666;2637.3538483071675;2540.6824146981626;2620.737926207383;2626.579747240442;2629.382095207625;2630.408158164417;2610.6214598883153;2623.134365659337;2643.524165650182;2648.9470210595778;2654.4558365535117;2488.502299540099;2496.8002559795264;2592.8185027048116;2596.026490066225;2596.376869551313;2480.950380992388;2511.522810665986;2530.051230788454;2568.2166939083572;2598.1036542392844;9938.453385063818;9984.251181161442;10028;10034.59861605535;10038.196944244442;5581.748821303051;5766.308043034821;5766.942330576682;5768.3654797972185;5775.682337471438;3603.428504790952;3700.8149592520535;3773.2076263984322;3787.280416720842;3802.6387493188104;1209.7157168065498;1260.5651050387694;1281.0712233630636;1302.8957683385306;1311.7048664050608;13984.370703318375;14026.579202623938;14073.64815879601;14074.437022519087;14083.2958352083;4870.634702397334;5040.7731652075745;5176.5858731301405;5208.322918020633;5253.921191182136;11607.535698571963;11639.709007274885;11640.35978021217;11641.301521908712;11658.30050196974;5836.416358364215;5840.766369345179;5843;5844.59087863854;5847.619904706181;4662.463816661059;4774.498677638868;5328.014317351302;5341.198820177005;5382.569394448435;4430.180416622935;4444.777761111932;4530.524294949048;4579.198640237945;4712.69367491112;1425.180521200314;1449.9420023199166;1454.4691187716408;1459.3797636004656;1473.4769156949344;1063.6702622187147;1072.5763323487179;1091.8635170603675;1095.5891540672249;1104.138771758014;6596.70314835824;6597.406233439014;6797.320267973262;6857.794266172023;6918.965405173042;481.1339588740254;520.456123351099;522.882351470916;523.1890569617154;530.2841164428069;4551.658625603093;4664.580187783048;4672.649551283667;4689.155951928686;4756.500567440438;12053.939730301292;12289.385530723428;12541.184822986477;12546.686332841751;12588;12253.509859605694;12422.37888105591;12427.37863106841;12429.316387598768;12440.626781196579;9052.637894484147;9323.627054917863;9357.719268422094;9365.250779937589;9416.43501389905;6632.303608121078;6665.50008749336;6677.866442671022;6709.93290067093;6777.1189745332795;11302.321860688386;11458.541658333907;11485.598004069818;11514.36670983104;11577.189596728485;11431.371274579978;11526;11607.6517704469;11739.23694959825;11786.116041296766;7339.302766237199;8285.710000149966;8453.95773021131;8619.310455163697;8642.22220000203;9826.557804898654;9939.254555908481;9941.403515789076;9943.30396872212;9945.055219754111;8566.78583035429;8658.047614762498;8683.175098365646;8718.476891386283;8867.822643547222;8526.190011948855;8611.440256383315;8630.870536941826;8730.519821409884;8747.64411516216;7880.724174653859;7881.881771773543;7974.720884769005;7979.561124137996;7982.08206056311;5854.121881717606;5896.233489646319;5994.400559943971;5994.790182343771;6099.573029887865;5931.377205393372;5950.10748387728;5978.581499295007;6106.297775755845;6276.905846412399 11:58:11 INFO - PROCESS | 10904 | |4;prototype.html;357.662009401116;366.2272604803864;366.77809924995375;373.22369471499286;376.63090171631785;5657.971710141449;5669.9433005669935;5671.2060311556415;5701.287339082614;5701.657900525971;5316.548093412064;5519.254900588419;5614.3543492498375;5639.351474580424;5647.8588035299135;4380.978095109528;4420.933685994696;4422.690411671184;4442.11157768446;4455.443069616282;4428.582853486885;4432.9804145046655;4433.401490798749;4452.7977446089535;4465.665075119363;4357.629601483878;4371.672124590653;4373.890652733691;4395.252807022798;4418.381426600278;4236.97881510592;4362.607365337103;4376.212281789277;4383.123375324916;4405.3612226227015;3920.0591857954173;3939.5863434339267;3945.28984782739;3945.861894833667;3952.5849785772366;5422.9728851355885;5442.945570544283;5453.590980676426;5458.990086833948;5463.726813659301;4729.692569982974;4941.802327906916;4990.151674215392;4995.800167993276;5091.439941606421;5776.9422305776825;5779.306483221998;5785.71071446426;5798.681072541009;5806.187133801272;4212.641925436342;4227.323628219501;4232.3016702244095;4243.745375277463;4245.9787701061605;5653.180288858092;5837.795677151279;5877.324107727623;5942.821715348547;6090;4201.2017716634355;4308.267594508941;4321.524632290446;4342.848000320037;4359.956400436018;4417.514073451917;4420.801063952065;4421.646268298528;4435.933460998088;4459.464864216315;4603.746793926366;4621.514740952219;4938.456769755324;4986.650934434628;4995.225740010304;5790.826275211751;5801.796937107181;5805.767769289181;5826.184334193216;5828.329742079631;1494.8175663531365;1520.7794869743825;1523.0100434717522;1527.732646786808;1532.6015236038488;950.097407462913;966.9081437263449;970.7621632699893;982.3320142303303;985.9507024648739;4925.37462637336;4929.580985616263;4944.478316058836;4958.628102892298;4959.975200123977;5217.9478205217465;5220.92168617471;5223.895522089537;5239.633225674243;5243.2659427680155;4760.785764640599;4912.38595175603;4931.854643230206;4977.776000080005;5006.799728010911;2786.456640955035;2786.986065069662;2789.316617428743;2791.4417116576765;2795.9440811183663;5357.303550538405;5385.3268341457315;5395.62230643859;5421.83734487966;5440.401555828856;5062.696238225718;5346.85042715818;5374.355077390738;5379.246905433164;5384.3655532515395;5369.785208591613;5380.865478363072;5412.810551630752;5430;5433.646812957303;5084.542391184811;5297.920531191958;5303;5303.602229832701;5332.6000549958135;5185.585153187661;5203.479652034917;5220.686758794484;5221.303076500077;5224.869378265574;5800.767969281182;5936.406359364202;5998.400159983967;6074.7266373012435;6175.413335733098;4343.04453020335;4350.73895566267;4355.499117601516;4365.214261432846;4368.541303163122;5758.193852860519;5808.5643576732755;6042.75828966854;6043.758249669964;6044.818655440168;5799.362070172193;5817.621854579439;5838.474537291664;5858.9121163181735;5864.237649105589;5736.311642602915;5820.359760426265;5834.862201870595;5840.1531777892815;5851.297844258716;5601.691906945157;5652.6043176978865;5744.885102298014;5845.678487683218;5849.415058494116;5790.913136303043;5803.593748437737;5810.796622118206;5861.6189947653265;5869.647821130746;5498.835034948958;5648.71756412186;5684.431556844283;5707.229524014371;5726.742296596746 11:58:11 INFO - PROCESS | 10904 | |5;yui.html;791.6279348706106;809.198893095835;811.5779794506857;838.1869586501092;852.7100785732849;16321.347146114156;17138.400155994543;17215;17275.48173554794;17329;14713.043652162629;14954.850451495482;15016.174110423923;15038.924805375958;15065.623359415993;710.3642240195022;729.6898818002354;840.3403328387217;848.7581039403772;861.4142383179435;865.0873328638285;865.6061492021147;866.9609867555976;867.0505796153202;867.9045305016443;921.1203300847708;922.377395258198;923.5890028937125;924.0389994405809;924.1359329027347;751.5866273549553;773.1688434932414;773.9938080495333;777.8755399136168;921.2169655792557;644.4940721533574;655.8163714160042;673.188807486977;674.3559900295206;674.5177198303188;13269.734605307936;13274.070815042951;13293.86706132936;13293.933530332286;13319.067665263436;15085.24573771307;15276;15386.615334616725;15478.613034674223;15665.843341566553;13982.161070335813;14038.438462461489;14058.578242652737;14095.154290742486;14383.137011779327;4101.179764047202;4495.100979804052;4496.213162696515;4611.354410382549;4673.672842900998;82470;83143.58428207881;83164.58417707933;83656;84518.57740711258;11626.76746465066;12049.759004819854;12134.271943683407;12249.632511024683;12449.253044817158;21239.256626018014;21384.893075534834;21393.78606213949;21403.892980534998;21406;8711.60797764102;8870.119315320588;8905.51019693923;8919.821603567892;9040.547972601475;5056.797728090909;5176.197689358156;5188.636795424284;5303.7878484860175;5368.489993450616;3584.964150358463;3710.3135919854913;3732.992092135108;3733;3736.308782875177;675.5642610516189;678.7115475922811;685.530411668009;692.6121372031679;706.7808031146232;739.5303981971487;773.1842905734504;775.968961241544;778.4900889917113;784.1531146361915;10053.849192262122;10234.667225992662;10301.433421161759;10573.2598718089;10637.46812659364;678.2674711311771;720.7405334079727;725.8512005038955;727.665273973978;737.5242968285426;4764.280369169369;5134;5143.125668636266;5154.072266991978;5182.326297581366;76385.61807190928;76699.61650191713;77969.22030779732;81185.18814811777;81808.18191818125;89457;119948.40025799815;120363.39818300852;121257.39371303088;122157.38921305336;88452.11547884568;90229.54885225532;91152.54423727971;91866.2334495992;92177.53911230536;9677.322587419094;10562.260641755003;10684.57261709523;10708.839367409339;10728.678139655824;53541;54119.729401354314;54155.72922135364;54361.45638543564;56229.71885140548;70366.64816675884;76911;80778;82149.58925205335;82179;13733;13925.512607058705;13978.65053373633;14127.951447039915;14223.288835557974;15723.685526289182;15731.842681573038;16255.837441625432;16412.507624771275;16638.584035399213;10774.892251077388;13934;14839.554813355617;15493.070415774639;15655.530334089995;12967.546135885199;13316.40076196554;13712.108712933627;13724.725505489634;13862.86137138656;13533.593992180251;13636.975208670736;14375;14519.637009074435;14949.252537373306;12080.30926549445;12178.269303841798;12279.079069070034;12832.165909215872;12853.742925141258;12753.744925101631;12858.292793896426;12889.742205155657;12935.353232338533;13103 11:58:11 INFO - PROCESS | 10904 | __end_tp_report 11:58:11 INFO - PROCESS | 10904 | __start_cc_report 11:58:11 INFO - PROCESS | 10904 | _x_x_mozilla_cycle_collect,1116 11:58:11 INFO - PROCESS | 10904 | __end_cc_report 11:58:11 INFO - PROCESS | 10904 | __startTimestamp1478548691079__endTimestamp 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | ------- Summary: start ------- 11:58:11 INFO - PROCESS | 10904 | Number of tests: 6 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#0] dojo.html Cycles:165 Average:5732.40 Median:5910.53 stddev:664.43 (11.2%) stddev-sans-first:636.39 11:58:11 INFO - PROCESS | 10904 | Values: 3213.3 3247.1 3258.8 3272.0 3294.6 5798.4 5839.2 5858.2 5865.0 5890.4 5806.9 5867.4 5869.6 5870.1 5882.6 5253.6 5281.6 5294.5 5303.9 5362.3 5089.0 5119.4 5350.9 5367.5 5370.5 5186.0 5234.6 5239.8 5240.0 5240.0 5191.8 5205.6 5223.5 5223.6 5279.4 5239.3 5242.5 5243.7 5327.8 5334.9 5569.9 5795.8 5813.1 5854.7 5886.4 6020.9 6028.5 6035.7 6075.1 6106.8 6129.3 6152.8 6159.9 6172.0 6203.8 5591.9 5770.4 5783.2 5790.2 5803.4 6130.6 6223.1 6263.1 6286.5 6366.1 6119.7 6120.8 6127.2 6130.1 6139.8 5983.0 6209.5 6217.2 6218.7 6221.9 5996.7 6073.8 6125.8 6127.3 6172.7 6134.0 6169.3 6182.9 6188.2 6195.1 4757.2 4757.5 4762.3 4766.4 4782.0 4066.6 4097.9 4162.4 4214.0 4228.9 5870.1 5908.1 5909.1 5910.5 5931.4 6267.6 6270.2 6277.7 6293.1 6293.3 5648.4 5664.7 5724.0 5765.8 5888.7 5245.9 5251.7 5254.4 5275.2 5280.0 6333.7 6359.4 6362.7 6393.1 6395.3 6069.0 6101.7 6121.1 6139.2 6240.2 6475.5 6479.3 6485.8 6497.2 6505.5 6137.4 6142.3 6155.8 6156.3 6162.4 5951.7 6054.7 6232.5 6236.8 6240.3 6032.1 6041.7 6062.4 6119.8 6123.4 6099.0 6102.8 6108.3 6110.3 6139.8 5821.9 6022.5 6063.4 6064.4 6075.2 5863.8 5886.7 5903.1 5917.8 6022.3 5812.0 5835.1 5837.7 5838.0 5843.0 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#1] ext.html Cycles:180 Average:69472.94 Median:40764.08 stddev:148012.49 (363.1%) stddev-sans-first:148337.36 11:58:11 INFO - PROCESS | 10904 | Values: 592.5 634.9 650.9 656.9 681.8 33564.5 34171.1 37408.3 45918.0 46894.8 47897.3 48040.0 48410.0 48483.5 48553.5 9251.0 9429.3 9440.5 9444.4 9446.2 8638.7 8803.7 8814.5 9011.6 9098.0 11036.2 11301.7 11304.5 11636.2 11643.8 11116.8 11178.3 11192.4 11193.2 11202.4 11141.9 11199.8 11201.3 11205.2 11206.6 44919.3 45167.3 45221.0 45232.3 45261.5 3770.3 3777.8 4327.8 4374.6 4470.3 34124.8 34270.5 34302.0 34343.8 34624.3 4573.4 4618.0 4618.1 4631.5 4653.9 387498.0 388168.1 391562.0 391635.0 392990.0 61372.0 61559.0 61697.0 62013.0 62099.4 40151.0 40930.2 41113.0 43723.8 43756.0 19768.5 20018.8 20032.1 20046.2 20051.1 15157.5 15240.3 15246.5 15249.0 15256.1 18009.2 18710.4 19706.0 20257.6 20602.3 7412.8 7601.8 7680.5 7842.8 7879.3 985.4 1132.1 1185.8 1198.6 1203.7 34126.7 35317.6 35619.4 35791.3 35907.1 1143.8 1158.2 1205.8 1211.9 1260.8 18564.4 18664.8 18699.8 18793.7 18843.2 594848.0 602842.0 606084.0 627487.0 970117.0 64767.7 65230.7 65420.0 65598.0 65794.3 1346.7 1391.2 1457.5 1466.6 1495.5 32573.2 35070.0 35344.0 37088.0 37941.0 59845.4 60110.1 60383.4 60516.0 60632.7 530772.0 533067.0 533496.0 535274.0 535926.0 27952.9 31445.4 32562.2 32585.0 32610.7 39182.0 43224.6 48303.3 53391.2 53427.5 42998.8 43782.6 44008.0 44213.3 44531.6 43490.0 44320.1 44414.8 44536.3 45408.5 45280.5 45417.5 45492.0 45850.0 46341.3 36928.0 40056.6 40371.2 40527.6 40598.0 29538.0 29870.3 30275.5 30370.5 30408.5 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#2] jquery.html Cycles:180 Average:30585.91 Median:2145.11 stddev:87360.54 (4072.5%) stddev-sans-first:87576.27 11:58:11 INFO - PROCESS | 10904 | Values: 431.6 441.1 442.3 444.0 448.2 19028.1 19462.1 20777.2 20892.4 20961.5 19128.9 19448.2 19578.3 19604.3 19690.3 5937.4 6240.8 6243.0 6250.3 6250.8 5766.5 6039.5 6082.9 6092.6 6191.9 6138.4 6139.9 6142.6 6144.5 6149.0 6025.8 6834.4 6864.6 6895.7 6906.1 5920.0 6071.7 6195.5 6197.4 6197.6 15150.7 15394.5 15395.9 16391.6 23784.2 2384.0 2434.1 2524.2 2590.3 2616.4 10509.2 11071.6 11279.8 11297.1 11501.9 1938.6 1967.3 2017.8 2063.6 2070.0 64544.0 87205.6 91515.5 91916.1 93251.5 11721.4 11823.2 11894.3 12038.9 12234.0 17218.6 17220.3 17220.4 17238.7 17258.7 9053.6 9095.2 9100.4 9169.0 9462.4 8875.7 8983.6 9036.7 9193.1 9276.9 5081.2 5220.8 5225.3 5239.8 5332.6 2112.3 2133.4 2139.1 2143.4 2146.8 956.2 981.7 1015.5 1048.5 1107.6 19577.1 19953.7 20004.9 20307.7 20465.7 1037.1 1038.3 1054.9 1075.9 1105.3 10572.3 11208.0 11436.8 11522.4 11573.7 509107.0 532435.0 534522.0 535397.0 541132.0 70592.0 80921.6 97291.5 100709.0 101067.5 1010.8 1049.4 1061.5 1088.4 1090.6 18099.8 18307.3 18367.3 18543.9 18920.4 45009.8 45232.1 45459.8 45711.8 45952.1 60166.4 60192.4 61319.4 61494.4 62091.4 5832.3 7029.4 7563.7 8702.6 8912.3 8366.6 12061.9 13660.5 13685.2 13982.9 12294.4 12460.8 12501.7 12515.6 12561.4 11919.6 11942.0 12103.3 12362.4 12593.8 11301.8 11694.8 11822.6 12033.1 12536.7 8481.0 8488.5 8589.4 8687.3 8849.4 8994.6 11240.3 11726.4 11877.4 12299.0 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#3] mootools.html Cycles:180 Average:6521.11 Median:4565.43 stddev:3770.94 (82.6%) stddev-sans-first:3762.28 11:58:11 INFO - PROCESS | 10904 | Values: 1452.7 1525.3 1664.6 1827.4 1861.1 9322.5 10104.1 10115.1 10122.7 10125.2 8620.3 8864.0 9408.1 9676.6 9970.3 2601.9 2625.8 2630.1 2633.6 2637.4 2540.7 2620.7 2626.6 2629.4 2630.4 2610.6 2623.1 2643.5 2648.9 2654.5 2488.5 2496.8 2592.8 2596.0 2596.4 2481.0 2511.5 2530.1 2568.2 2598.1 9938.5 9984.3 10028.0 10034.6 10038.2 5581.7 5766.3 5766.9 5768.4 5775.7 3603.4 3700.8 3773.2 3787.3 3802.6 1209.7 1260.6 1281.1 1302.9 1311.7 13984.4 14026.6 14073.6 14074.4 14083.3 4870.6 5040.8 5176.6 5208.3 5253.9 11607.5 11639.7 11640.4 11641.3 11658.3 5836.4 5840.8 5843.0 5844.6 5847.6 4662.5 4774.5 5328.0 5341.2 5382.6 4430.2 4444.8 4530.5 4579.2 4712.7 1425.2 1449.9 1454.5 1459.4 1473.5 1063.7 1072.6 1091.9 1095.6 1104.1 6596.7 6597.4 6797.3 6857.8 6919.0 481.1 520.5 522.9 523.2 530.3 4551.7 4664.6 4672.6 4689.2 4756.5 12053.9 12289.4 12541.2 12546.7 12588.0 12253.5 12422.4 12427.4 12429.3 12440.6 9052.6 9323.6 9357.7 9365.3 9416.4 6632.3 6665.5 6677.9 6709.9 6777.1 11302.3 11458.5 11485.6 11514.4 11577.2 11431.4 11526.0 11607.7 11739.2 11786.1 7339.3 8285.7 8454.0 8619.3 8642.2 9826.6 9939.3 9941.4 9943.3 9945.1 8566.8 8658.0 8683.2 8718.5 8867.8 8526.2 8611.4 8630.9 8730.5 8747.6 7880.7 7881.9 7974.7 7979.6 7982.1 5854.1 5896.2 5994.4 5994.8 6099.6 5931.4 5950.1 5978.6 6106.3 6276.9 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#4] prototype.html Cycles:180 Average:4748.47 Median:5241.45 stddev:1352.61 (25.8%) stddev-sans-first:1315.65 11:58:11 INFO - PROCESS | 10904 | Values: 357.7 366.2 366.8 373.2 376.6 5658.0 5669.9 5671.2 5701.3 5701.7 5316.5 5519.3 5614.4 5639.4 5647.9 4381.0 4420.9 4422.7 4442.1 4455.4 4428.6 4433.0 4433.4 4452.8 4465.7 4357.6 4371.7 4373.9 4395.3 4418.4 4237.0 4362.6 4376.2 4383.1 4405.4 3920.1 3939.6 3945.3 3945.9 3952.6 5423.0 5442.9 5453.6 5459.0 5463.7 4729.7 4941.8 4990.2 4995.8 5091.4 5776.9 5779.3 5785.7 5798.7 5806.2 4212.6 4227.3 4232.3 4243.7 4246.0 5653.2 5837.8 5877.3 5942.8 6090.0 4201.2 4308.3 4321.5 4342.8 4360.0 4417.5 4420.8 4421.6 4435.9 4459.5 4603.7 4621.5 4938.5 4986.7 4995.2 5790.8 5801.8 5805.8 5826.2 5828.3 1494.8 1520.8 1523.0 1527.7 1532.6 950.1 966.9 970.8 982.3 986.0 4925.4 4929.6 4944.5 4958.6 4960.0 5217.9 5220.9 5223.9 5239.6 5243.3 4760.8 4912.4 4931.9 4977.8 5006.8 2786.5 2787.0 2789.3 2791.4 2795.9 5357.3 5385.3 5395.6 5421.8 5440.4 5062.7 5346.9 5374.4 5379.2 5384.4 5369.8 5380.9 5412.8 5430.0 5433.6 5084.5 5297.9 5303.0 5303.6 5332.6 5185.6 5203.5 5220.7 5221.3 5224.9 5800.8 5936.4 5998.4 6074.7 6175.4 4343.0 4350.7 4355.5 4365.2 4368.5 5758.2 5808.6 6042.8 6043.8 6044.8 5799.4 5817.6 5838.5 5858.9 5864.2 5736.3 5820.4 5834.9 5840.2 5851.3 5601.7 5652.6 5744.9 5845.7 5849.4 5790.9 5803.6 5810.8 5861.6 5869.6 5498.8 5648.7 5684.4 5707.2 5726.7 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - PROCESS | 10904 | [#5] yui.html Cycles:180 Average:21150.94 Median:4553.78 stddev:29540.85 (648.7%) stddev-sans-first:29584.17 11:58:11 INFO - PROCESS | 10904 | Values: 791.6 809.2 811.6 838.2 852.7 16321.3 17138.4 17215.0 17275.5 17329.0 14713.0 14954.9 15016.2 15038.9 15065.6 710.4 729.7 840.3 848.8 861.4 865.1 865.6 867.0 867.1 867.9 921.1 922.4 923.6 924.0 924.1 751.6 773.2 774.0 777.9 921.2 644.5 655.8 673.2 674.4 674.5 13269.7 13274.1 13293.9 13293.9 13319.1 15085.2 15276.0 15386.6 15478.6 15665.8 13982.2 14038.4 14058.6 14095.2 14383.1 4101.2 4495.1 4496.2 4611.4 4673.7 82470.0 83143.6 83164.6 83656.0 84518.6 11626.8 12049.8 12134.3 12249.6 12449.3 21239.3 21384.9 21393.8 21403.9 21406.0 8711.6 8870.1 8905.5 8919.8 9040.5 5056.8 5176.2 5188.6 5303.8 5368.5 3585.0 3710.3 3733.0 3733.0 3736.3 675.6 678.7 685.5 692.6 706.8 739.5 773.2 776.0 778.5 784.2 10053.8 10234.7 10301.4 10573.3 10637.5 678.3 720.7 725.9 727.7 737.5 4764.3 5134.0 5143.1 5154.1 5182.3 76385.6 76699.6 77969.2 81185.2 81808.2 89457.0 119948.4 120363.4 121257.4 122157.4 88452.1 90229.5 91152.5 91866.2 92177.5 9677.3 10562.3 10684.6 10708.8 10728.7 53541.0 54119.7 54155.7 54361.5 56229.7 70366.6 76911.0 80778.0 82149.6 82179.0 13733.0 13925.5 13978.7 14128.0 14223.3 15723.7 15731.8 16255.8 16412.5 16638.6 10774.9 13934.0 14839.6 15493.1 15655.5 12967.5 13316.4 13712.1 13724.7 13862.9 13533.6 13637.0 14375.0 14519.6 14949.3 12080.3 12178.3 12279.1 12832.2 12853.7 12753.7 12858.3 12889.7 12935.4 13103.0 11:58:11 INFO - PROCESS | 10904 | -------- Summary: end -------- 11:58:11 INFO - PROCESS | 10904 | 11:58:11 INFO - TEST-INFO | 10904: exit 0 11:58:11 INFO - TEST-OK | dromaeo_css | took 1114130ms 11:58:11 INFO - TEST-START | kraken 11:58:11 INFO - operating with platform_type : linux_ 11:58:11 INFO - Initialising browser for kraken test... 11:58:11 INFO - TEST-INFO | started process 11225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3D5SUj/profile http://localhost:49594/getInfo.html) 11:58:15 INFO - PROCESS | 11225 | __metrics Screen width/height:1600/1200 11:58:15 INFO - PROCESS | 11225 | colorDepth:24 11:58:15 INFO - PROCESS | 11225 | Browser inner width/height: 1024/697 11:58:15 INFO - PROCESS | 11225 | __metrics 11:58:16 INFO - PROCESS | 11225 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:58:16 INFO - PROCESS | 11225 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:58:16 INFO - PROCESS | 11225 | console.error: PushService: 11:58:16 INFO - PROCESS | 11225 | stateChangeProcessEnqueue: Error transitioning state 11:58:16 INFO - PROCESS | 11225 | UnknownError 11:58:17 INFO - TEST-INFO | 11225: exit 0 11:58:17 INFO - Browser initialized. 11:58:17 INFO - Running cycle 1/1 for kraken test... 11:58:17 INFO - TEST-INFO | started process 11316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3D5SUj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:58:28 INFO - PROCESS | 11316 | RSS: Main: 148254720 11:58:28 INFO - PROCESS | 11316 | 11:58:31 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:32 INFO - PROCESS | 11316 | RSS: Main: 189775872 11:58:32 INFO - PROCESS | 11316 | 11:58:34 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-dft) 11:58:35 INFO - PROCESS | 11316 | RSS: Main: 179265536 11:58:35 INFO - PROCESS | 11316 | 11:58:38 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-fft) 11:58:38 INFO - PROCESS | 11316 | RSS: Main: 270643200 11:58:38 INFO - PROCESS | 11316 | 11:58:40 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-oscillator) 11:58:41 INFO - PROCESS | 11316 | RSS: Main: 176451584 11:58:41 INFO - PROCESS | 11316 | 11:58:43 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:44 INFO - PROCESS | 11316 | RSS: Main: 178655232 11:58:44 INFO - PROCESS | 11316 | 11:58:47 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:47 INFO - PROCESS | 11316 | RSS: Main: 214536192 11:58:47 INFO - PROCESS | 11316 | 11:58:50 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:51 INFO - PROCESS | 11316 | RSS: Main: 213344256 11:58:51 INFO - PROCESS | 11316 | 11:58:54 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49594/tests/kraken/driver.html?testName=json-parse-financial) 11:58:54 INFO - PROCESS | 11316 | RSS: Main: 213020672 11:58:54 INFO - PROCESS | 11316 | 11:58:56 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:56 INFO - PROCESS | 11316 | RSS: Main: 174841856 11:58:56 INFO - PROCESS | 11316 | 11:58:58 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:59 INFO - PROCESS | 11316 | RSS: Main: 182558720 11:58:59 INFO - PROCESS | 11316 | 11:59:01 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:01 INFO - PROCESS | 11316 | RSS: Main: 189276160 11:59:01 INFO - PROCESS | 11316 | 11:59:04 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:05 INFO - PROCESS | 11316 | RSS: Main: 198406144 11:59:05 INFO - PROCESS | 11316 | 11:59:07 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:08 INFO - PROCESS | 11316 | RSS: Main: 194174976 11:59:08 INFO - PROCESS | 11316 | 11:59:09 INFO - PROCESS | 11316 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49594/tests/kraken/driver.html?testName=ai-astar) 11:59:10 INFO - PROCESS | 11316 | RSS: Main: 245403648 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | __start_tp_report 11:59:10 INFO - PROCESS | 11316 | _x_x_mozilla_page_load 11:59:10 INFO - PROCESS | 11316 | _x_x_mozilla_page_load_details 11:59:10 INFO - PROCESS | 11316 | |i|pagename|runs| 11:59:10 INFO - PROCESS | 11316 | |0;ai-astar;107;110;110;110;110;111;110;110;109;110 11:59:10 INFO - PROCESS | 11316 | |1;audio-beat-detection;140;117;117;156;120;116;116;116;145;117 11:59:10 INFO - PROCESS | 11316 | |2;audio-dft;163;161;162;162;162;161;161;160;160;162 11:59:10 INFO - PROCESS | 11316 | |3;audio-fft;74;75;74;119;77;76;75;75;102;74 11:59:10 INFO - PROCESS | 11316 | |4;audio-oscillator;81;82;122;82;81;81;104;81;81;115 11:59:10 INFO - PROCESS | 11316 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;117 11:59:10 INFO - PROCESS | 11316 | |6;imaging-darkroom;147;146;147;146;146;145;145;146;146;146 11:59:10 INFO - PROCESS | 11316 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;94;95 11:59:10 INFO - PROCESS | 11316 | |8;json-parse-financial;52;50;48;50;49;49;49;49;49;49 11:59:10 INFO - PROCESS | 11316 | |9;json-stringify-tinderbox;59;58;58;58;59;59;58;62;58;57 11:59:10 INFO - PROCESS | 11316 | |10;stanford-crypto-aes;73;73;72;77;74;73;79;75;79;73 11:59:10 INFO - PROCESS | 11316 | |11;stanford-crypto-ccm;120;128;131;121;120;119;115;125;157;124 11:59:10 INFO - PROCESS | 11316 | |12;stanford-crypto-pbkdf2;156;157;156;153;154;154;153;154;156;155 11:59:10 INFO - PROCESS | 11316 | |13;stanford-crypto-sha256-iterative;66;65;62;62;62;63;62;61;60;60 11:59:10 INFO - PROCESS | 11316 | __end_tp_report 11:59:10 INFO - PROCESS | 11316 | __start_cc_report 11:59:10 INFO - PROCESS | 11316 | _x_x_mozilla_cycle_collect,1592 11:59:10 INFO - PROCESS | 11316 | __end_cc_report 11:59:10 INFO - PROCESS | 11316 | __startTimestamp1478548750178__endTimestamp 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | ------- Summary: start ------- 11:59:10 INFO - PROCESS | 11316 | Number of tests: 14 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.06 (1.0%) stddev-sans-first:0.50 11:59:10 INFO - PROCESS | 11316 | Values: 107.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:118.50 stddev:15.04 (12.7%) stddev-sans-first:15.08 11:59:10 INFO - PROCESS | 11316 | Values: 140.0 117.0 117.0 156.0 120.0 116.0 116.0 116.0 145.0 117.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 11:59:10 INFO - PROCESS | 11316 | Values: 163.0 161.0 162.0 162.0 162.0 161.0 161.0 160.0 160.0 162.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:15.52 (20.7%) stddev-sans-first:16.19 11:59:10 INFO - PROCESS | 11316 | Values: 74.0 75.0 74.0 119.0 77.0 76.0 75.0 75.0 102.0 74.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:81.00 stddev:16.22 (20.0%) stddev-sans-first:16.80 11:59:10 INFO - PROCESS | 11316 | Values: 81.0 82.0 122.0 82.0 81.0 81.0 104.0 81.0 81.0 115.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:59:10 INFO - PROCESS | 11316 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 11:59:10 INFO - PROCESS | 11316 | Values: 147.0 146.0 147.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:59:10 INFO - PROCESS | 11316 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:1.07 (2.2%) stddev-sans-first:0.60 11:59:10 INFO - PROCESS | 11316 | Values: 52.0 50.0 48.0 50.0 49.0 49.0 49.0 49.0 49.0 49.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:58.50 stddev:1.35 (2.3%) stddev-sans-first:1.42 11:59:10 INFO - PROCESS | 11316 | Values: 59.0 58.0 58.0 58.0 59.0 59.0 58.0 62.0 58.0 57.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.50 stddev:2.62 (3.5%) stddev-sans-first:2.69 11:59:10 INFO - PROCESS | 11316 | Values: 73.0 73.0 72.0 77.0 74.0 73.0 79.0 75.0 79.0 73.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:124.50 stddev:11.84 (9.5%) stddev-sans-first:12.36 11:59:10 INFO - PROCESS | 11316 | Values: 120.0 128.0 131.0 121.0 120.0 119.0 115.0 125.0 157.0 124.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 11:59:10 INFO - PROCESS | 11316 | Values: 156.0 157.0 156.0 153.0 154.0 154.0 153.0 154.0 156.0 155.0 11:59:10 INFO - PROCESS | 11316 | 11:59:10 INFO - PROCESS | 11316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.95 (3.1%) stddev-sans-first:1.54 11:59:10 INFO - PROCESS | 11316 | Values: 66.0 65.0 62.0 62.0 62.0 63.0 62.0 61.0 60.0 60.0 11:59:10 INFO - PROCESS | 11316 | -------- Summary: end -------- 11:59:10 INFO - PROCESS | 11316 | 11:59:11 INFO - TEST-INFO | 11316: exit 0 11:59:11 INFO - TEST-OK | kraken | took 59410ms 11:59:11 INFO - SUITE-END | took 1173s 11:59:11 INFO - Completed test suite (00:19:33) 11:59:11 INFO - javascript benchmark 11:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3213.2609499815044, 3247.1395080303714, 3258.788178768378, 3272.0, 3294.6375898651145, 5798.362180160184, 5839.182514447975, 5858.20914176586, 5864.970675146629, 5890.440408161223, 5806.912896306559, 5867.413258674131, 5869.618474799135, 5870.060790273546, 5882.588218824684, 5253.60597955152, 5281.603879709018, 5294.470552944713, 5303.867403314909, 5362.302900622933, 5089.033083714083, 5119.411267704206, 5350.91973620396, 5367.543758780489, 5370.516653501184, 5186.0, 5234.6335756497065, 5239.842804715865, 5240.0, 5240.030594340059, 5191.792328306863, 5205.583553315726, 5223.451537588575, 5223.634345595772, 5279.366476022863, 5239.345081864767, 5242.528172464458, 5243.659162154486, 5327.813526526592, 5334.91997620036, 5569.944300557024, 5795.82612521625, 5813.069908814569, 5854.707264636793, 5886.381929897385, 6020.939790602081, 6028.457438830526, 6035.668038257894, 6075.088736689532, 6106.816795496142, 6129.264488261392, 6152.815415537541, 6159.876802463926, 6172.043333283348, 6203.8138855834395, 5591.944080559224, 5770.394108618535, 5783.248177736909, 5790.160426738099, 5803.390643982406, 6130.551011451118, 6223.066540018943, 6263.123162757218, 6286.49708023357, 6366.140571022853, 6119.724612392453, 6120.785772497941, 6127.20346354971, 6130.111133885562, 6139.785107521216, 5982.970085149546, 6209.534284928648, 6217.160683307786, 6218.657973811393, 6221.9377806222265, 5996.670183139882, 6073.757049717962, 6125.754969801247, 6127.264728232641, 6172.660503672251, 6134.0, 6169.290531588835, 6182.907256391158, 6188.226471691039, 6195.101710251988, 4757.191277482836, 4757.524247575215, 4762.285657151455, 4766.380370551806, 4781.976090119597, 4066.5933406659688, 4097.8975525612095, 4162.41726158338, 4214.030772922245, 4228.91542169161, 5870.119482077723, 5908.113782932509, 5909.143174239711, 5910.527157827363, 5931.40685931412, 6267.561270711007, 6270.2475702915945, 6277.7175027123885, 6293.056041593798, 6293.339199383999, 5648.378678345379, 5664.660120392789, 5724.026915424388, 5765.769369225268, 5888.676122813286, 5245.868853278698, 5251.711155886463, 5254.448282930313, 5275.155975043975, 5280.023195708806, 6333.714982825876, 6359.427651511293, 6362.745490180433, 6393.073004414427, 6395.2645445773405, 6068.969655151696, 6101.694915254131, 6121.056693971993, 6139.154842350836, 6240.188775459162, 6475.481961442979, 6479.254885688206, 6485.77299794505, 6497.18785151856, 6505.51208659343, 6137.355577664281, 6142.2629284484365, 6155.784547540815, 6156.26124865019, 6162.414570615784, 5951.672658003851, 6054.697265136813, 6232.470240029467, 6236.75052997875, 6240.282367527792, 6032.095185722177, 6041.728122234598, 6062.36345183767, 6119.807225076679, 6123.4351415035735, 6099.0, 6102.755889764359, 6108.328083910677, 6110.346130329577, 6139.785107521216, 5821.883562328814, 6022.48808851235, 6063.363346848694, 6064.363241859718, 6075.179850720273, 5863.824085277449, 5886.676232807065, 5903.144044113494, 5917.792877249276, 6022.337542870368, 5811.970940145272, 5835.095560188178, 5837.737301821513, 5838.0, 5843.0358990767745], "value": 5686.054297536902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5022980696215, 634.873025394921, 650.8503044299814, 656.8981807819788, 681.781829814459, 33564.496532552, 34171.14572135698, 37408.25183496328, 45918.0, 46894.76552617241, 47897.28154077683, 48040.03919921599, 48410.0, 48483.515164848344, 48553.51446485534, 9251.028641992578, 9429.339946203769, 9440.480773557452, 9444.433333999981, 9446.197073248783, 8638.740837774845, 8803.691870784523, 8814.471131732116, 9011.639534418615, 9098.044705305947, 11036.227464077518, 11301.660950171508, 11304.491297891615, 11636.243644163102, 11643.825342619868, 11116.833247501294, 11178.27341222818, 11192.384418856918, 11193.16051296156, 11202.383868887207, 11141.944290278496, 11199.776004479947, 11201.327920324806, 11205.159613028974, 11206.607768728056, 44919.326210106876, 45167.322490162675, 45221.0, 45232.3215151773, 45261.547384526064, 3770.3213421584105, 3777.7722240272024, 4327.831485498898, 4374.562543745632, 4470.284754439274, 34124.82937585321, 34270.48594271088, 34302.0, 34343.82828085869, 34624.30751384983, 4573.428321459817, 4618.0, 4618.053299073682, 4631.467381251132, 4653.88365290867, 387498.0, 388168.05915970524, 391562.0, 391635.0, 392990.0, 61372.0, 61559.0, 61697.0, 62013.0, 62099.37900621026, 40151.0, 40930.1813963719, 41113.0, 43723.78138109289, 43756.0, 19768.505787355432, 20018.799812001984, 20032.098555565033, 20046.198152073754, 20051.097700603506, 15157.545273641588, 15240.314185861664, 15246.466373676869, 15249.0, 15256.084634921941, 18009.18958646864, 18710.438686839418, 19706.0, 20257.594848102955, 20602.27892023772, 7412.770376879871, 7601.847963040819, 7680.462367634212, 7842.8431431371055, 7879.290863822283, 985.3693636072919, 1132.105636547135, 1185.7509922916113, 1198.5728898979637, 1203.7050922523863, 34126.65873341235, 35317.64682353144, 35619.38315468927, 35791.284174316366, 35907.12742980555, 1143.8284257361297, 1158.177693837368, 1205.8311836342918, 1211.8666946635863, 1260.836091308124, 18564.44306670802, 18664.81335186631, 18699.813001869807, 18793.718094228596, 18843.246270149313, 594848.0, 602842.0, 606084.0, 627487.0, 970117.0, 64767.67616161889, 65230.67384663046, 65420.0, 65598.0, 65794.34205657883, 1346.7037251804588, 1391.1513976474141, 1457.5190187238186, 1466.5893549806071, 1495.521433141406, 32573.18567035843, 35070.0, 35344.0, 37088.0, 37941.0, 59845.40154598398, 60110.098348523934, 60383.396166039536, 60516.0, 60632.69683651553, 530772.0, 533067.0, 533496.0, 535274.0, 535926.0, 27952.860235698692, 31445.371092577563, 32562.185945351557, 32585.0, 32610.673893260762, 39182.0, 43224.56775432331, 48303.27545086897, 53391.199132013826, 53427.46572534225, 42998.78500607602, 43782.56217437912, 44008.00525718398, 44213.33679994867, 44531.55468445404, 43490.0, 44320.11359772722, 44414.77792611016, 44536.33195502135, 45408.54591454043, 45280.547194528954, 45417.54582454133, 45492.0, 45850.0, 46341.304880427495, 36928.0, 40056.59943400645, 40371.1925761489, 40527.59472405238, 40597.98505037398, 29538.0, 29870.25324366908, 30275.545866812456, 30370.54444183295, 30408.5438718415], "value": 21991.679255128573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.64033295120345, 441.11996566849143, 442.32103720788587, 443.99112017759643, 448.2290460408097, 19028.14373353199, 19462.12420441082, 20777.16891324349, 20892.373228803142, 20961.47596310093, 19128.904355478204, 19448.22207111714, 19578.314758983437, 19604.31384901529, 19690.326322262626, 5937.406259374071, 6240.750369985195, 6243.001119820829, 6250.281217659959, 6250.812475625716, 5766.452187042245, 6039.456448919596, 6082.908756368658, 6092.603980741238, 6191.907121393183, 6138.355472675372, 6139.938600614004, 6142.570020098595, 6144.5084393248435, 6148.969255153718, 6025.819225423223, 6834.350736680008, 6864.622445765481, 6895.724171033153, 6906.136732908387, 5920.0, 6071.696415179224, 6195.504359651217, 6197.442230199259, 6197.597156184878, 15150.696986060328, 15394.461193858273, 15395.923020384938, 16391.590210244838, 23784.16755413552, 2383.988080059606, 2434.111549284516, 2524.1544082732307, 2590.3006188329045, 2616.398228407477, 10509.159267258678, 11071.612493562767, 11279.774404511945, 11297.096232301396, 11501.924779421217, 1938.5541325495074, 1967.3114409956545, 2017.8284845788125, 2063.597598468299, 2069.9793002069937, 64544.0, 87205.56397218037, 91515.54242228813, 91916.08083919142, 93251.53374233085, 11721.421287316776, 11823.231489953298, 11894.312763043485, 12038.939805300917, 12234.0, 17218.569535761457, 17220.31118755261, 17220.397286095176, 17238.655226895393, 17258.741118883227, 9053.637854485878, 9095.181433670869, 9100.362974591715, 9168.954155229314, 9462.384944978554, 8875.689350872688, 8983.595738191798, 9036.728898132935, 9193.080691930754, 9276.860847087299, 5081.18701007837, 5220.773118317193, 5225.3207083079715, 5239.764210610531, 5332.600054995891, 2112.3451729963454, 2133.445304220914, 2139.144342263076, 2143.389134096775, 2146.8389870759443, 956.206348730552, 981.7202097402206, 1015.4973288222377, 1048.528162326956, 1107.5625128074366, 19577.1190296437, 19953.700694489595, 20004.89997550032, 20307.695384569244, 20465.693014604793, 1037.1339931157568, 1038.2576457832686, 1054.852320675106, 1075.8924107589178, 1105.3312745788842, 10572.312799667998, 11208.0, 11436.771264574661, 11522.36626985507, 11573.652790416301, 509107.0, 532435.0, 534522.0, 535397.0, 541132.0, 70592.0, 80921.59539202384, 97291.51354243325, 100709.0, 101067.4946625277, 1010.7725761703705, 1049.4018409506662, 1061.5223149582564, 1088.3633074651418, 1090.6061195675416, 18099.819001809814, 18307.267709292013, 18367.265309387476, 18543.90728046351, 18920.43238702841, 45009.77495112504, 45232.09535809331, 45459.77270113628, 45711.771441142584, 45952.08095837998, 60166.39833601608, 60192.39807602043, 61319.38680613137, 61494.385056148865, 62091.37908620856, 5832.270966129234, 7029.437644988287, 7563.659635316534, 8702.608382622924, 8912.28701703875, 8366.581670916552, 12061.879381206076, 13660.453581857011, 13685.178889266675, 13982.930085349508, 12294.385280735749, 12460.813087803508, 12501.687457813627, 12515.56195533152, 12561.37193140321, 11919.582814601446, 11942.0, 12103.33431661267, 12362.44369003379, 12593.811092833432, 11301.773964520498, 11694.766104677688, 11822.645320640395, 12033.097517686034, 12536.686582835502, 8480.95759521223, 8488.490690558587, 8589.398742088244, 8687.348448866487, 8849.380543361904, 8994.640214391351, 11240.269382490113, 11726.413679315829, 11877.406129693309, 12299.0], "value": 9644.899025372139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.6586252230725, 1525.260248779342, 1664.6337805682754, 1827.3512902919472, 1861.1345724238242, 9322.48726320053, 10104.14114800241, 10115.089641932243, 10122.696319110439, 10125.24060695447, 8620.267277281422, 8864.0, 9408.059194080588, 9676.564554595043, 9970.252231082679, 2601.895924163036, 2625.8424494530295, 2630.06632645411, 2633.552296109666, 2637.3538483071675, 2540.6824146981626, 2620.737926207383, 2626.579747240442, 2629.382095207625, 2630.408158164417, 2610.6214598883153, 2623.134365659337, 2643.524165650182, 2648.9470210595778, 2654.4558365535117, 2488.502299540099, 2496.8002559795264, 2592.8185027048116, 2596.026490066225, 2596.376869551313, 2480.950380992388, 2511.522810665986, 2530.051230788454, 2568.2166939083572, 2598.1036542392844, 9938.453385063818, 9984.251181161442, 10028.0, 10034.59861605535, 10038.196944244442, 5581.748821303051, 5766.308043034821, 5766.942330576682, 5768.3654797972185, 5775.682337471438, 3603.428504790952, 3700.8149592520535, 3773.2076263984322, 3787.280416720842, 3802.6387493188104, 1209.7157168065498, 1260.5651050387694, 1281.0712233630636, 1302.8957683385306, 1311.7048664050608, 13984.370703318375, 14026.579202623938, 14073.64815879601, 14074.437022519087, 14083.2958352083, 4870.634702397334, 5040.7731652075745, 5176.5858731301405, 5208.322918020633, 5253.921191182136, 11607.535698571963, 11639.709007274885, 11640.35978021217, 11641.301521908712, 11658.30050196974, 5836.416358364215, 5840.766369345179, 5843.0, 5844.59087863854, 5847.619904706181, 4662.463816661059, 4774.498677638868, 5328.014317351302, 5341.198820177005, 5382.569394448435, 4430.180416622935, 4444.777761111932, 4530.524294949048, 4579.198640237945, 4712.69367491112, 1425.180521200314, 1449.9420023199166, 1454.4691187716408, 1459.3797636004656, 1473.4769156949344, 1063.6702622187147, 1072.5763323487179, 1091.8635170603675, 1095.5891540672249, 1104.138771758014, 6596.70314835824, 6597.406233439014, 6797.320267973262, 6857.794266172023, 6918.965405173042, 481.1339588740254, 520.456123351099, 522.882351470916, 523.1890569617154, 530.2841164428069, 4551.658625603093, 4664.580187783048, 4672.649551283667, 4689.155951928686, 4756.500567440438, 12053.939730301292, 12289.385530723428, 12541.184822986477, 12546.686332841751, 12588.0, 12253.509859605694, 12422.37888105591, 12427.37863106841, 12429.316387598768, 12440.626781196579, 9052.637894484147, 9323.627054917863, 9357.719268422094, 9365.250779937589, 9416.43501389905, 6632.303608121078, 6665.50008749336, 6677.866442671022, 6709.93290067093, 6777.1189745332795, 11302.321860688386, 11458.541658333907, 11485.598004069818, 11514.36670983104, 11577.189596728485, 11431.371274579978, 11526.0, 11607.6517704469, 11739.23694959825, 11786.116041296766, 7339.302766237199, 8285.710000149966, 8453.95773021131, 8619.310455163697, 8642.22220000203, 9826.557804898654, 9939.254555908481, 9941.403515789076, 9943.30396872212, 9945.055219754111, 8566.78583035429, 8658.047614762498, 8683.175098365646, 8718.476891386283, 8867.822643547222, 8526.190011948855, 8611.440256383315, 8630.870536941826, 8730.519821409884, 8747.64411516216, 7880.724174653859, 7881.881771773543, 7974.720884769005, 7979.561124137996, 7982.08206056311, 5854.121881717606, 5896.233489646319, 5994.400559943971, 5994.790182343771, 6099.573029887865, 5931.377205393372, 5950.10748387728, 5978.581499295007, 6106.297775755845, 6276.905846412399], "value": 5111.895411017035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.662009401116, 366.2272604803864, 366.77809924995375, 373.22369471499286, 376.63090171631785, 5657.971710141449, 5669.9433005669935, 5671.2060311556415, 5701.287339082614, 5701.657900525971, 5316.548093412064, 5519.254900588419, 5614.3543492498375, 5639.351474580424, 5647.8588035299135, 4380.978095109528, 4420.933685994696, 4422.690411671184, 4442.11157768446, 4455.443069616282, 4428.582853486885, 4432.9804145046655, 4433.401490798749, 4452.7977446089535, 4465.665075119363, 4357.629601483878, 4371.672124590653, 4373.890652733691, 4395.252807022798, 4418.381426600278, 4236.97881510592, 4362.607365337103, 4376.212281789277, 4383.123375324916, 4405.3612226227015, 3920.0591857954173, 3939.5863434339267, 3945.28984782739, 3945.861894833667, 3952.5849785772366, 5422.9728851355885, 5442.945570544283, 5453.590980676426, 5458.990086833948, 5463.726813659301, 4729.692569982974, 4941.802327906916, 4990.151674215392, 4995.800167993276, 5091.439941606421, 5776.9422305776825, 5779.306483221998, 5785.71071446426, 5798.681072541009, 5806.187133801272, 4212.641925436342, 4227.323628219501, 4232.3016702244095, 4243.745375277463, 4245.9787701061605, 5653.180288858092, 5837.795677151279, 5877.324107727623, 5942.821715348547, 6090.0, 4201.2017716634355, 4308.267594508941, 4321.524632290446, 4342.848000320037, 4359.956400436018, 4417.514073451917, 4420.801063952065, 4421.646268298528, 4435.933460998088, 4459.464864216315, 4603.746793926366, 4621.514740952219, 4938.456769755324, 4986.650934434628, 4995.225740010304, 5790.826275211751, 5801.796937107181, 5805.767769289181, 5826.184334193216, 5828.329742079631, 1494.8175663531365, 1520.7794869743825, 1523.0100434717522, 1527.732646786808, 1532.6015236038488, 950.097407462913, 966.9081437263449, 970.7621632699893, 982.3320142303303, 985.9507024648739, 4925.37462637336, 4929.580985616263, 4944.478316058836, 4958.628102892298, 4959.975200123977, 5217.9478205217465, 5220.92168617471, 5223.895522089537, 5239.633225674243, 5243.2659427680155, 4760.785764640599, 4912.38595175603, 4931.854643230206, 4977.776000080005, 5006.799728010911, 2786.456640955035, 2786.986065069662, 2789.316617428743, 2791.4417116576765, 2795.9440811183663, 5357.303550538405, 5385.3268341457315, 5395.62230643859, 5421.83734487966, 5440.401555828856, 5062.696238225718, 5346.85042715818, 5374.355077390738, 5379.246905433164, 5384.3655532515395, 5369.785208591613, 5380.865478363072, 5412.810551630752, 5430.0, 5433.646812957303, 5084.542391184811, 5297.920531191958, 5303.0, 5303.602229832701, 5332.6000549958135, 5185.585153187661, 5203.479652034917, 5220.686758794484, 5221.303076500077, 5224.869378265574, 5800.767969281182, 5936.406359364202, 5998.400159983967, 6074.7266373012435, 6175.413335733098, 4343.04453020335, 4350.73895566267, 4355.499117601516, 4365.214261432846, 4368.541303163122, 5758.193852860519, 5808.5643576732755, 6042.75828966854, 6043.758249669964, 6044.818655440168, 5799.362070172193, 5817.621854579439, 5838.474537291664, 5858.9121163181735, 5864.237649105589, 5736.311642602915, 5820.359760426265, 5834.862201870595, 5840.1531777892815, 5851.297844258716, 5601.691906945157, 5652.6043176978865, 5744.885102298014, 5845.678487683218, 5849.415058494116, 5790.913136303043, 5803.593748437737, 5810.796622118206, 5861.6189947653265, 5869.647821130746, 5498.835034948958, 5648.71756412186, 5684.431556844283, 5707.229524014371, 5726.742296596746], "value": 4326.031827925658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.6279348706106, 809.198893095835, 811.5779794506857, 838.1869586501092, 852.7100785732849, 16321.347146114156, 17138.400155994543, 17215.0, 17275.48173554794, 17329.0, 14713.043652162629, 14954.850451495482, 15016.174110423923, 15038.924805375958, 15065.623359415993, 710.3642240195022, 729.6898818002354, 840.3403328387217, 848.7581039403772, 861.4142383179435, 865.0873328638285, 865.6061492021147, 866.9609867555976, 867.0505796153202, 867.9045305016443, 921.1203300847708, 922.377395258198, 923.5890028937125, 924.0389994405809, 924.1359329027347, 751.5866273549553, 773.1688434932414, 773.9938080495333, 777.8755399136168, 921.2169655792557, 644.4940721533574, 655.8163714160042, 673.188807486977, 674.3559900295206, 674.5177198303188, 13269.734605307936, 13274.070815042951, 13293.86706132936, 13293.933530332286, 13319.067665263436, 15085.24573771307, 15276.0, 15386.615334616725, 15478.613034674223, 15665.843341566553, 13982.161070335813, 14038.438462461489, 14058.578242652737, 14095.154290742486, 14383.137011779327, 4101.179764047202, 4495.100979804052, 4496.213162696515, 4611.354410382549, 4673.672842900998, 82470.0, 83143.58428207881, 83164.58417707933, 83656.0, 84518.57740711258, 11626.76746465066, 12049.759004819854, 12134.271943683407, 12249.632511024683, 12449.253044817158, 21239.256626018014, 21384.893075534834, 21393.78606213949, 21403.892980534998, 21406.0, 8711.60797764102, 8870.119315320588, 8905.51019693923, 8919.821603567892, 9040.547972601475, 5056.797728090909, 5176.197689358156, 5188.636795424284, 5303.7878484860175, 5368.489993450616, 3584.964150358463, 3710.3135919854913, 3732.992092135108, 3733.0, 3736.308782875177, 675.5642610516189, 678.7115475922811, 685.530411668009, 692.6121372031679, 706.7808031146232, 739.5303981971487, 773.1842905734504, 775.968961241544, 778.4900889917113, 784.1531146361915, 10053.849192262122, 10234.667225992662, 10301.433421161759, 10573.2598718089, 10637.46812659364, 678.2674711311771, 720.7405334079727, 725.8512005038955, 727.665273973978, 737.5242968285426, 4764.280369169369, 5134.0, 5143.125668636266, 5154.072266991978, 5182.326297581366, 76385.61807190928, 76699.61650191713, 77969.22030779732, 81185.18814811777, 81808.18191818125, 89457.0, 119948.40025799815, 120363.39818300852, 121257.39371303088, 122157.38921305336, 88452.11547884568, 90229.54885225532, 91152.54423727971, 91866.2334495992, 92177.53911230536, 9677.322587419094, 10562.260641755003, 10684.57261709523, 10708.839367409339, 10728.678139655824, 53541.0, 54119.729401354314, 54155.72922135364, 54361.45638543564, 56229.71885140548, 70366.64816675884, 76911.0, 80778.0, 82149.58925205335, 82179.0, 13733.0, 13925.512607058705, 13978.65053373633, 14127.951447039915, 14223.288835557974, 15723.685526289182, 15731.842681573038, 16255.837441625432, 16412.507624771275, 16638.584035399213, 10774.892251077388, 13934.0, 14839.554813355617, 15493.070415774639, 15655.530334089995, 12967.546135885199, 13316.40076196554, 13712.108712933627, 13724.725505489634, 13862.86137138656, 13533.593992180251, 13636.975208670736, 14375.0, 14519.637009074435, 14949.252537373306, 12080.30926549445, 12178.269303841798, 12279.079069070034, 12832.165909215872, 12853.742925141258, 12753.744925101631, 12858.292793896426, 12889.742205155657, 12935.353232338533, 13103.0], "value": 7940.395213595262, "unit": "score"}], "name": "dromaeo_css", "value": 7720.65403122953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 117.0, 156.0, 120.0, 116.0, 116.0, 116.0, 145.0, 117.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 119.0, 77.0, 76.0, 75.0, 75.0, 102.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 122.0, 82.0, 81.0, 81.0, 104.0, 81.0, 81.0, 115.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 48.0, 50.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 62.0, 58.0, 57.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 77.0, 74.0, 73.0, 79.0, 75.0, 79.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 128.0, 131.0, 121.0, 120.0, 119.0, 115.0, 125.0, 157.0, 124.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 156.0, 153.0, 154.0, 154.0, 153.0, 154.0, 156.0, 155.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 60.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1453.6, "alertThreshold": 2.0}]} 11:59:11 INFO - Return code: 0 11:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:11 INFO - # TBPL SUCCESS # 11:59:11 INFO - Running post-action listener: _resource_record_post_action 11:59:11 INFO - [mozharness: 2016-11-07 19:59:11.482521Z] Finished run-tests step (success) 11:59:11 INFO - Running post-run listener: _resource_record_post_run 11:59:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2334720; Write bytes: 360235008; Read time: 128; Write time: 257628 11:59:11 INFO - TinderboxPrint: CPU usage
13.0% 11:59:11 INFO - TinderboxPrint: I/O read bytes / time
2,334,720 / 128 11:59:11 INFO - TinderboxPrint: I/O write bytes / time
360,235,008 / 257,628 11:59:11 INFO - TinderboxPrint: CPU idle
8,261.7 (87.0%) 11:59:11 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 11:59:11 INFO - TinderboxPrint: Swap in / out
0 / 0 11:59:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107663360; Read time: 0; Write time: 97004 11:59:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 598016; Write bytes: 252571648; Read time: 80; Write time: 160624 11:59:12 INFO - Running post-run listener: _upload_blobber_files 11:59:12 INFO - Blob upload gear active. 11:59:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:12 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 11:59:12 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'] 11:59:12 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 11:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:16 INFO - (blobuploader) - INFO - Done attempting. 11:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:17 INFO - (blobuploader) - INFO - Done attempting. 11:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:17 INFO - (blobuploader) - INFO - Done attempting. 11:59:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:59:17 INFO - Return code: 0 11:59:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:59:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:59:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ed0ce454981fa17c33eda2aeaed2046753d48ec823b3bb1861fa926cbb38d10c5fc9f8b384ff75042b57cc2286e3df12e84090ed4deaf2371ff6ea8e898d57b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e337ecf6d3a1c9077605fac5e1f7ab32bf51a6ffc2d53babba8cc5d7ec4a7244005ac9871afa0500c3e60f915a16ea3a583b9f3e99c00731b724aa892d3e54a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef52e402f888f14ccb85412427b89dc0cefa1e06f0cd717c8a60f127c837a5522378d936d36b17e185408dac6ea957f7f1422b14eacf1f188cce87981ae00ae7"} 11:59:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:59:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:59:17 INFO - Contents: 11:59:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ed0ce454981fa17c33eda2aeaed2046753d48ec823b3bb1861fa926cbb38d10c5fc9f8b384ff75042b57cc2286e3df12e84090ed4deaf2371ff6ea8e898d57b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e337ecf6d3a1c9077605fac5e1f7ab32bf51a6ffc2d53babba8cc5d7ec4a7244005ac9871afa0500c3e60f915a16ea3a583b9f3e99c00731b724aa892d3e54a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef52e402f888f14ccb85412427b89dc0cefa1e06f0cd717c8a60f127c837a5522378d936d36b17e185408dac6ea957f7f1422b14eacf1f188cce87981ae00ae7"} 11:59:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:59:17 INFO - Copying logs to upload dir... 11:59:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:59:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.929530 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-07 11:59:17.848944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 11:59:17.852680) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ed0ce454981fa17c33eda2aeaed2046753d48ec823b3bb1861fa926cbb38d10c5fc9f8b384ff75042b57cc2286e3df12e84090ed4deaf2371ff6ea8e898d57b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e337ecf6d3a1c9077605fac5e1f7ab32bf51a6ffc2d53babba8cc5d7ec4a7244005ac9871afa0500c3e60f915a16ea3a583b9f3e99c00731b724aa892d3e54a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef52e402f888f14ccb85412427b89dc0cefa1e06f0cd717c8a60f127c837a5522378d936d36b17e185408dac6ea957f7f1422b14eacf1f188cce87981ae00ae7"} build_url:https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/Z0y9RwGbTuavsPw7kvREUw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ed0ce454981fa17c33eda2aeaed2046753d48ec823b3bb1861fa926cbb38d10c5fc9f8b384ff75042b57cc2286e3df12e84090ed4deaf2371ff6ea8e898d57b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e337ecf6d3a1c9077605fac5e1f7ab32bf51a6ffc2d53babba8cc5d7ec4a7244005ac9871afa0500c3e60f915a16ea3a583b9f3e99c00731b724aa892d3e54a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef52e402f888f14ccb85412427b89dc0cefa1e06f0cd717c8a60f127c837a5522378d936d36b17e185408dac6ea957f7f1422b14eacf1f188cce87981ae00ae7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 11:59:17.883421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:59:17.883779) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478547523.132277-510084597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:59:17.971465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 11:59:17.972313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 11:59:17.972685) ========= ========= Total master_lag: 0.20 =========