builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1477710814.78 results: success (0) buildid: 20161028172321 builduid: 75247105c33e4f1b88b4fd1f0146a128 revision: 0c44c99f7b57f8827429eb3634c406bfea2115a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.780352) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.780828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.781102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.795927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.796252) ========= 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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 20:13:34-- 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% 102M=0s 2016-10-28 20:13:35 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.967465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:34.967798) ========= 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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014666 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.018554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.018934) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0c44c99f7b57f8827429eb3634c406bfea2115a9 --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 0c44c99f7b57f8827429eb3634c406bfea2115a9 --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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 20:13:35,245 truncating revision to first 12 chars 2016-10-28 20:13:35,245 Setting DEBUG logging. 2016-10-28 20:13:35,245 attempt 1/10 2016-10-28 20:13:35,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0c44c99f7b57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 20:13:35,751 unpacking tar archive at: mozilla-aurora-0c44c99f7b57/testing/mozharness/ program finished with exit code 0 elapsedTime=0.836851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.869841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.870173) ========= script_repo_revision: 0c44c99f7b57f8827429eb3634c406bfea2115a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.870605) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.870891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 20:13:35.879856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-28 20:13:35.880137) ========= /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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:13:36 INFO - MultiFileLogger online at 20161028 20:13:36 in /builds/slave/test 20:13:36 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 20:13:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:13:36 INFO - {'append_to_log': False, 20:13:36 INFO - 'base_work_dir': '/builds/slave/test', 20:13:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:13:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:13:36 INFO - 'branch': 'Mozilla-Aurora', 20:13:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:13:36 INFO - 'config_files': ('talos/linux_config.py',), 20:13:36 INFO - 'default_actions': ('clobber', 20:13:36 INFO - 'read-buildbot-config', 20:13:36 INFO - 'download-and-extract', 20:13:36 INFO - 'populate-webroot', 20:13:36 INFO - 'create-virtualenv', 20:13:36 INFO - 'install', 20:13:36 INFO - 'run-tests'), 20:13:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:13:36 INFO - 'download_minidump_stackwalk': True, 20:13:36 INFO - 'download_symbols': 'ondemand', 20:13:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:13:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:13:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:13:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:13:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:13:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:13:36 INFO - 'installer_path': 'installer.exe', 20:13:36 INFO - 'log_level': 'info', 20:13:36 INFO - 'log_name': 'talos', 20:13:36 INFO - 'log_to_console': True, 20:13:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:13:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:13:36 INFO - 'opt_config_files': (), 20:13:36 INFO - 'pip_index': False, 20:13:36 INFO - 'sps_profile': False, 20:13:36 INFO - 'sps_profile_interval': 0, 20:13:36 INFO - 'suite': 'dromaeojs', 20:13:36 INFO - 'system_bits': '32', 20:13:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:13:36 INFO - 'title': 'talos-linux64-ix-028', 20:13:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:13:36 INFO - 'use_talos_json': True, 20:13:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:13:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:13:36 INFO - 'work_dir': 'build'} 20:13:36 INFO - [mozharness: 2016-10-29 03:13:36.197223Z] Running clobber step. 20:13:36 INFO - Running pre-action listener: _resource_record_pre_action 20:13:36 INFO - Running main action method: clobber 20:13:36 INFO - rmtree: /builds/slave/test/build 20:13:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:13:36 INFO - Running post-action listener: _resource_record_post_action 20:13:36 INFO - [mozharness: 2016-10-29 03:13:36.661473Z] Finished clobber step (success) 20:13:36 INFO - [mozharness: 2016-10-29 03:13:36.661574Z] Running read-buildbot-config step. 20:13:36 INFO - Running pre-action listener: _resource_record_pre_action 20:13:36 INFO - Running main action method: read_buildbot_config 20:13:36 INFO - Using buildbot properties: 20:13:36 INFO - { 20:13:36 INFO - "project": "", 20:13:36 INFO - "product": "firefox", 20:13:36 INFO - "script_repo_revision": "production", 20:13:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:13:36 INFO - "repository": "", 20:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:13:36 INFO - "buildid": "20161028172321", 20:13:36 INFO - "pgo_build": "True", 20:13:36 INFO - "basedir": "/builds/slave/test", 20:13:36 INFO - "buildnumber": 603, 20:13:36 INFO - "slavename": "talos-linux64-ix-028", 20:13:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:13:36 INFO - "platform": "ubuntu64_hw", 20:13:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:13:36 INFO - "branch": "mozilla-aurora", 20:13:36 INFO - "repo_path": "releases/mozilla-aurora", 20:13:36 INFO - "revision": "0c44c99f7b57f8827429eb3634c406bfea2115a9", 20:13:36 INFO - "stage_platform": "linux64-pgo", 20:13:36 INFO - "builduid": "75247105c33e4f1b88b4fd1f0146a128", 20:13:36 INFO - "slavebuilddir": "test" 20:13:36 INFO - } 20:13:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 20:13:36 INFO - Running post-action listener: _resource_record_post_action 20:13:36 INFO - [mozharness: 2016-10-29 03:13:36.664028Z] Finished read-buildbot-config step (success) 20:13:36 INFO - [mozharness: 2016-10-29 03:13:36.664117Z] Running download-and-extract step. 20:13:36 INFO - Running pre-action listener: _resource_record_pre_action 20:13:36 INFO - Running main action method: download_and_extract 20:13:36 INFO - mkdir: /builds/slave/test/build/tests 20:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:36 INFO - trying https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 20:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/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 20:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/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 20:13:37 INFO - Downloaded 1361 bytes. 20:13:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 20:13:37 INFO - Using the following test package requirements: 20:13:37 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 20:13:37 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:13:37 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:13:37 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'jsshell-linux-x86_64.zip'], 20:13:37 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:13:37 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 20:13:37 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:13:37 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:13:37 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:13:37 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 20:13:37 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:13:37 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:13:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 20:13:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:37 INFO - Fetch https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:13:37 INFO - Expected file size: 21895310 20:13:42 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 20:13:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 20:13:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 20:13:42 INFO - Expected file size: 21895310 20:13:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 20:13:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:13:47 INFO - Fetch https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 20:13:48 INFO - Expected file size: 14414081 20:13:48 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')]} 20:13:48 INFO - trying https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 20:13:48 INFO - Downloading https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/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 20:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/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 20:13:49 INFO - Downloaded 63981167 bytes. 20:13:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 20:13:49 INFO - mkdir: /builds/slave/test/properties 20:13:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:13:49 INFO - Writing to file /builds/slave/test/properties/build_url 20:13:49 INFO - Contents: 20:13:49 INFO - build_url:https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 20:13:50 INFO - Running post-action listener: _resource_record_post_action 20:13:50 INFO - Running post-action listener: set_extra_try_arguments 20:13:50 INFO - [mozharness: 2016-10-29 03:13:50.307753Z] Finished download-and-extract step (success) 20:13:50 INFO - [mozharness: 2016-10-29 03:13:50.307979Z] Running populate-webroot step. 20:13:50 INFO - Running pre-action listener: _resource_record_pre_action 20:13:50 INFO - Running main action method: populate_webroot 20:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:13:50 INFO - '--tppagecycles', 20:13:50 INFO - '7'], 20:13:50 INFO - 'tests': ['tsvgm']}}, 20:13:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:13:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:13:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:13:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['damp', 'tps']}, 20:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'tests': ['damp', 'tps']}, 20:13:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['dromaeo_dom']}, 20:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:13:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['basic_compositor_video']}, 20:13:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:13:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'other-e10s': {'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['a11yr', 20:13:50 INFO - 'ts_paint', 20:13:50 INFO - 'tpaint', 20:13:50 INFO - 'sessionrestore', 20:13:50 INFO - 'sessionrestore_no_auto_restore', 20:13:50 INFO - 'tabpaint']}, 20:13:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['tsvgx', 20:13:50 INFO - 'tsvgr_opacity', 20:13:50 INFO - 'tart', 20:13:50 INFO - 'tscrollx', 20:13:50 INFO - 'cart']}, 20:13:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:13:50 INFO - 'tsvgr_opacity', 20:13:50 INFO - 'tart', 20:13:50 INFO - 'tscrollx', 20:13:50 INFO - 'cart']}, 20:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'talos_options': ['--disable-e10s'], 20:13:50 INFO - 'tests': ['tp5o']}, 20:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'tests': ['tp5o']}, 20:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'talos_options': ['--disable-e10s', 20:13:50 INFO - '--xperf_path', 20:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:50 INFO - 'tests': ['tp5n']}, 20:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:50 INFO - 'talos_options': ['--xperf_path', 20:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:50 INFO - 'tests': ['tp5n']}}, 20:13:50 INFO - 'talos.zip': {'path': '', 20:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:13:50 INFO - Running post-action listener: _resource_record_post_action 20:13:50 INFO - [mozharness: 2016-10-29 03:13:50.328074Z] Finished populate-webroot step (success) 20:13:50 INFO - [mozharness: 2016-10-29 03:13:50.328162Z] Running create-virtualenv step. 20:13:50 INFO - Running pre-action listener: _resource_record_pre_action 20:13:50 INFO - Running main action method: create_virtualenv 20:13:50 INFO - Creating virtualenv /builds/slave/test/build/venv 20:13:50 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 20:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:13:50 INFO - Using real prefix '/usr' 20:13:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:13:50 INFO - Installing distribute.............................................................................................................................................................................................done. 20:13:52 INFO - Installing pip.................done. 20:13:52 INFO - Return code: 0 20:13:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:13:52 INFO - Using env: {'DISPLAY': ':0', 20:13:52 INFO - 'HOME': '/home/cltbld', 20:13:52 INFO - 'LANG': 'en_US.UTF-8', 20:13:52 INFO - 'LANGUAGE': 'en_US:en', 20:13:52 INFO - 'LOGNAME': 'cltbld', 20:13:52 INFO - 'MAIL': '/var/mail/cltbld', 20:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:52 INFO - 'MOZ_NO_REMOTE': '1', 20:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:52 INFO - 'NO_EM_RESTART': '1', 20:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:52 INFO - 'PWD': '/builds/slave/test', 20:13:52 INFO - 'SHELL': '/bin/bash', 20:13:52 INFO - 'SHLVL': '1', 20:13:52 INFO - 'TERM': 'linux', 20:13:52 INFO - 'TMOUT': '86400', 20:13:52 INFO - 'USER': 'cltbld', 20:13:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:52 INFO - '_': '/tools/buildbot/bin/python'} 20:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:53 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 20:13:53 INFO - Cleaning up... 20:13:53 INFO - Return code: 0 20:13:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:13:53 INFO - Using env: {'DISPLAY': ':0', 20:13:53 INFO - 'HOME': '/home/cltbld', 20:13:53 INFO - 'LANG': 'en_US.UTF-8', 20:13:53 INFO - 'LANGUAGE': 'en_US:en', 20:13:53 INFO - 'LOGNAME': 'cltbld', 20:13:53 INFO - 'MAIL': '/var/mail/cltbld', 20:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:53 INFO - 'MOZ_NO_REMOTE': '1', 20:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:53 INFO - 'NO_EM_RESTART': '1', 20:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:53 INFO - 'PWD': '/builds/slave/test', 20:13:53 INFO - 'SHELL': '/bin/bash', 20:13:53 INFO - 'SHLVL': '1', 20:13:53 INFO - 'TERM': 'linux', 20:13:53 INFO - 'TMOUT': '86400', 20:13:53 INFO - 'USER': 'cltbld', 20:13:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:53 INFO - '_': '/tools/buildbot/bin/python'} 20:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:53 INFO - Downloading/unpacking psutil>=3.1.1 20:13:53 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 20:13:53 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 20:13:53 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 20:13:53 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 20:13:53 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 20:13:53 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 20:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:55 INFO - Installing collected packages: psutil 20:13:55 INFO - Running setup.py install for psutil 20:13:55 INFO - building 'psutil._psutil_linux' extension 20:13:55 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 20:13:55 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 20:13:55 INFO - building 'psutil._psutil_posix' extension 20:13:55 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 20:13:55 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 20:13:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:56 INFO - Successfully installed psutil 20:13:56 INFO - Cleaning up... 20:13:56 INFO - Return code: 0 20:13:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:13:56 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')]} 20:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:56 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')]} 20:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:56 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:13:56 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 20:13:56 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 20:13:56 INFO - Using env: {'DISPLAY': ':0', 20:13:56 INFO - 'HOME': '/home/cltbld', 20:13:56 INFO - 'LANG': 'en_US.UTF-8', 20:13:56 INFO - 'LANGUAGE': 'en_US:en', 20:13:56 INFO - 'LOGNAME': 'cltbld', 20:13:56 INFO - 'MAIL': '/var/mail/cltbld', 20:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:56 INFO - 'MOZ_NO_REMOTE': '1', 20:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:56 INFO - 'NO_EM_RESTART': '1', 20:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:56 INFO - 'PWD': '/builds/slave/test', 20:13:56 INFO - 'SHELL': '/bin/bash', 20:13:56 INFO - 'SHLVL': '1', 20:13:56 INFO - 'TERM': 'linux', 20:13:56 INFO - 'TMOUT': '86400', 20:13:56 INFO - 'USER': 'cltbld', 20:13:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:56 INFO - '_': '/tools/buildbot/bin/python'} 20:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:13:58 INFO - Installing collected packages: mozsystemmonitor 20:13:58 INFO - Running setup.py install for mozsystemmonitor 20:13:58 INFO - Successfully installed mozsystemmonitor 20:13:58 INFO - Cleaning up... 20:13:58 INFO - Return code: 0 20:13:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:58 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:13:58 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 20:13:58 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 20:13:58 INFO - Using env: {'DISPLAY': ':0', 20:13:58 INFO - 'HOME': '/home/cltbld', 20:13:58 INFO - 'LANG': 'en_US.UTF-8', 20:13:58 INFO - 'LANGUAGE': 'en_US:en', 20:13:58 INFO - 'LOGNAME': 'cltbld', 20:13:58 INFO - 'MAIL': '/var/mail/cltbld', 20:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:58 INFO - 'MOZ_NO_REMOTE': '1', 20:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:58 INFO - 'NO_EM_RESTART': '1', 20:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:58 INFO - 'PWD': '/builds/slave/test', 20:13:58 INFO - 'SHELL': '/bin/bash', 20:13:58 INFO - 'SHLVL': '1', 20:13:58 INFO - 'TERM': 'linux', 20:13:58 INFO - 'TMOUT': '86400', 20:13:58 INFO - 'USER': 'cltbld', 20:13:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:58 INFO - '_': '/tools/buildbot/bin/python'} 20:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:58 INFO - Downloading/unpacking jsonschema==2.5.1 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:14:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:00 INFO - warning: no files found matching '*.txt' 20:14:00 INFO - no previously-included directories found matching 'build' 20:14:00 INFO - no previously-included directories found matching 'dist' 20:14:00 INFO - no previously-included directories found matching '.git*' 20:14:00 INFO - Installing collected packages: jsonschema, functools32 20:14:00 INFO - Running setup.py install for functools32 20:14:00 INFO - warning: no files found matching '*.txt' 20:14:00 INFO - no previously-included directories found matching 'build' 20:14:00 INFO - no previously-included directories found matching 'dist' 20:14:00 INFO - no previously-included directories found matching '.git*' 20:14:00 INFO - Successfully installed jsonschema functools32 20:14:01 INFO - Cleaning up... 20:14:01 INFO - Return code: 0 20:14:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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', '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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:14: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 functools32==3.2.3-2 20:14:01 INFO - Using env: {'DISPLAY': ':0', 20:14:01 INFO - 'HOME': '/home/cltbld', 20:14:01 INFO - 'LANG': 'en_US.UTF-8', 20:14:01 INFO - 'LANGUAGE': 'en_US:en', 20:14:01 INFO - 'LOGNAME': 'cltbld', 20:14:01 INFO - 'MAIL': '/var/mail/cltbld', 20:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:01 INFO - 'MOZ_NO_REMOTE': '1', 20:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:01 INFO - 'NO_EM_RESTART': '1', 20:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:01 INFO - 'PWD': '/builds/slave/test', 20:14:01 INFO - 'SHELL': '/bin/bash', 20:14:01 INFO - 'SHLVL': '1', 20:14:01 INFO - 'TERM': 'linux', 20:14:01 INFO - 'TMOUT': '86400', 20:14:01 INFO - 'USER': 'cltbld', 20:14:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:01 INFO - '_': '/tools/buildbot/bin/python'} 20:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:14:01 INFO - Cleaning up... 20:14:01 INFO - Return code: 0 20:14:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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', '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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:14: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 blobuploader==1.2.4 20:14:01 INFO - Using env: {'DISPLAY': ':0', 20:14:01 INFO - 'HOME': '/home/cltbld', 20:14:01 INFO - 'LANG': 'en_US.UTF-8', 20:14:01 INFO - 'LANGUAGE': 'en_US:en', 20:14:01 INFO - 'LOGNAME': 'cltbld', 20:14:01 INFO - 'MAIL': '/var/mail/cltbld', 20:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:01 INFO - 'MOZ_NO_REMOTE': '1', 20:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:01 INFO - 'NO_EM_RESTART': '1', 20:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:01 INFO - 'PWD': '/builds/slave/test', 20:14:01 INFO - 'SHELL': '/bin/bash', 20:14:01 INFO - 'SHLVL': '1', 20:14:01 INFO - 'TERM': 'linux', 20:14:01 INFO - 'TMOUT': '86400', 20:14:01 INFO - 'USER': 'cltbld', 20:14:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:01 INFO - '_': '/tools/buildbot/bin/python'} 20:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:01 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:01 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 20:14:01 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 20:14:01 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 20:14:01 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 20:14:01 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 20:14:01 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 20:14:03 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:04 INFO - Downloading docopt-0.6.1.tar.gz 20:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:04 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:04 INFO - Running setup.py install for blobuploader 20:14:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:04 INFO - Running setup.py install for requests 20:14:04 INFO - Running setup.py install for docopt 20:14:04 INFO - Successfully installed blobuploader requests docopt 20:14:04 INFO - Cleaning up... 20:14:04 INFO - Return code: 0 20:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:04 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14:04 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 20:14:04 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 20:14:04 INFO - Using env: {'DISPLAY': ':0', 20:14:04 INFO - 'HOME': '/home/cltbld', 20:14:04 INFO - 'LANG': 'en_US.UTF-8', 20:14:04 INFO - 'LANGUAGE': 'en_US:en', 20:14:04 INFO - 'LOGNAME': 'cltbld', 20:14:04 INFO - 'MAIL': '/var/mail/cltbld', 20:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:04 INFO - 'MOZ_NO_REMOTE': '1', 20:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:04 INFO - 'NO_EM_RESTART': '1', 20:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:04 INFO - 'PWD': '/builds/slave/test', 20:14:04 INFO - 'SHELL': '/bin/bash', 20:14:04 INFO - 'SHLVL': '1', 20:14:04 INFO - 'TERM': 'linux', 20:14:04 INFO - 'TMOUT': '86400', 20:14:04 INFO - 'USER': 'cltbld', 20:14:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:04 INFO - '_': '/tools/buildbot/bin/python'} 20:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:05 INFO - Running setup.py (path:/tmp/pip-iiNNgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:05 INFO - Running setup.py (path:/tmp/pip-fwiDhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:05 INFO - Running setup.py (path:/tmp/pip-k9MIkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:05 INFO - Running setup.py (path:/tmp/pip-ySnW3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:05 INFO - Running setup.py (path:/tmp/pip-ATAnhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:05 INFO - Running setup.py (path:/tmp/pip-pVPyo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:05 INFO - Running setup.py (path:/tmp/pip-SUNyM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:05 INFO - Running setup.py (path:/tmp/pip-sxtukm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:05 INFO - Running setup.py (path:/tmp/pip-dLjCyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:05 INFO - Running setup.py (path:/tmp/pip-Z3b3U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:05 INFO - Running setup.py (path:/tmp/pip-UZ31XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:05 INFO - Running setup.py (path:/tmp/pip-Lyfb5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:05 INFO - Running setup.py (path:/tmp/pip-wC47N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:05 INFO - Running setup.py (path:/tmp/pip-Ebg5FA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:06 INFO - Running setup.py (path:/tmp/pip-TlFOTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:06 INFO - Running setup.py (path:/tmp/pip-FHmWdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:06 INFO - Running setup.py (path:/tmp/pip-LxcBpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:06 INFO - Running setup.py install for manifestparser 20:14:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozcrash 20:14:06 INFO - Running setup.py install for mozdebug 20:14:06 INFO - Running setup.py install for mozdevice 20:14:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozfile 20:14:06 INFO - Running setup.py install for mozhttpd 20:14:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozinfo 20:14:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozInstall 20:14:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Running setup.py install for mozleak 20:14:07 INFO - Running setup.py install for mozlog 20:14:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Running setup.py install for moznetwork 20:14:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Running setup.py install for mozprocess 20:14:07 INFO - Running setup.py install for mozprofile 20:14:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Running setup.py install for mozrunner 20:14:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:07 INFO - Running setup.py install for mozscreenshot 20:14:07 INFO - Running setup.py install for moztest 20:14:07 INFO - Running setup.py install for mozversion 20:14:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:08 INFO - Cleaning up... 20:14:08 INFO - Return code: 0 20:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:08 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14:08 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 20:14:08 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 20:14:08 INFO - Using env: {'DISPLAY': ':0', 20:14:08 INFO - 'HOME': '/home/cltbld', 20:14:08 INFO - 'LANG': 'en_US.UTF-8', 20:14:08 INFO - 'LANGUAGE': 'en_US:en', 20:14:08 INFO - 'LOGNAME': 'cltbld', 20:14:08 INFO - 'MAIL': '/var/mail/cltbld', 20:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:08 INFO - 'MOZ_NO_REMOTE': '1', 20:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:08 INFO - 'NO_EM_RESTART': '1', 20:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:08 INFO - 'PWD': '/builds/slave/test', 20:14:08 INFO - 'SHELL': '/bin/bash', 20:14:08 INFO - 'SHLVL': '1', 20:14:08 INFO - 'TERM': 'linux', 20:14:08 INFO - 'TMOUT': '86400', 20:14:08 INFO - 'USER': 'cltbld', 20:14:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:08 INFO - '_': '/tools/buildbot/bin/python'} 20:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:08 INFO - Running setup.py (path:/tmp/pip-ovM3DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:08 INFO - Running setup.py (path:/tmp/pip-HX9GDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:08 INFO - Running setup.py (path:/tmp/pip-33fNm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:08 INFO - Running setup.py (path:/tmp/pip-iW37Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:08 INFO - Running setup.py (path:/tmp/pip-ubmZLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:08 INFO - Running setup.py (path:/tmp/pip-zZocmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:08 INFO - Running setup.py (path:/tmp/pip-XAf4sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:08 INFO - Running setup.py (path:/tmp/pip-LONMuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:08 INFO - Running setup.py (path:/tmp/pip-ZYT27I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:08 INFO - Running setup.py (path:/tmp/pip-zlPl4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:08 INFO - Running setup.py (path:/tmp/pip-9Lf9cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:09 INFO - Running setup.py (path:/tmp/pip-lvusLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:09 INFO - Running setup.py (path:/tmp/pip-2tPXIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:09 INFO - Running setup.py (path:/tmp/pip-uUi5fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:09 INFO - Running setup.py (path:/tmp/pip-nkGHDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:09 INFO - Running setup.py (path:/tmp/pip-MPHEj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:09 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)) 20:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:09 INFO - Running setup.py (path:/tmp/pip-HAlayy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:09 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)) 20:14:09 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)) 20:14:09 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)) 20:14:09 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)) 20:14:09 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)) 20:14:09 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)) 20:14:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:11 INFO - Downloading blessings-1.6.tar.gz 20:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:11 INFO - Installing collected packages: blessings 20:14:11 INFO - Running setup.py install for blessings 20:14:11 INFO - Successfully installed blessings 20:14:11 INFO - Cleaning up... 20:14:11 INFO - Return code: 0 20:14:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:11 INFO - Reading from file tmpfile_stdout 20:14:11 INFO - Current package versions: 20:14:11 INFO - argparse == 1.2.1 20:14:11 INFO - blessings == 1.6 20:14:11 INFO - blobuploader == 1.2.4 20:14:11 INFO - docopt == 0.6.1 20:14:11 INFO - functools32 == 3.2.3-2 20:14:11 INFO - jsonschema == 2.5.1 20:14:11 INFO - manifestparser == 1.1 20:14:11 INFO - mozInstall == 1.12 20:14:11 INFO - mozcrash == 0.17 20:14:11 INFO - mozdebug == 0.1 20:14:11 INFO - mozdevice == 0.48 20:14:11 INFO - mozfile == 1.2 20:14:11 INFO - mozhttpd == 0.7 20:14:11 INFO - mozinfo == 0.9 20:14:11 INFO - mozleak == 0.1 20:14:11 INFO - mozlog == 3.4 20:14:11 INFO - moznetwork == 0.27 20:14:11 INFO - mozprocess == 0.23 20:14:11 INFO - mozprofile == 0.28 20:14:11 INFO - mozrunner == 6.12 20:14:11 INFO - mozscreenshot == 0.1 20:14:11 INFO - mozsystemmonitor == 0.3 20:14:11 INFO - moztest == 0.7 20:14:11 INFO - mozversion == 1.4 20:14:11 INFO - psutil == 3.1.1 20:14:11 INFO - requests == 1.2.3 20:14:11 INFO - wsgiref == 0.1.2 20:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:11 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14:11 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 20:14:11 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 20:14:11 INFO - Using env: {'DISPLAY': ':0', 20:14:11 INFO - 'HOME': '/home/cltbld', 20:14:11 INFO - 'LANG': 'en_US.UTF-8', 20:14:11 INFO - 'LANGUAGE': 'en_US:en', 20:14:11 INFO - 'LOGNAME': 'cltbld', 20:14:11 INFO - 'MAIL': '/var/mail/cltbld', 20:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:11 INFO - 'MOZ_NO_REMOTE': '1', 20:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:11 INFO - 'NO_EM_RESTART': '1', 20:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:11 INFO - 'PWD': '/builds/slave/test', 20:14:11 INFO - 'SHELL': '/bin/bash', 20:14:11 INFO - 'SHLVL': '1', 20:14:11 INFO - 'TERM': 'linux', 20:14:11 INFO - 'TMOUT': '86400', 20:14:11 INFO - 'USER': 'cltbld', 20:14:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:11 INFO - '_': '/tools/buildbot/bin/python'} 20:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 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)) 20:14:12 INFO - Cleaning up... 20:14:12 INFO - Return code: 0 20:14:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:12 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')]} 20:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:12 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')]} 20:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:12 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 0x7fb5c2984f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, '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': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', '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 20:14:12 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 20:14:12 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 20:14:12 INFO - Using env: {'DISPLAY': ':0', 20:14:12 INFO - 'HOME': '/home/cltbld', 20:14:12 INFO - 'LANG': 'en_US.UTF-8', 20:14:12 INFO - 'LANGUAGE': 'en_US:en', 20:14:12 INFO - 'LOGNAME': 'cltbld', 20:14:12 INFO - 'MAIL': '/var/mail/cltbld', 20:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:12 INFO - 'MOZ_NO_REMOTE': '1', 20:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:12 INFO - 'NO_EM_RESTART': '1', 20:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:12 INFO - 'PWD': '/builds/slave/test', 20:14:12 INFO - 'SHELL': '/bin/bash', 20:14:12 INFO - 'SHLVL': '1', 20:14:12 INFO - 'TERM': 'linux', 20:14:12 INFO - 'TMOUT': '86400', 20:14:12 INFO - 'USER': 'cltbld', 20:14:12 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:12 INFO - '_': '/tools/buildbot/bin/python'} 20:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:12 INFO - Cleaning up... 20:14:12 INFO - Return code: 0 20:14:12 INFO - Running post-action listener: _resource_record_post_action 20:14:12 INFO - Running post-action listener: _start_resource_monitoring 20:14:12 INFO - Starting resource monitoring. 20:14:12 INFO - [mozharness: 2016-10-29 03:14:12.365247Z] Finished create-virtualenv step (success) 20:14:12 INFO - [mozharness: 2016-10-29 03:14:12.365733Z] Running install step. 20:14:12 INFO - Running pre-action listener: _resource_record_pre_action 20:14:12 INFO - Running main action method: install 20:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:12 INFO - Reading from file tmpfile_stdout 20:14:12 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:12 INFO - Reading from file tmpfile_stdout 20:14:12 INFO - Output received: 20:14:12 INFO - Usage: mozinstall [options] installer 20:14:12 INFO - Options: 20:14:12 INFO - -h, --help show this help message and exit 20:14:12 INFO - -d DEST, --destination=DEST 20:14:12 INFO - Directory to install application into. [default: 20:14:12 INFO - "/builds/slave/test"] 20:14:12 INFO - --app=APP Application being installed. [default: firefox] 20:14:12 INFO - mkdir: /builds/slave/test/build/application 20:14:12 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'] 20:14:12 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 20:14:28 INFO - Reading from file tmpfile_stdout 20:14:28 INFO - Output received: 20:14:28 INFO - /builds/slave/test/build/application/firefox/firefox 20:14:28 INFO - Running post-action listener: _resource_record_post_action 20:14:28 INFO - [mozharness: 2016-10-29 03:14:28.880388Z] Finished install step (success) 20:14:28 INFO - [mozharness: 2016-10-29 03:14:28.880633Z] Running run-tests step. 20:14:28 INFO - Running pre-action listener: _resource_record_pre_action 20:14:28 INFO - Running main action method: run_tests 20:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:14:28 INFO - Python 2.7.3 20:14:28 INFO - Return code: 0 20:14:28 INFO - grabbing minidump binary from tooltool 20:14:28 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')]} 20:14:28 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 0x2c47f60>, '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 0x2c48d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c491d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:14:28 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 20:14:28 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 20:14:28 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 20:14:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:14:29 INFO - Return code: 0 20:14:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:14:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:14:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:14:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:14:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:14:29 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/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 20:14:29 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/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 20:14:29 INFO - Using env: {'DISPLAY': ':0', 20:14:29 INFO - 'HOME': '/home/cltbld', 20:14:29 INFO - 'LANG': 'en_US.UTF-8', 20:14:29 INFO - 'LANGUAGE': 'en_US:en', 20:14:29 INFO - 'LOGNAME': 'cltbld', 20:14:29 INFO - 'MAIL': '/var/mail/cltbld', 20:14:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:14:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:29 INFO - 'MOZ_NO_REMOTE': '1', 20:14:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:29 INFO - 'NO_EM_RESTART': '1', 20:14:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:29 INFO - 'PWD': '/builds/slave/test', 20:14:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:14:29 INFO - 'SHELL': '/bin/bash', 20:14:29 INFO - 'SHLVL': '1', 20:14:29 INFO - 'TERM': 'linux', 20:14:29 INFO - 'TMOUT': '86400', 20:14:29 INFO - 'USER': 'cltbld', 20:14:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236', 20:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:29 INFO - '_': '/tools/buildbot/bin/python'} 20:14:29 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/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 20:14:29 INFO - mozversion application_buildid: 20161028172321 20:14:29 INFO - mozversion application_changeset: 0c44c99f7b57f8827429eb3634c406bfea2115a9 20:14:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:14:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:14:29 INFO - mozversion application_name: Firefox 20:14:29 INFO - mozversion application_remotingname: firefox-dev 20:14:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:14:29 INFO - mozversion application_vendor: Mozilla 20:14:29 INFO - mozversion application_version: 51.0a2 20:14:29 INFO - mozversion platform_buildid: 20161028172321 20:14:29 INFO - mozversion platform_changeset: 0c44c99f7b57f8827429eb3634c406bfea2115a9 20:14:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:14:29 INFO - mozversion platform_version: 51.0a2 20:14:29 INFO - using testdate: 1477710869 20:14:29 INFO - actual date: 1477710869 20:14:29 INFO - starting webserver on 'localhost:39491' 20:14:29 INFO - SUITE-START | Running 2 tests 20:14:29 INFO - TEST-START | dromaeo_css 20:14:29 INFO - operating with platform_type : linux_ 20:14:29 INFO - Initialising browser for dromaeo_css test... 20:14:29 INFO - TEST-INFO | started process 19331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBEdCx/profile http://localhost:39491/getInfo.html) 20:14:33 INFO - PROCESS | 19331 | __metrics Screen width/height:1600/1200 20:14:33 INFO - PROCESS | 19331 | colorDepth:24 20:14:33 INFO - PROCESS | 19331 | Browser inner width/height: 1024/697 20:14:33 INFO - PROCESS | 19331 | __metrics 20:14:34 INFO - PROCESS | 19331 | 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" 20:14:34 INFO - PROCESS | 19331 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:14:34 INFO - PROCESS | 19331 | console.error: PushService: 20:14:34 INFO - PROCESS | 19331 | stateChangeProcessEnqueue: Error transitioning state 20:14:34 INFO - PROCESS | 19331 | UnknownError 20:14:35 INFO - TEST-INFO | 19331: exit 0 20:14:35 INFO - Browser initialized. 20:14:35 INFO - Running cycle 1/1 for dromaeo_css test... 20:14:35 INFO - TEST-INFO | started process 19421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBEdCx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:46 INFO - PROCESS | 19421 | RSS: Main: 144928768 20:14:46 INFO - PROCESS | 19421 | 20:15:37 INFO - PROCESS | 19421 | 1477710937809 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] 20:17:47 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39491/tests/dromaeo/cssquery-ext.html) 20:17:48 INFO - PROCESS | 19421 | RSS: Main: 246714368 20:17:48 INFO - PROCESS | 19421 | 20:20:50 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-ext.html (next: http://localhost:39491/tests/dromaeo/cssquery-jquery.html) 20:20:51 INFO - PROCESS | 19421 | RSS: Main: 233697280 20:20:51 INFO - PROCESS | 19421 | 20:23:53 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39491/tests/dromaeo/cssquery-mootools.html) 20:23:53 INFO - PROCESS | 19421 | RSS: Main: 172941312 20:23:53 INFO - PROCESS | 19421 | 20:26:55 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39491/tests/dromaeo/cssquery-prototype.html) 20:26:56 INFO - PROCESS | 19421 | RSS: Main: 175116288 20:26:56 INFO - PROCESS | 19421 | 20:29:58 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39491/tests/dromaeo/cssquery-yui.html) 20:29:59 INFO - PROCESS | 19421 | RSS: Main: 177741824 20:29:59 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | Cycle 1(1): loaded http://localhost:39491/tests/dromaeo/cssquery-yui.html (next: http://localhost:39491/tests/dromaeo/cssquery-dojo.html) 20:33:02 INFO - PROCESS | 19421 | RSS: Main: 267075584 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | __start_tp_report 20:33:02 INFO - PROCESS | 19421 | _x_x_mozilla_page_load 20:33:02 INFO - PROCESS | 19421 | _x_x_mozilla_page_load_details 20:33:02 INFO - PROCESS | 19421 | |i|pagename|runs| 20:33:02 INFO - PROCESS | 19421 | |0;dojo.html;3123.7032481914216;3158.7630927680416;3180.332130252647;3212.3414699986506;3226.2740883301276;5541.612087153901;5631.887362252753;5651.519620832229;5661.631993920402;5694.572907031974;5613.80351687691;5640.661560306385;5653.547716182706;5659.122835960422;5666.235058267132;5108.4636113208135;5131.769070391822;5147.897042059157;5170.172772356424;5207.765650545734;5050.292958985745;5205.583553315744;5206.297149884755;5222.164453687411;5225.007248622749;5037.974810125944;5053.974730126344;5121.359830021247;5143.81996630118;5188.16989281715;5179.2749015137915;5263.394709608406;5269.762860671279;5271.446498117681;5293.23248129023;4967.403911530603;5086.669366491166;5171.120909445403;5214.687118772886;5231.895362092737;5462.153366228241;5468.26178465906;5527;5561.249231353756;5576.7211639417865;5851.034579294412;5881.852953676193;5885.440883116097;5940.61386009908;5941.851453713649;6020.307664618581;6026.276846778414;6031.60794548353;6032.638041717511;6040.697965101727;5439.292891924064;5480.80817171401;5490.368607610136;5521.309836270466;5541.501264886179;6038;6082.2701275847185;6088.6042407243385;6091.329953705089;6097.603655762361;5843.152742852262;5862.384449632812;5868.882622347614;5873.500752436091;5878.706064696748;5840.707964601753;5863.355030946593;5890.14592884038;5891.823245302648;5893.410658934158;5920.023196172583;5926.436988486087;5935.347111817697;5937.2578427696535;5954.523638108941;5887.941120588825;5950.345461999176;5958.821235362946;5966.164736936832;5974.372690867396;4469.575390337977;4473;4595.586397224266;4608.377868987711;4642.094791515622;4161.958380416218;4166.604172603597;4167.416561681367;4167.562405947332;4192.601702838226;5806.912896306559;5807.0998995155815;5807.245058142415;5824.980628390015;5831;5774.364819869811;5832.825015249549;5991.700414979321;6006.699665016732;6107.725152368154;5715.628484148517;5721.828345149652;5722.62802917809;5737.3688894221605;5754.136879468113;5257.316548848702;5267.841964741064;5268.868278293074;5272.314599102092;5275.314209152785;5852.502537284378;5880.676562789087;6098.969505152446;6280.403361680633;6286.748530058747;5953.821385358447;6015.2781666200335;6023.457888789854;6054;6072.05883088122;6183.783567575113;6192.071189321638;6196.47329976957;6200.162977997912;6202.751889924533;5616.241807356118;5639.943600563942;5885.14665373527;5937.8218653438735;5937.970310148422;6006.969965150146;6053.485453736305;6068;6124.289394097845;6124.564025909317;5967.731452084753;5972.761089556369;5977.7310021050025;5981.162637230704;6010;5594.524465420485;5946.791862284799;5953.255843019622;5957.6127551709;5962.612430192024;5652.971735141298;5787.074068149076;5788.392218816964;5828.0966450200285;5911.822645320647;5868.735906884286;5917.970410148094;5923.052311630118;5924.377940316204;5924.763009479572;5580.441955804387;5620.606557540933;5762.7694892203845;5790.536757059509;5799.855003624774 20:33:02 INFO - PROCESS | 19421 | |1;ext.html;586.7007826008735;637.9776707815226;663.1014974709269;666.2537957487615;672.4049216443447;34755.652443475556;45368.319475207856;46590.76704616481;46613.300800487974;46654.30018549716;48657.51342486574;49009.75495122528;49079.26381104286;49135.50864491354;49171.262431063566;8470.576471176448;9316.48759318239;9474.47890366033;9479.620815167385;9480.81038379232;8363.958180209122;8633.438826476291;8634.352423568225;10886;11142.721431964224;11428.828567571492;11478.253913495639;11487.253328533661;11491.080713542897;11491.310521368745;11275.985161335519;11285.548578056867;11293.604723834667;11306.717332066683;11364.204505684605;11074.557017719282;11161.162912781574;11173.944130279297;11174.608888688857;11177.385243811586;45901;46144.53915956283;46157.53842461566;46164.30753538699;46175;3594.7843129412317;3698.5007024051947;4236.068065025689;4363.38912552243;4544.272916333404;33755.6624433755;34099.82950085258;34382.48426273608;36113.81943090294;36762;4005.859794907164;4094.979525102385;4202.915941681149;4290.806913688892;4341.9131617367475;408534;410180;411545;411820;413088;67140;67807.66096169586;67857.66071169612;67919.32080679228;68090.65954670294;40081;40239.59760402417;40472.79763601163;43957.340639890426;70854.64572677207;17332.30670773155;17416.738748918775;17431.912840435718;17444.563885902953;17505.12474376276;14687.26563671812;14937.178455184852;14947.476838310607;14947.850521494645;14965.027273227206;19129.441512860125;19146;20013.299534516224;20609.690854637192;21281.68077478808;7642.235776422424;7758.262965018314;7793.766187014398;7843.294103530596;7892.632210336991;977.4233202410612;1024.144839059379;1059.1579694143174;1077.3051381858656;1078.7087486378791;34749.82625086858;35723;35825;35864.82067589645;35899.64100359015;1139.9772004559863;1153.7923173828792;1158.4323681396056;1203.175824560179;1203.915725899196;17792.288308467774;18066.90966545159;18213.08934553267;18217.45347639573;18349.082545872654;617017;623597;624049;624558;624774;64157.358426416075;64563.67718161379;64564.80328778614;64626;64772.67613661902;1319.0832371501906;1355.9932200338935;1411.0757453867734;1426.3011124548896;1450.7927011666252;29996.471120344286;34827.30345393129;34830.12924676904;34866.47700284447;35305.82347088351;50287;50733.23900141427;50855.2371714432;50856.491435085176;50891;335425;336008;336188;337798;338878;30592.541111882896;31252;31433.8428307857;31744.04767856968;33680.49479257862;51841;51962;51966.74016629893;52053.21920171125;52394;43465;43617.345739813296;43851;45487;46144;43335.932969383684;44777.328340075575;45262.54737452715;45950;46194.459304738564;43511.78244108759;43652;43819.56180438155;44547;44566.554334457534;37512.624873750916;39551.80224098861;39556;39901.201975960896;40256.59743402529;28065.29836754016;28846.820952475013;29117.708822912347;29160.416791663625;29225.415491690474 20:33:02 INFO - PROCESS | 19421 | |2;jquery.html;395.5984675554311;420.04143005449066;433.31752489828517;436.1690978685604;447.97312161270304;16949;20061.498462538424;21323.786762132375;21545.353639390843;21809;13526.797098043537;15961.042337459761;19937.900310498462;20527.794722052775;20642.587148257062;5489.34127904651;5695.974724549579;5698.458646428583;5701.458361455655;5704.087346024637;5430.185472179165;5521.806736764214;5564.276644036269;5564.610477266593;5566.387697353288;5570.053090974524;5570.693611851347;5575.135853942646;5576.86057848553;5578.972105139469;5418.864528386783;5559.082751346023;5622.0161471742285;5640.323161220639;5641.041023026116;5293.258943747878;5491.093969495028;5495.0383682855345;5497.532709719679;5499.4225606311165;14849.628759281104;15135.697286054326;15135.772963405447;15164.696706065817;19743.506412339662;2516.282859385085;2519.0553542421594;2613.8693065346847;2682.12830829981;3031.621047369079;10757.462126893624;10842.620508282173;11122.221444498888;11394.772104557862;11504.539818407253;1974.9506262343414;1977.4067779666043;1990.1641310649418;2009.9151833711687;2035.3385149826365;87322;87369;87564;88939.55530222307;89666.5516672419;10588.629397971188;11527.596534121265;11535.480903359368;11838.940805295919;12083.395830208454;15120.621984450478;15766.369345226292;15946.681066378607;16033.839661603235;16722.41471548514;8530.914690853013;8566.52884091381;8671.783205419915;8696.304295656333;8785.956070219736;8043.075046369625;8060.19398060201;8106.310963568045;8278;8290.792730181794;4926.482719314492;4978.427480839678;5049.242613607915;5103.566196873233;5151.5878729701535;1906.4566598519355;1966.8328192103545;2047.5597746484577;2092.8593916315644;2152.4511249631246;959.9232061435068;1001.1340190734962;1012.8987101289812;1026.4252018869456;1051.7160366700948;19965.60068798645;19987.400377988393;20218.595628087354;20305.207719137146;20762.377128686163;1013.4122209118693;1041.6093964763213;1041.7760181561;1049.8792638846478;1088.314361951981;10604.416757078434;11162;11203.43982800873;11290.774184516427;11505.137114716263;531108;532887;534569;551191;560796;95831.52084239534;97346;100179.49910250402;100336.49831750794;101639.49180254052;990.6681261777242;1037.6783197208738;1049.7480604654982;1065.4406436620682;1073.044989958937;17781.822181778018;17885.10574471297;18126;18236.270549177883;18595.256189752257;43732.56267437412;44028.559714403724;44261.557384425745;44591;46058;60657.69671151616;60876.391236087075;61685.69157154186;62315.37684623096;62935;8638.079450358717;8778.956105219433;8789.121087891159;9013.864792027995;9225;12581.811272831097;13049.543265985645;13181.472741090249;13505.662358441117;13515.459381624625;10550.155987520826;11143.83284250753;11180.608678696206;11191.944040280072;11309.886901131213;10827.729306767395;11160.497777599865;11574.826377604511;11746.29522228669;12173.147879648339;11007.779844402907;11090.611828585961;11192.944035279772;11245.325280483197;11305.773884522428;8575.3997220194;8768.473891566526;8854.203121718818;9145.314101442285;9414.19979301767;8644.827103458021;8659.00421451516;8985.236254918143;9099.226565741987;9287.117723816227 20:33:02 INFO - PROCESS | 19421 | |3;mootools.html;1366.8291463567055;1541.7841502189694;1565.8121025476942;1666.2002238925315;1832.3586744639379;7955.641996110175;8775.868361974575;9022.007579166295;9031.277497800176;9345.579448924798;9023;9076.410033347827;9080.364374493787;9086.04596517366;9090.50002249876;2520.571502844516;2547.8089143314232;2550.7576780205945;2551.5407226699185;2552.961705574418;2395.2454976682375;2480.677511923456;2481.950360992779;2483.466054798218;2483.838550494221;2378.1795280628244;2398.95202095958;2424.963625545618;2427.8057755379614;2432.781049705526;2334.463073493106;2353.670486131943;2360.799332056777;2386.4033991502124;2393.9281821545383;2367.715874095102;2371.6205407134776;2372.644103384489;2379.1553998330514;2399.712034555847;8932.910670893338;8978.461292322481;9039.276857851357;9052.8642070369;9072.8639070414;5458.972705136489;5625.54995600351;5632.633878797906;5693.402192769782;5697.914531282034;3632;3637.290728307981;3654;3683.557973043252;3701.592824789271;1200.8438902942648;1209.5585111434264;1231.6428235811604;1237.3565745812127;1240.875912408761;12295.631131066082;12358.752824943631;12370.257784532867;12393.62819115428;12401.441935112942;4720.347907484702;4737.076270127292;4893.730844803499;4900.705957642553;4933.55597996182;9899.752506187402;9904.60381584743;9910.157636600825;9911.603535858629;9913.553890074963;5574.052411090124;5578.497935185853;5601.5238704710555;5602.047651899187;5602.607817452821;4433;4606.608438282717;4653.95346046542;4660.697054691502;5241.816536421207;4004.439378487014;4031.9395209071886;4125;4132;4144.191882582867;1254.7615952968906;1257.4781465691635;1269.206745783885;1271.6693659648558;1274.3755559775643;804.8108694456798;905.7282815155427;923.5982347678647;928.1692884868005;968.3560432312574;6054.878902421927;6160.568760186744;6198.597091189148;6207.34822843604;6332.145160403379;940.4451373689556;957.2676902169845;968.4625033106553;983.5279066048193;1026.4662375564665;4039.7576145431367;4328.61042506176;4364.585364390377;4372.475302963665;4464.799084041226;11010.779784404427;11162.330260184415;11172.888271117346;11278.774424511465;11300.09599232076;11152.386618736047;11164.553417863357;11190.66428007161;11214;11223.71940701489;8105.432619716681;8286.58567071644;8383.371247156487;8556.957215213759;8580.356473264404;6315.463185629273;6343.809685709436;6498.090267362479;6537.70580323877;6596.208454985433;10139.543720532447;10401.791964160826;10427.94786026065;10567.154627629618;10605.363678179334;9650.903490965282;9711.757206069904;10236.027577380137;10448.164146868385;10612.416317102325;7567;7655.387568994356;7705.460617756928;7723.691052357843;7742.690292388466;8607.698730544402;8793.20861122502;8858.689945852122;8869.911300886908;8906.955465222632;7873.291403773688;8014.8397032057865;8043.87934180976;8055.315298199719;8297.294729948022;7340.559566426032;7352.485326027127;7450.180480147288;7555.282248186413;7572;7257.564546127249;7355.411567074728;7363.374113200223;7365.226651201761;7375.96312018458;5170.121079416433;5182.663126896739;5267.262583238273;5357.973210133924;5453.754581043783;5106.66806657566;5167.044096842096;5224.138017227115;5280.867978300574;5386.919196211981 20:33:02 INFO - PROCESS | 19421 | |4;prototype.html;349.3868261201592;358.24946736586844;364.21148214116425;368.84508506427295;370.20406126827316;5524.558035357172;5539.169124631312;5542.251796007537;5549.86125346866;5593.412691667378;5514.420985796493;5521.613487055898;5525.309336332958;5525.4474552544725;5537.972310138443;4109.363048727445;4271.658267338621;4310.719803212797;4316.20150272199;4321.395004699345;4302.913941721164;4305.332673435607;4305.526392096866;4314.913701725964;4319.222539942809;4278.315469524861;4291.806868690901;4295.506016808075;4295.527491975896;4304.31131019037;4178.9373159402785;4230.302000169968;4236.6187043166265;4257.595528424795;4301.827926882921;3722.516072910504;3722.5532936047575;3727.148731220618;3730.7015438764834;3744.775313481173;5315.8570907255125;5324.946750532523;5337.4662533746705;5341.679499230058;5376.542993845528;4763.618910487153;4853.95146048542;4875.219964805649;4898.755062246873;4919.975400123012;5701.515371193454;5702.315722113373;5711.200431939532;5713.257456475773;5728.283964504437;4128.938065929014;4130.483689538808;4133.400656904732;4134.4831896013;4137.296659567851;5832.533397328203;5882.617629854089;5895.852603684899;5926.459120628668;5954.225950626391;4131.772752498641;4134.462519872397;4138.896527586834;4152.6055024772595;4159.646430053479;4191;4192.832286708558;4204.348326009474;4210.410542524049;4218.764055050828;4617.7691115444095;4818.277258411196;4825.806967721322;4830.492798256132;4878.512148785164;5767.625104368202;5772.422757724278;5774.855628609318;5781.797637082682;5794.82615521535;1460.2260801775076;1466.9706605868037;1471.220253265771;1482.4366740638488;1484.6807936293749;904.4554764731053;927.7587827164986;943.5895385507326;945.0561500924571;948.6537413843897;4921.966387058686;4946.629002824802;4948.678335908155;4952.554270115635;4960.181570040975;5123.666961647481;5133.61287001546;5138.743062846843;5152.948470515322;5180.844574662766;4672.392588963481;4896.485868983706;4911.838790931978;4921.434035085939;4928.310036594808;2743.9451210975667;2753.3116720819794;2763.8341699498096;2774.667039955218;2790.4698107359536;5315.627906046617;5322.2282768998275;5341.439148889388;5351.705656188947;5361.678299302054;5259.08120992845;5260.658057226268;5607.812952948353;5755.510781583528;6056.636601803906;5941.881162376815;5948.405159484104;6088.573799834057;6106.175666284995;6129.233845769279;5919.4080591940465;5955.851103722442;5957.43830153021;5961.821145365646;5965.806838632204;5595.692236927008;5827.533797296291;5849.239598852122;5852.590318677822;5876.236089308362;6072.876517844213;6078.635281883101;6106.877862442815;6153.876922461436;6156.969215153896;4177.394277829759;4387.495438024668;4398.538153493837;4403.163398954189;4408.184485870124;5883.235179426647;5910.1725758392995;5912.349641539341;5921.3190483094995;5940.495057919952;5760.798372056958;5779.971100144472;5784.566157538117;5798.971005144947;5799.507041901317;5614.719264036864;5765.884682306414;5787.594868359174;5802.100674395476;5816.41835816415;5783.277090363705;5798.768049277982;5799.681017544076;5802.5357971361345;5809.128630705428;5589.944100558942;5809.186713859978;5809.506191973561;5829.504492118217;5856.560757943256;5620.662760234399;5622.297212848394;5627.493525582717;5644.491995720405;5681.2330335404195 20:33:02 INFO - PROCESS | 19421 | |5;yui.html;681.8397676546014;692.2350802363392;719.5610677486732;764.4916130773034;768.3852917665868;14190.503332383369;15266.618334541641;15268.618284542892;15292.31184596693;15313.540593782176;13981.300934953262;14105.083169593969;14120.152790832557;14125.293735313244;14173.71652566948;716.6345163966375;731.9963400182992;839.2530647723531;850.9319254459659;862.6764963138822;827.6234313387424;828.4242451496212;828.4780588229437;828.5732847583499;829.3075282139421;869.9304055675562;870.1298701298701;870.2211520688979;870.5125129927261;872.6160489384682;746.5110352718978;765.885117232414;864.4813112132733;887.5473508510642;894.695803426838;650.4471199480452;655.1123228026004;655.3741177175785;656.9080328753978;657.2179106862818;13317.400716967759;13333.266670333127;13354.33228338589;13356.599302020857;13365.398557064955;13745.175289482662;13930.58208253754;13942;13961.511347102803;14043.64890877726;12133.757324853454;12240.81638775419;12341.382930853422;12394.876051239462;12657.873421265762;4364.192624364471;4403.713758605681;4481.932771008437;4588.4723256825555;4591.632669386441;88677.55661221653;90476;92221.53889230578;92492.53753731189;92975;10685.145188384911;10923;10963.725906852233;11107.83338249927;11259.437028148559;19977.700334494995;20035.699464508045;20091;20108.798912010694;20128.798712012984;7996.80007999793;8126.228008339198;8160.4287699861625;8222.342212622976;8377.539235342114;4911.140550403665;5063.696178229245;5081.949180508222;5213.13983192769;5224.817131400383;3442.5008373785663;3560.359135355661;3572;3576.8569257229938;3582.570091589026;599.7780821096222;599.9130126131687;601.4286427893519;612.8467883029243;616.1281786272464;607.4168797953926;632.8734253149388;638.1990601794811;742.4718832375769;755.9470837041464;9495.975182787559;9887.806068332207;9949.55227014786;9997.450140242356;10215.693529193988;608.415078719937;668.7024274198033;706.5301574453034;727.6143643868758;782.9021372328459;4601.792919318638;4680.836170734008;4842.273658951185;4853.39332583427;4893.7063776173545;120686.39656801836;121171;121434;121947;123700;104029.47985260177;106120.46939765406;108770.45614771875;109291.45354273178;112242;96785.45324363509;98244.50877745566;99418;100039.49980250197;101367.49316253519;8992.190702836777;9074.591643376196;9113.908860911572;9199.954000229956;9255.583498742708;54553.45446545642;54584.454155457934;54661;55172.72413637906;55401;68385.65807170932;69813.30186698068;76045.23954760382;82492;83082.58458707668;12938.353082346033;13114.540991065267;13137.343132843129;13403.865961340261;13518.121322114031;14570.125792452487;14745.92627036858;15286.312115954586;15526.844731552539;15887.285072172011;13288.40202190923;13419.731605367642;13554.59336219915;14160.362783674553;14171.220582868042;13118.344082796013;13316.33418329099;13349.733005339645;14328.211948342941;14472;13219.471221151047;13238.53665121716;13385.19688818674;13627.863721362659;14919.25403729831;11100.722481938015;11787.115966302734;11866.703332416413;12076.75846483083;12285;11549;12275.570355037531;12300.200486968319;12411.317377544321;12417.31704756211 20:33:02 INFO - PROCESS | 19421 | __end_tp_report 20:33:02 INFO - PROCESS | 19421 | __start_cc_report 20:33:02 INFO - PROCESS | 19421 | _x_x_mozilla_cycle_collect,925 20:33:02 INFO - PROCESS | 19421 | __end_cc_report 20:33:02 INFO - PROCESS | 19421 | __startTimestamp1477711982430__endTimestamp 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | ------- Summary: start ------- 20:33:02 INFO - PROCESS | 19421 | Number of tests: 6 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#0] dojo.html Cycles:165 Average:5572.39 Median:5806.91 stddev:621.20 (10.7%) stddev-sans-first:592.67 20:33:02 INFO - PROCESS | 19421 | Values: 3123.7 3158.8 3180.3 3212.3 3226.3 5541.6 5631.9 5651.5 5661.6 5694.6 5613.8 5640.7 5653.5 5659.1 5666.2 5108.5 5131.8 5147.9 5170.2 5207.8 5050.3 5205.6 5206.3 5222.2 5225.0 5038.0 5054.0 5121.4 5143.8 5188.2 5179.3 5263.4 5269.8 5271.4 5293.2 4967.4 5086.7 5171.1 5214.7 5231.9 5462.2 5468.3 5527.0 5561.2 5576.7 5851.0 5881.9 5885.4 5940.6 5941.9 6020.3 6026.3 6031.6 6032.6 6040.7 5439.3 5480.8 5490.4 5521.3 5541.5 6038.0 6082.3 6088.6 6091.3 6097.6 5843.2 5862.4 5868.9 5873.5 5878.7 5840.7 5863.4 5890.1 5891.8 5893.4 5920.0 5926.4 5935.3 5937.3 5954.5 5887.9 5950.3 5958.8 5966.2 5974.4 4469.6 4473.0 4595.6 4608.4 4642.1 4162.0 4166.6 4167.4 4167.6 4192.6 5806.9 5807.1 5807.2 5825.0 5831.0 5774.4 5832.8 5991.7 6006.7 6107.7 5715.6 5721.8 5722.6 5737.4 5754.1 5257.3 5267.8 5268.9 5272.3 5275.3 5852.5 5880.7 6099.0 6280.4 6286.7 5953.8 6015.3 6023.5 6054.0 6072.1 6183.8 6192.1 6196.5 6200.2 6202.8 5616.2 5639.9 5885.1 5937.8 5938.0 6007.0 6053.5 6068.0 6124.3 6124.6 5967.7 5972.8 5977.7 5981.2 6010.0 5594.5 5946.8 5953.3 5957.6 5962.6 5653.0 5787.1 5788.4 5828.1 5911.8 5868.7 5918.0 5923.1 5924.4 5924.8 5580.4 5620.6 5762.8 5790.5 5799.9 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#1] ext.html Cycles:180 Average:63158.96 Median:40248.10 stddev:125573.09 (312.0%) stddev-sans-first:125837.47 20:33:02 INFO - PROCESS | 19421 | Values: 586.7 638.0 663.1 666.3 672.4 34755.7 45368.3 46590.8 46613.3 46654.3 48657.5 49009.8 49079.3 49135.5 49171.3 8470.6 9316.5 9474.5 9479.6 9480.8 8364.0 8633.4 8634.4 10886.0 11142.7 11428.8 11478.3 11487.3 11491.1 11491.3 11276.0 11285.5 11293.6 11306.7 11364.2 11074.6 11161.2 11173.9 11174.6 11177.4 45901.0 46144.5 46157.5 46164.3 46175.0 3594.8 3698.5 4236.1 4363.4 4544.3 33755.7 34099.8 34382.5 36113.8 36762.0 4005.9 4095.0 4202.9 4290.8 4341.9 408534.0 410180.0 411545.0 411820.0 413088.0 67140.0 67807.7 67857.7 67919.3 68090.7 40081.0 40239.6 40472.8 43957.3 70854.6 17332.3 17416.7 17431.9 17444.6 17505.1 14687.3 14937.2 14947.5 14947.9 14965.0 19129.4 19146.0 20013.3 20609.7 21281.7 7642.2 7758.3 7793.8 7843.3 7892.6 977.4 1024.1 1059.2 1077.3 1078.7 34749.8 35723.0 35825.0 35864.8 35899.6 1140.0 1153.8 1158.4 1203.2 1203.9 17792.3 18066.9 18213.1 18217.5 18349.1 617017.0 623597.0 624049.0 624558.0 624774.0 64157.4 64563.7 64564.8 64626.0 64772.7 1319.1 1356.0 1411.1 1426.3 1450.8 29996.5 34827.3 34830.1 34866.5 35305.8 50287.0 50733.2 50855.2 50856.5 50891.0 335425.0 336008.0 336188.0 337798.0 338878.0 30592.5 31252.0 31433.8 31744.0 33680.5 51841.0 51962.0 51966.7 52053.2 52394.0 43465.0 43617.3 43851.0 45487.0 46144.0 43335.9 44777.3 45262.5 45950.0 46194.5 43511.8 43652.0 43819.6 44547.0 44566.6 37512.6 39551.8 39556.0 39901.2 40256.6 28065.3 28846.8 29117.7 29160.4 29225.4 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#2] jquery.html Cycles:180 Average:30879.93 Median:12162.64 stddev:89473.61 (735.6%) stddev-sans-first:89695.33 20:33:02 INFO - PROCESS | 19421 | Values: 395.6 420.0 433.3 436.2 448.0 16949.0 20061.5 21323.8 21545.4 21809.0 13526.8 15961.0 19937.9 20527.8 20642.6 5489.3 5696.0 5698.5 5701.5 5704.1 5430.2 5521.8 5564.3 5564.6 5566.4 5570.1 5570.7 5575.1 5576.9 5579.0 5418.9 5559.1 5622.0 5640.3 5641.0 5293.3 5491.1 5495.0 5497.5 5499.4 14849.6 15135.7 15135.8 15164.7 19743.5 2516.3 2519.1 2613.9 2682.1 3031.6 10757.5 10842.6 11122.2 11394.8 11504.5 1975.0 1977.4 1990.2 2009.9 2035.3 87322.0 87369.0 87564.0 88939.6 89666.6 10588.6 11527.6 11535.5 11838.9 12083.4 15120.6 15766.4 15946.7 16033.8 16722.4 8530.9 8566.5 8671.8 8696.3 8786.0 8043.1 8060.2 8106.3 8278.0 8290.8 4926.5 4978.4 5049.2 5103.6 5151.6 1906.5 1966.8 2047.6 2092.9 2152.5 959.9 1001.1 1012.9 1026.4 1051.7 19965.6 19987.4 20218.6 20305.2 20762.4 1013.4 1041.6 1041.8 1049.9 1088.3 10604.4 11162.0 11203.4 11290.8 11505.1 531108.0 532887.0 534569.0 551191.0 560796.0 95831.5 97346.0 100179.5 100336.5 101639.5 990.7 1037.7 1049.7 1065.4 1073.0 17781.8 17885.1 18126.0 18236.3 18595.3 43732.6 44028.6 44261.6 44591.0 46058.0 60657.7 60876.4 61685.7 62315.4 62935.0 8638.1 8779.0 8789.1 9013.9 9225.0 12581.8 13049.5 13181.5 13505.7 13515.5 10550.2 11143.8 11180.6 11191.9 11309.9 10827.7 11160.5 11574.8 11746.3 12173.1 11007.8 11090.6 11192.9 11245.3 11305.8 8575.4 8768.5 8854.2 9145.3 9414.2 8644.8 8659.0 8985.2 9099.2 9287.1 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#3] mootools.html Cycles:180 Average:5943.76 Median:5176.39 stddev:3317.21 (64.1%) stddev-sans-first:3308.68 20:33:02 INFO - PROCESS | 19421 | Values: 1366.8 1541.8 1565.8 1666.2 1832.4 7955.6 8775.9 9022.0 9031.3 9345.6 9023.0 9076.4 9080.4 9086.0 9090.5 2520.6 2547.8 2550.8 2551.5 2553.0 2395.2 2480.7 2482.0 2483.5 2483.8 2378.2 2399.0 2425.0 2427.8 2432.8 2334.5 2353.7 2360.8 2386.4 2393.9 2367.7 2371.6 2372.6 2379.2 2399.7 8932.9 8978.5 9039.3 9052.9 9072.9 5459.0 5625.5 5632.6 5693.4 5697.9 3632.0 3637.3 3654.0 3683.6 3701.6 1200.8 1209.6 1231.6 1237.4 1240.9 12295.6 12358.8 12370.3 12393.6 12401.4 4720.3 4737.1 4893.7 4900.7 4933.6 9899.8 9904.6 9910.2 9911.6 9913.6 5574.1 5578.5 5601.5 5602.0 5602.6 4433.0 4606.6 4654.0 4660.7 5241.8 4004.4 4031.9 4125.0 4132.0 4144.2 1254.8 1257.5 1269.2 1271.7 1274.4 804.8 905.7 923.6 928.2 968.4 6054.9 6160.6 6198.6 6207.3 6332.1 940.4 957.3 968.5 983.5 1026.5 4039.8 4328.6 4364.6 4372.5 4464.8 11010.8 11162.3 11172.9 11278.8 11300.1 11152.4 11164.6 11190.7 11214.0 11223.7 8105.4 8286.6 8383.4 8557.0 8580.4 6315.5 6343.8 6498.1 6537.7 6596.2 10139.5 10401.8 10427.9 10567.2 10605.4 9650.9 9711.8 10236.0 10448.2 10612.4 7567.0 7655.4 7705.5 7723.7 7742.7 8607.7 8793.2 8858.7 8869.9 8907.0 7873.3 8014.8 8043.9 8055.3 8297.3 7340.6 7352.5 7450.2 7555.3 7572.0 7257.6 7355.4 7363.4 7365.2 7376.0 5170.1 5182.7 5267.3 5358.0 5453.8 5106.7 5167.0 5224.1 5280.9 5386.9 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#4] prototype.html Cycles:180 Average:4753.69 Median:5331.21 stddev:1402.61 (26.3%) stddev-sans-first:1367.03 20:33:02 INFO - PROCESS | 19421 | Values: 349.4 358.2 364.2 368.8 370.2 5524.6 5539.2 5542.3 5549.9 5593.4 5514.4 5521.6 5525.3 5525.4 5538.0 4109.4 4271.7 4310.7 4316.2 4321.4 4302.9 4305.3 4305.5 4314.9 4319.2 4278.3 4291.8 4295.5 4295.5 4304.3 4178.9 4230.3 4236.6 4257.6 4301.8 3722.5 3722.6 3727.1 3730.7 3744.8 5315.9 5324.9 5337.5 5341.7 5376.5 4763.6 4854.0 4875.2 4898.8 4920.0 5701.5 5702.3 5711.2 5713.3 5728.3 4128.9 4130.5 4133.4 4134.5 4137.3 5832.5 5882.6 5895.9 5926.5 5954.2 4131.8 4134.5 4138.9 4152.6 4159.6 4191.0 4192.8 4204.3 4210.4 4218.8 4617.8 4818.3 4825.8 4830.5 4878.5 5767.6 5772.4 5774.9 5781.8 5794.8 1460.2 1467.0 1471.2 1482.4 1484.7 904.5 927.8 943.6 945.1 948.7 4922.0 4946.6 4948.7 4952.6 4960.2 5123.7 5133.6 5138.7 5152.9 5180.8 4672.4 4896.5 4911.8 4921.4 4928.3 2743.9 2753.3 2763.8 2774.7 2790.5 5315.6 5322.2 5341.4 5351.7 5361.7 5259.1 5260.7 5607.8 5755.5 6056.6 5941.9 5948.4 6088.6 6106.2 6129.2 5919.4 5955.9 5957.4 5961.8 5965.8 5595.7 5827.5 5849.2 5852.6 5876.2 6072.9 6078.6 6106.9 6153.9 6157.0 4177.4 4387.5 4398.5 4403.2 4408.2 5883.2 5910.2 5912.3 5921.3 5940.5 5760.8 5780.0 5784.6 5799.0 5799.5 5614.7 5765.9 5787.6 5802.1 5816.4 5783.3 5798.8 5799.7 5802.5 5809.1 5589.9 5809.2 5809.5 5829.5 5856.6 5620.7 5622.3 5627.5 5644.5 5681.2 20:33:02 INFO - PROCESS | 19421 | 20:33:02 INFO - PROCESS | 19421 | [#5] yui.html Cycles:180 Average:22124.12 Median:4535.20 stddev:32997.26 (727.6%) stddev-sans-first:33050.55 20:33:02 INFO - PROCESS | 19421 | Values: 681.8 692.2 719.6 764.5 768.4 14190.5 15266.6 15268.6 15292.3 15313.5 13981.3 14105.1 14120.2 14125.3 14173.7 716.6 732.0 839.3 850.9 862.7 827.6 828.4 828.5 828.6 829.3 869.9 870.1 870.2 870.5 872.6 746.5 765.9 864.5 887.5 894.7 650.4 655.1 655.4 656.9 657.2 13317.4 13333.3 13354.3 13356.6 13365.4 13745.2 13930.6 13942.0 13961.5 14043.6 12133.8 12240.8 12341.4 12394.9 12657.9 4364.2 4403.7 4481.9 4588.5 4591.6 88677.6 90476.0 92221.5 92492.5 92975.0 10685.1 10923.0 10963.7 11107.8 11259.4 19977.7 20035.7 20091.0 20108.8 20128.8 7996.8 8126.2 8160.4 8222.3 8377.5 4911.1 5063.7 5081.9 5213.1 5224.8 3442.5 3560.4 3572.0 3576.9 3582.6 599.8 599.9 601.4 612.8 616.1 607.4 632.9 638.2 742.5 755.9 9496.0 9887.8 9949.6 9997.5 10215.7 608.4 668.7 706.5 727.6 782.9 4601.8 4680.8 4842.3 4853.4 4893.7 120686.4 121171.0 121434.0 121947.0 123700.0 104029.5 106120.5 108770.5 109291.5 112242.0 96785.5 98244.5 99418.0 100039.5 101367.5 8992.2 9074.6 9113.9 9200.0 9255.6 54553.5 54584.5 54661.0 55172.7 55401.0 68385.7 69813.3 76045.2 82492.0 83082.6 12938.4 13114.5 13137.3 13403.9 13518.1 14570.1 14745.9 15286.3 15526.8 15887.3 13288.4 13419.7 13554.6 14160.4 14171.2 13118.3 13316.3 13349.7 14328.2 14472.0 13219.5 13238.5 13385.2 13627.9 14919.3 11100.7 11787.1 11866.7 12076.8 12285.0 11549.0 12275.6 12300.2 12411.3 12417.3 20:33:02 INFO - PROCESS | 19421 | -------- Summary: end -------- 20:33:02 INFO - PROCESS | 19421 | 20:33:03 INFO - TEST-INFO | 19421: exit 0 20:33:03 INFO - TEST-OK | dromaeo_css | took 1113989ms 20:33:03 INFO - TEST-START | kraken 20:33:03 INFO - operating with platform_type : linux_ 20:33:03 INFO - Initialising browser for kraken test... 20:33:03 INFO - TEST-INFO | started process 19741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0MaW7/profile http://localhost:39491/getInfo.html) 20:33:07 INFO - PROCESS | 19741 | __metrics Screen width/height:1600/1200 20:33:07 INFO - PROCESS | 19741 | colorDepth:24 20:33:07 INFO - PROCESS | 19741 | Browser inner width/height: 1024/697 20:33:07 INFO - PROCESS | 19741 | __metrics 20:33:07 INFO - PROCESS | 19741 | 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" 20:33:07 INFO - PROCESS | 19741 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:33:08 INFO - PROCESS | 19741 | console.error: PushService: 20:33:08 INFO - PROCESS | 19741 | stateChangeProcessEnqueue: Error transitioning state 20:33:08 INFO - PROCESS | 19741 | UnknownError 20:33:08 INFO - TEST-INFO | 19741: exit 0 20:33:08 INFO - Browser initialized. 20:33:08 INFO - Running cycle 1/1 for kraken test... 20:33:08 INFO - TEST-INFO | started process 19836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi0MaW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:33:20 INFO - PROCESS | 19836 | RSS: Main: 148770816 20:33:20 INFO - PROCESS | 19836 | 20:33:23 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39491/tests/kraken/driver.html?testName=audio-beat-detection) 20:33:24 INFO - PROCESS | 19836 | RSS: Main: 189992960 20:33:24 INFO - PROCESS | 19836 | 20:33:26 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39491/tests/kraken/driver.html?testName=audio-dft) 20:33:27 INFO - PROCESS | 19836 | RSS: Main: 179548160 20:33:27 INFO - PROCESS | 19836 | 20:33:29 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39491/tests/kraken/driver.html?testName=audio-fft) 20:33:30 INFO - PROCESS | 19836 | RSS: Main: 271028224 20:33:30 INFO - PROCESS | 19836 | 20:33:32 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39491/tests/kraken/driver.html?testName=audio-oscillator) 20:33:33 INFO - PROCESS | 19836 | RSS: Main: 176930816 20:33:33 INFO - PROCESS | 19836 | 20:33:35 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:33:35 INFO - PROCESS | 19836 | RSS: Main: 178675712 20:33:35 INFO - PROCESS | 19836 | 20:33:38 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39491/tests/kraken/driver.html?testName=imaging-darkroom) 20:33:39 INFO - PROCESS | 19836 | RSS: Main: 214712320 20:33:39 INFO - PROCESS | 19836 | 20:33:42 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39491/tests/kraken/driver.html?testName=imaging-desaturate) 20:33:43 INFO - PROCESS | 19836 | RSS: Main: 213331968 20:33:43 INFO - PROCESS | 19836 | 20:33:46 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39491/tests/kraken/driver.html?testName=json-parse-financial) 20:33:46 INFO - PROCESS | 19836 | RSS: Main: 213655552 20:33:46 INFO - PROCESS | 19836 | 20:33:48 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:33:48 INFO - PROCESS | 19836 | RSS: Main: 175439872 20:33:48 INFO - PROCESS | 19836 | 20:33:50 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:33:51 INFO - PROCESS | 19836 | RSS: Main: 183300096 20:33:51 INFO - PROCESS | 19836 | 20:33:53 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:33:53 INFO - PROCESS | 19836 | RSS: Main: 189661184 20:33:53 INFO - PROCESS | 19836 | 20:33:56 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:33:56 INFO - PROCESS | 19836 | RSS: Main: 197873664 20:33:56 INFO - PROCESS | 19836 | 20:33:59 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:00 INFO - PROCESS | 19836 | RSS: Main: 195084288 20:34:00 INFO - PROCESS | 19836 | 20:34:01 INFO - PROCESS | 19836 | Cycle 1(1): loaded http://localhost:39491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39491/tests/kraken/driver.html?testName=ai-astar) 20:34:02 INFO - PROCESS | 19836 | RSS: Main: 245690368 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | __start_tp_report 20:34:02 INFO - PROCESS | 19836 | _x_x_mozilla_page_load 20:34:02 INFO - PROCESS | 19836 | _x_x_mozilla_page_load_details 20:34:02 INFO - PROCESS | 19836 | |i|pagename|runs| 20:34:02 INFO - PROCESS | 19836 | |0;ai-astar;110;111;112;110;112;110;110;111;110;113 20:34:02 INFO - PROCESS | 19836 | |1;audio-beat-detection;145;122;116;167;117;121;117;117;152;122 20:34:02 INFO - PROCESS | 19836 | |2;audio-dft;161;162;161;161;162;159;159;159;159;158 20:34:02 INFO - PROCESS | 19836 | |3;audio-fft;75;76;75;110;76;75;76;76;97;76 20:34:02 INFO - PROCESS | 19836 | |4;audio-oscillator;82;81;114;82;81;82;104;82;82;110 20:34:02 INFO - PROCESS | 19836 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 20:34:02 INFO - PROCESS | 19836 | |6;imaging-darkroom;145;145;146;145;146;146;146;146;145;145 20:34:02 INFO - PROCESS | 19836 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;95 20:34:02 INFO - PROCESS | 19836 | |8;json-parse-financial;55;51;51;51;50;52;52;50;51;50 20:34:02 INFO - PROCESS | 19836 | |9;json-stringify-tinderbox;59;59;60;59;61;59;59;58;60;59 20:34:02 INFO - PROCESS | 19836 | |10;stanford-crypto-aes;74;75;73;74;73;73;82;73;72;73 20:34:02 INFO - PROCESS | 19836 | |11;stanford-crypto-ccm;132;122;122;126;128;121;118;129;169;123 20:34:02 INFO - PROCESS | 19836 | |12;stanford-crypto-pbkdf2;158;159;155;157;152;156;154;156;149;154 20:34:02 INFO - PROCESS | 19836 | |13;stanford-crypto-sha256-iterative;62;63;62;63;62;61;62;61;59;61 20:34:02 INFO - PROCESS | 19836 | __end_tp_report 20:34:02 INFO - PROCESS | 19836 | __start_cc_report 20:34:02 INFO - PROCESS | 19836 | _x_x_mozilla_cycle_collect,1593 20:34:02 INFO - PROCESS | 19836 | __end_cc_report 20:34:02 INFO - PROCESS | 19836 | __startTimestamp1477712042087__endTimestamp 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | ------- Summary: start ------- 20:34:02 INFO - PROCESS | 19836 | Number of tests: 14 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.10 (1.0%) stddev-sans-first:1.12 20:34:02 INFO - PROCESS | 19836 | Values: 110.0 111.0 112.0 110.0 112.0 110.0 110.0 111.0 110.0 113.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:122.00 stddev:18.22 (14.9%) stddev-sans-first:18.46 20:34:02 INFO - PROCESS | 19836 | Values: 145.0 122.0 116.0 167.0 117.0 121.0 117.0 117.0 152.0 122.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.45 (0.9%) stddev-sans-first:1.50 20:34:02 INFO - PROCESS | 19836 | Values: 161.0 162.0 161.0 161.0 162.0 159.0 159.0 159.0 159.0 158.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.15 (16.0%) stddev-sans-first:12.68 20:34:02 INFO - PROCESS | 19836 | Values: 75.0 76.0 75.0 110.0 76.0 75.0 76.0 76.0 97.0 76.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:13.56 (16.5%) stddev-sans-first:14.07 20:34:02 INFO - PROCESS | 19836 | Values: 82.0 81.0 114.0 82.0 81.0 82.0 104.0 82.0 82.0 110.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:34:02 INFO - PROCESS | 19836 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:34:02 INFO - PROCESS | 19836 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:34:02 INFO - PROCESS | 19836 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.49 (2.9%) stddev-sans-first:0.78 20:34:02 INFO - PROCESS | 19836 | Values: 55.0 51.0 51.0 51.0 50.0 52.0 52.0 50.0 51.0 50.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 20:34:02 INFO - PROCESS | 19836 | Values: 59.0 59.0 60.0 59.0 61.0 59.0 59.0 58.0 60.0 59.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:73.50 stddev:2.86 (3.9%) stddev-sans-first:3.03 20:34:02 INFO - PROCESS | 19836 | Values: 74.0 75.0 73.0 74.0 73.0 73.0 82.0 73.0 72.0 73.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:127.00 stddev:14.67 (11.6%) stddev-sans-first:15.52 20:34:02 INFO - PROCESS | 19836 | Values: 132.0 122.0 122.0 126.0 128.0 121.0 118.0 129.0 169.0 123.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:156.00 stddev:2.94 (1.9%) stddev-sans-first:2.92 20:34:02 INFO - PROCESS | 19836 | Values: 158.0 159.0 155.0 157.0 152.0 156.0 154.0 156.0 149.0 154.0 20:34:02 INFO - PROCESS | 19836 | 20:34:02 INFO - PROCESS | 19836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:62.00 stddev:1.17 (1.9%) stddev-sans-first:1.24 20:34:02 INFO - PROCESS | 19836 | Values: 62.0 63.0 62.0 63.0 62.0 61.0 62.0 61.0 59.0 61.0 20:34:02 INFO - PROCESS | 19836 | -------- Summary: end -------- 20:34:02 INFO - PROCESS | 19836 | 20:34:03 INFO - TEST-INFO | 19836: exit 0 20:34:03 INFO - TEST-OK | kraken | took 59909ms 20:34:03 INFO - SUITE-END | took 1173s 20:34:03 INFO - Completed test suite (00:19:34) 20:34:03 INFO - javascript benchmark 20:34:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.7032481914216, 3158.7630927680416, 3180.332130252647, 3212.3414699986506, 3226.2740883301276, 5541.612087153901, 5631.887362252753, 5651.519620832229, 5661.631993920402, 5694.572907031974, 5613.80351687691, 5640.661560306385, 5653.547716182706, 5659.122835960422, 5666.235058267132, 5108.4636113208135, 5131.769070391822, 5147.897042059157, 5170.172772356424, 5207.765650545734, 5050.292958985745, 5205.583553315744, 5206.297149884755, 5222.164453687411, 5225.007248622749, 5037.974810125944, 5053.974730126344, 5121.359830021247, 5143.81996630118, 5188.16989281715, 5179.2749015137915, 5263.394709608406, 5269.762860671279, 5271.446498117681, 5293.23248129023, 4967.403911530603, 5086.669366491166, 5171.120909445403, 5214.687118772886, 5231.895362092737, 5462.153366228241, 5468.26178465906, 5527.0, 5561.249231353756, 5576.7211639417865, 5851.034579294412, 5881.852953676193, 5885.440883116097, 5940.61386009908, 5941.851453713649, 6020.307664618581, 6026.276846778414, 6031.60794548353, 6032.638041717511, 6040.697965101727, 5439.292891924064, 5480.80817171401, 5490.368607610136, 5521.309836270466, 5541.501264886179, 6038.0, 6082.2701275847185, 6088.6042407243385, 6091.329953705089, 6097.603655762361, 5843.152742852262, 5862.384449632812, 5868.882622347614, 5873.500752436091, 5878.706064696748, 5840.707964601753, 5863.355030946593, 5890.14592884038, 5891.823245302648, 5893.410658934158, 5920.023196172583, 5926.436988486087, 5935.347111817697, 5937.2578427696535, 5954.523638108941, 5887.941120588825, 5950.345461999176, 5958.821235362946, 5966.164736936832, 5974.372690867396, 4469.575390337977, 4473.0, 4595.586397224266, 4608.377868987711, 4642.094791515622, 4161.958380416218, 4166.604172603597, 4167.416561681367, 4167.562405947332, 4192.601702838226, 5806.912896306559, 5807.0998995155815, 5807.245058142415, 5824.980628390015, 5831.0, 5774.364819869811, 5832.825015249549, 5991.700414979321, 6006.699665016732, 6107.725152368154, 5715.628484148517, 5721.828345149652, 5722.62802917809, 5737.3688894221605, 5754.136879468113, 5257.316548848702, 5267.841964741064, 5268.868278293074, 5272.314599102092, 5275.314209152785, 5852.502537284378, 5880.676562789087, 6098.969505152446, 6280.403361680633, 6286.748530058747, 5953.821385358447, 6015.2781666200335, 6023.457888789854, 6054.0, 6072.05883088122, 6183.783567575113, 6192.071189321638, 6196.47329976957, 6200.162977997912, 6202.751889924533, 5616.241807356118, 5639.943600563942, 5885.14665373527, 5937.8218653438735, 5937.970310148422, 6006.969965150146, 6053.485453736305, 6068.0, 6124.289394097845, 6124.564025909317, 5967.731452084753, 5972.761089556369, 5977.7310021050025, 5981.162637230704, 6010.0, 5594.524465420485, 5946.791862284799, 5953.255843019622, 5957.6127551709, 5962.612430192024, 5652.971735141298, 5787.074068149076, 5788.392218816964, 5828.0966450200285, 5911.822645320647, 5868.735906884286, 5917.970410148094, 5923.052311630118, 5924.377940316204, 5924.763009479572, 5580.441955804387, 5620.606557540933, 5762.7694892203845, 5790.536757059509, 5799.855003624774], "value": 5530.628314430002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7007826008735, 637.9776707815226, 663.1014974709269, 666.2537957487615, 672.4049216443447, 34755.652443475556, 45368.319475207856, 46590.76704616481, 46613.300800487974, 46654.30018549716, 48657.51342486574, 49009.75495122528, 49079.26381104286, 49135.50864491354, 49171.262431063566, 8470.576471176448, 9316.48759318239, 9474.47890366033, 9479.620815167385, 9480.81038379232, 8363.958180209122, 8633.438826476291, 8634.352423568225, 10886.0, 11142.721431964224, 11428.828567571492, 11478.253913495639, 11487.253328533661, 11491.080713542897, 11491.310521368745, 11275.985161335519, 11285.548578056867, 11293.604723834667, 11306.717332066683, 11364.204505684605, 11074.557017719282, 11161.162912781574, 11173.944130279297, 11174.608888688857, 11177.385243811586, 45901.0, 46144.53915956283, 46157.53842461566, 46164.30753538699, 46175.0, 3594.7843129412317, 3698.5007024051947, 4236.068065025689, 4363.38912552243, 4544.272916333404, 33755.6624433755, 34099.82950085258, 34382.48426273608, 36113.81943090294, 36762.0, 4005.859794907164, 4094.979525102385, 4202.915941681149, 4290.806913688892, 4341.9131617367475, 408534.0, 410180.0, 411545.0, 411820.0, 413088.0, 67140.0, 67807.66096169586, 67857.66071169612, 67919.32080679228, 68090.65954670294, 40081.0, 40239.59760402417, 40472.79763601163, 43957.340639890426, 70854.64572677207, 17332.30670773155, 17416.738748918775, 17431.912840435718, 17444.563885902953, 17505.12474376276, 14687.26563671812, 14937.178455184852, 14947.476838310607, 14947.850521494645, 14965.027273227206, 19129.441512860125, 19146.0, 20013.299534516224, 20609.690854637192, 21281.68077478808, 7642.235776422424, 7758.262965018314, 7793.766187014398, 7843.294103530596, 7892.632210336991, 977.4233202410612, 1024.144839059379, 1059.1579694143174, 1077.3051381858656, 1078.7087486378791, 34749.82625086858, 35723.0, 35825.0, 35864.82067589645, 35899.64100359015, 1139.9772004559863, 1153.7923173828792, 1158.4323681396056, 1203.175824560179, 1203.915725899196, 17792.288308467774, 18066.90966545159, 18213.08934553267, 18217.45347639573, 18349.082545872654, 617017.0, 623597.0, 624049.0, 624558.0, 624774.0, 64157.358426416075, 64563.67718161379, 64564.80328778614, 64626.0, 64772.67613661902, 1319.0832371501906, 1355.9932200338935, 1411.0757453867734, 1426.3011124548896, 1450.7927011666252, 29996.471120344286, 34827.30345393129, 34830.12924676904, 34866.47700284447, 35305.82347088351, 50287.0, 50733.23900141427, 50855.2371714432, 50856.491435085176, 50891.0, 335425.0, 336008.0, 336188.0, 337798.0, 338878.0, 30592.541111882896, 31252.0, 31433.8428307857, 31744.04767856968, 33680.49479257862, 51841.0, 51962.0, 51966.74016629893, 52053.21920171125, 52394.0, 43465.0, 43617.345739813296, 43851.0, 45487.0, 46144.0, 43335.932969383684, 44777.328340075575, 45262.54737452715, 45950.0, 46194.459304738564, 43511.78244108759, 43652.0, 43819.56180438155, 44547.0, 44566.554334457534, 37512.624873750916, 39551.80224098861, 39556.0, 39901.201975960896, 40256.59743402529, 28065.29836754016, 28846.820952475013, 29117.708822912347, 29160.416791663625, 29225.415491690474], "value": 21608.777820651907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.5984675554311, 420.04143005449066, 433.31752489828517, 436.1690978685604, 447.97312161270304, 16949.0, 20061.498462538424, 21323.786762132375, 21545.353639390843, 21809.0, 13526.797098043537, 15961.042337459761, 19937.900310498462, 20527.794722052775, 20642.587148257062, 5489.34127904651, 5695.974724549579, 5698.458646428583, 5701.458361455655, 5704.087346024637, 5430.185472179165, 5521.806736764214, 5564.276644036269, 5564.610477266593, 5566.387697353288, 5570.053090974524, 5570.693611851347, 5575.135853942646, 5576.86057848553, 5578.972105139469, 5418.864528386783, 5559.082751346023, 5622.0161471742285, 5640.323161220639, 5641.041023026116, 5293.258943747878, 5491.093969495028, 5495.0383682855345, 5497.532709719679, 5499.4225606311165, 14849.628759281104, 15135.697286054326, 15135.772963405447, 15164.696706065817, 19743.506412339662, 2516.282859385085, 2519.0553542421594, 2613.8693065346847, 2682.12830829981, 3031.621047369079, 10757.462126893624, 10842.620508282173, 11122.221444498888, 11394.772104557862, 11504.539818407253, 1974.9506262343414, 1977.4067779666043, 1990.1641310649418, 2009.9151833711687, 2035.3385149826365, 87322.0, 87369.0, 87564.0, 88939.55530222307, 89666.5516672419, 10588.629397971188, 11527.596534121265, 11535.480903359368, 11838.940805295919, 12083.395830208454, 15120.621984450478, 15766.369345226292, 15946.681066378607, 16033.839661603235, 16722.41471548514, 8530.914690853013, 8566.52884091381, 8671.783205419915, 8696.304295656333, 8785.956070219736, 8043.075046369625, 8060.19398060201, 8106.310963568045, 8278.0, 8290.792730181794, 4926.482719314492, 4978.427480839678, 5049.242613607915, 5103.566196873233, 5151.5878729701535, 1906.4566598519355, 1966.8328192103545, 2047.5597746484577, 2092.8593916315644, 2152.4511249631246, 959.9232061435068, 1001.1340190734962, 1012.8987101289812, 1026.4252018869456, 1051.7160366700948, 19965.60068798645, 19987.400377988393, 20218.595628087354, 20305.207719137146, 20762.377128686163, 1013.4122209118693, 1041.6093964763213, 1041.7760181561, 1049.8792638846478, 1088.314361951981, 10604.416757078434, 11162.0, 11203.43982800873, 11290.774184516427, 11505.137114716263, 531108.0, 532887.0, 534569.0, 551191.0, 560796.0, 95831.52084239534, 97346.0, 100179.49910250402, 100336.49831750794, 101639.49180254052, 990.6681261777242, 1037.6783197208738, 1049.7480604654982, 1065.4406436620682, 1073.044989958937, 17781.822181778018, 17885.10574471297, 18126.0, 18236.270549177883, 18595.256189752257, 43732.56267437412, 44028.559714403724, 44261.557384425745, 44591.0, 46058.0, 60657.69671151616, 60876.391236087075, 61685.69157154186, 62315.37684623096, 62935.0, 8638.079450358717, 8778.956105219433, 8789.121087891159, 9013.864792027995, 9225.0, 12581.811272831097, 13049.543265985645, 13181.472741090249, 13505.662358441117, 13515.459381624625, 10550.155987520826, 11143.83284250753, 11180.608678696206, 11191.944040280072, 11309.886901131213, 10827.729306767395, 11160.497777599865, 11574.826377604511, 11746.29522228669, 12173.147879648339, 11007.779844402907, 11090.611828585961, 11192.944035279772, 11245.325280483197, 11305.773884522428, 8575.3997220194, 8768.473891566526, 8854.203121718818, 9145.314101442285, 9414.19979301767, 8644.827103458021, 8659.00421451516, 8985.236254918143, 9099.226565741987, 9287.117723816227], "value": 9330.97306078249, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.8291463567055, 1541.7841502189694, 1565.8121025476942, 1666.2002238925315, 1832.3586744639379, 7955.641996110175, 8775.868361974575, 9022.007579166295, 9031.277497800176, 9345.579448924798, 9023.0, 9076.410033347827, 9080.364374493787, 9086.04596517366, 9090.50002249876, 2520.571502844516, 2547.8089143314232, 2550.7576780205945, 2551.5407226699185, 2552.961705574418, 2395.2454976682375, 2480.677511923456, 2481.950360992779, 2483.466054798218, 2483.838550494221, 2378.1795280628244, 2398.95202095958, 2424.963625545618, 2427.8057755379614, 2432.781049705526, 2334.463073493106, 2353.670486131943, 2360.799332056777, 2386.4033991502124, 2393.9281821545383, 2367.715874095102, 2371.6205407134776, 2372.644103384489, 2379.1553998330514, 2399.712034555847, 8932.910670893338, 8978.461292322481, 9039.276857851357, 9052.8642070369, 9072.8639070414, 5458.972705136489, 5625.54995600351, 5632.633878797906, 5693.402192769782, 5697.914531282034, 3632.0, 3637.290728307981, 3654.0, 3683.557973043252, 3701.592824789271, 1200.8438902942648, 1209.5585111434264, 1231.6428235811604, 1237.3565745812127, 1240.875912408761, 12295.631131066082, 12358.752824943631, 12370.257784532867, 12393.62819115428, 12401.441935112942, 4720.347907484702, 4737.076270127292, 4893.730844803499, 4900.705957642553, 4933.55597996182, 9899.752506187402, 9904.60381584743, 9910.157636600825, 9911.603535858629, 9913.553890074963, 5574.052411090124, 5578.497935185853, 5601.5238704710555, 5602.047651899187, 5602.607817452821, 4433.0, 4606.608438282717, 4653.95346046542, 4660.697054691502, 5241.816536421207, 4004.439378487014, 4031.9395209071886, 4125.0, 4132.0, 4144.191882582867, 1254.7615952968906, 1257.4781465691635, 1269.206745783885, 1271.6693659648558, 1274.3755559775643, 804.8108694456798, 905.7282815155427, 923.5982347678647, 928.1692884868005, 968.3560432312574, 6054.878902421927, 6160.568760186744, 6198.597091189148, 6207.34822843604, 6332.145160403379, 940.4451373689556, 957.2676902169845, 968.4625033106553, 983.5279066048193, 1026.4662375564665, 4039.7576145431367, 4328.61042506176, 4364.585364390377, 4372.475302963665, 4464.799084041226, 11010.779784404427, 11162.330260184415, 11172.888271117346, 11278.774424511465, 11300.09599232076, 11152.386618736047, 11164.553417863357, 11190.66428007161, 11214.0, 11223.71940701489, 8105.432619716681, 8286.58567071644, 8383.371247156487, 8556.957215213759, 8580.356473264404, 6315.463185629273, 6343.809685709436, 6498.090267362479, 6537.70580323877, 6596.208454985433, 10139.543720532447, 10401.791964160826, 10427.94786026065, 10567.154627629618, 10605.363678179334, 9650.903490965282, 9711.757206069904, 10236.027577380137, 10448.164146868385, 10612.416317102325, 7567.0, 7655.387568994356, 7705.460617756928, 7723.691052357843, 7742.690292388466, 8607.698730544402, 8793.20861122502, 8858.689945852122, 8869.911300886908, 8906.955465222632, 7873.291403773688, 8014.8397032057865, 8043.87934180976, 8055.315298199719, 8297.294729948022, 7340.559566426032, 7352.485326027127, 7450.180480147288, 7555.282248186413, 7572.0, 7257.564546127249, 7355.411567074728, 7363.374113200223, 7365.226651201761, 7375.96312018458, 5170.121079416433, 5182.663126896739, 5267.262583238273, 5357.973210133924, 5453.754581043783, 5106.66806657566, 5167.044096842096, 5224.138017227115, 5280.867978300574, 5386.919196211981], "value": 4775.877279619601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3868261201592, 358.24946736586844, 364.21148214116425, 368.84508506427295, 370.20406126827316, 5524.558035357172, 5539.169124631312, 5542.251796007537, 5549.86125346866, 5593.412691667378, 5514.420985796493, 5521.613487055898, 5525.309336332958, 5525.4474552544725, 5537.972310138443, 4109.363048727445, 4271.658267338621, 4310.719803212797, 4316.20150272199, 4321.395004699345, 4302.913941721164, 4305.332673435607, 4305.526392096866, 4314.913701725964, 4319.222539942809, 4278.315469524861, 4291.806868690901, 4295.506016808075, 4295.527491975896, 4304.31131019037, 4178.9373159402785, 4230.302000169968, 4236.6187043166265, 4257.595528424795, 4301.827926882921, 3722.516072910504, 3722.5532936047575, 3727.148731220618, 3730.7015438764834, 3744.775313481173, 5315.8570907255125, 5324.946750532523, 5337.4662533746705, 5341.679499230058, 5376.542993845528, 4763.618910487153, 4853.95146048542, 4875.219964805649, 4898.755062246873, 4919.975400123012, 5701.515371193454, 5702.315722113373, 5711.200431939532, 5713.257456475773, 5728.283964504437, 4128.938065929014, 4130.483689538808, 4133.400656904732, 4134.4831896013, 4137.296659567851, 5832.533397328203, 5882.617629854089, 5895.852603684899, 5926.459120628668, 5954.225950626391, 4131.772752498641, 4134.462519872397, 4138.896527586834, 4152.6055024772595, 4159.646430053479, 4191.0, 4192.832286708558, 4204.348326009474, 4210.410542524049, 4218.764055050828, 4617.7691115444095, 4818.277258411196, 4825.806967721322, 4830.492798256132, 4878.512148785164, 5767.625104368202, 5772.422757724278, 5774.855628609318, 5781.797637082682, 5794.82615521535, 1460.2260801775076, 1466.9706605868037, 1471.220253265771, 1482.4366740638488, 1484.6807936293749, 904.4554764731053, 927.7587827164986, 943.5895385507326, 945.0561500924571, 948.6537413843897, 4921.966387058686, 4946.629002824802, 4948.678335908155, 4952.554270115635, 4960.181570040975, 5123.666961647481, 5133.61287001546, 5138.743062846843, 5152.948470515322, 5180.844574662766, 4672.392588963481, 4896.485868983706, 4911.838790931978, 4921.434035085939, 4928.310036594808, 2743.9451210975667, 2753.3116720819794, 2763.8341699498096, 2774.667039955218, 2790.4698107359536, 5315.627906046617, 5322.2282768998275, 5341.439148889388, 5351.705656188947, 5361.678299302054, 5259.08120992845, 5260.658057226268, 5607.812952948353, 5755.510781583528, 6056.636601803906, 5941.881162376815, 5948.405159484104, 6088.573799834057, 6106.175666284995, 6129.233845769279, 5919.4080591940465, 5955.851103722442, 5957.43830153021, 5961.821145365646, 5965.806838632204, 5595.692236927008, 5827.533797296291, 5849.239598852122, 5852.590318677822, 5876.236089308362, 6072.876517844213, 6078.635281883101, 6106.877862442815, 6153.876922461436, 6156.969215153896, 4177.394277829759, 4387.495438024668, 4398.538153493837, 4403.163398954189, 4408.184485870124, 5883.235179426647, 5910.1725758392995, 5912.349641539341, 5921.3190483094995, 5940.495057919952, 5760.798372056958, 5779.971100144472, 5784.566157538117, 5798.971005144947, 5799.507041901317, 5614.719264036864, 5765.884682306414, 5787.594868359174, 5802.100674395476, 5816.41835816415, 5783.277090363705, 5798.768049277982, 5799.681017544076, 5802.5357971361345, 5809.128630705428, 5589.944100558942, 5809.186713859978, 5809.506191973561, 5829.504492118217, 5856.560757943256, 5620.662760234399, 5622.297212848394, 5627.493525582717, 5644.491995720405, 5681.2330335404195], "value": 4311.850124866998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.8397676546014, 692.2350802363392, 719.5610677486732, 764.4916130773034, 768.3852917665868, 14190.503332383369, 15266.618334541641, 15268.618284542892, 15292.31184596693, 15313.540593782176, 13981.300934953262, 14105.083169593969, 14120.152790832557, 14125.293735313244, 14173.71652566948, 716.6345163966375, 731.9963400182992, 839.2530647723531, 850.9319254459659, 862.6764963138822, 827.6234313387424, 828.4242451496212, 828.4780588229437, 828.5732847583499, 829.3075282139421, 869.9304055675562, 870.1298701298701, 870.2211520688979, 870.5125129927261, 872.6160489384682, 746.5110352718978, 765.885117232414, 864.4813112132733, 887.5473508510642, 894.695803426838, 650.4471199480452, 655.1123228026004, 655.3741177175785, 656.9080328753978, 657.2179106862818, 13317.400716967759, 13333.266670333127, 13354.33228338589, 13356.599302020857, 13365.398557064955, 13745.175289482662, 13930.58208253754, 13942.0, 13961.511347102803, 14043.64890877726, 12133.757324853454, 12240.81638775419, 12341.382930853422, 12394.876051239462, 12657.873421265762, 4364.192624364471, 4403.713758605681, 4481.932771008437, 4588.4723256825555, 4591.632669386441, 88677.55661221653, 90476.0, 92221.53889230578, 92492.53753731189, 92975.0, 10685.145188384911, 10923.0, 10963.725906852233, 11107.83338249927, 11259.437028148559, 19977.700334494995, 20035.699464508045, 20091.0, 20108.798912010694, 20128.798712012984, 7996.80007999793, 8126.228008339198, 8160.4287699861625, 8222.342212622976, 8377.539235342114, 4911.140550403665, 5063.696178229245, 5081.949180508222, 5213.13983192769, 5224.817131400383, 3442.5008373785663, 3560.359135355661, 3572.0, 3576.8569257229938, 3582.570091589026, 599.7780821096222, 599.9130126131687, 601.4286427893519, 612.8467883029243, 616.1281786272464, 607.4168797953926, 632.8734253149388, 638.1990601794811, 742.4718832375769, 755.9470837041464, 9495.975182787559, 9887.806068332207, 9949.55227014786, 9997.450140242356, 10215.693529193988, 608.415078719937, 668.7024274198033, 706.5301574453034, 727.6143643868758, 782.9021372328459, 4601.792919318638, 4680.836170734008, 4842.273658951185, 4853.39332583427, 4893.7063776173545, 120686.39656801836, 121171.0, 121434.0, 121947.0, 123700.0, 104029.47985260177, 106120.46939765406, 108770.45614771875, 109291.45354273178, 112242.0, 96785.45324363509, 98244.50877745566, 99418.0, 100039.49980250197, 101367.49316253519, 8992.190702836777, 9074.591643376196, 9113.908860911572, 9199.954000229956, 9255.583498742708, 54553.45446545642, 54584.454155457934, 54661.0, 55172.72413637906, 55401.0, 68385.65807170932, 69813.30186698068, 76045.23954760382, 82492.0, 83082.58458707668, 12938.353082346033, 13114.540991065267, 13137.343132843129, 13403.865961340261, 13518.121322114031, 14570.125792452487, 14745.92627036858, 15286.312115954586, 15526.844731552539, 15887.285072172011, 13288.40202190923, 13419.731605367642, 13554.59336219915, 14160.362783674553, 14171.220582868042, 13118.344082796013, 13316.33418329099, 13349.733005339645, 14328.211948342941, 14472.0, 13219.471221151047, 13238.53665121716, 13385.19688818674, 13627.863721362659, 14919.25403729831, 11100.722481938015, 11787.115966302734, 11866.703332416413, 12076.75846483083, 12285.0, 11549.0, 12275.570355037531, 12300.200486968319, 12411.317377544321, 12417.31704756211], "value": 7681.833428783102, "unit": "score"}], "name": "dromaeo_css", "value": 7489.045216595932, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0, 111.0, 110.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 116.0, 167.0, 117.0, 121.0, 117.0, 117.0, 152.0, 122.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 159.0, 159.0, 159.0, 159.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 110.0, 76.0, 75.0, 76.0, 76.0, 97.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 114.0, 82.0, 81.0, 82.0, 104.0, 82.0, 82.0, 110.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 51.0, 50.0, 52.0, 52.0, 50.0, 51.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 61.0, 59.0, 59.0, 58.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 74.0, 73.0, 73.0, 82.0, 73.0, 72.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 122.0, 126.0, 128.0, 121.0, 118.0, 129.0, 169.0, 123.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 155.0, 157.0, 152.0, 156.0, 154.0, 156.0, 149.0, 154.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 62.0, 61.0, 59.0, 61.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1459.6999999999998, "alertThreshold": 2.0}]} 20:34:03 INFO - Return code: 0 20:34:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:34:03 INFO - # TBPL SUCCESS # 20:34:03 INFO - Running post-action listener: _resource_record_post_action 20:34:03 INFO - [mozharness: 2016-10-29 03:34:03.379497Z] Finished run-tests step (success) 20:34:03 INFO - Running post-run listener: _resource_record_post_run 20:34:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 1998848; Write bytes: 364265472; Read time: 88; Write time: 367180 20:34:03 INFO - TinderboxPrint: CPU usage
13.0% 20:34:03 INFO - TinderboxPrint: I/O read bytes / time
1,998,848 / 88 20:34:03 INFO - TinderboxPrint: I/O write bytes / time
364,265,472 / 367,180 20:34:03 INFO - TinderboxPrint: CPU idle
8,265.1 (87.0%) 20:34:03 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 20:34:03 INFO - TinderboxPrint: Swap in / out
0 / 0 20:34:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115376128; Read time: 0; Write time: 146704 20:34:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248889344; Read time: 28; Write time: 220476 20:34:04 INFO - Running post-run listener: _upload_blobber_files 20:34:04 INFO - Blob upload gear active. 20:34:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:34:04 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 20:34:04 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'] 20:34:04 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 20:34:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:05 INFO - (blobuploader) - INFO - Done attempting. 20:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:08 INFO - (blobuploader) - INFO - Done attempting. 20:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:09 INFO - (blobuploader) - INFO - Done attempting. 20:34:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:34:09 INFO - Return code: 0 20:34:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:34:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:34:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0797d6481cfdc0082ca507dde9256719ca55812c33f25fc3a079e44939fe172d5dd35d58db44041c8d7c636014746afaed05f7eb5900b6eecfdaf2acf09b0465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76e1c4a8fae89a4e9e08f66988c40070ec7462ca85f335d08b65b99722a96b104ae823debf829e962647a3bab552d1c22412b33e7e6e3e0ac1612abdd2f55863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1593e6794b9adb1302758da7ee7b19ba3962ff8b4b25caca3ef8a3eba9a98e3c57b5763dda57c85da27dd14fb660bcd791f518a26f77e168badd67da8d7a98de"} 20:34:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:34:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:34:09 INFO - Contents: 20:34:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0797d6481cfdc0082ca507dde9256719ca55812c33f25fc3a079e44939fe172d5dd35d58db44041c8d7c636014746afaed05f7eb5900b6eecfdaf2acf09b0465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76e1c4a8fae89a4e9e08f66988c40070ec7462ca85f335d08b65b99722a96b104ae823debf829e962647a3bab552d1c22412b33e7e6e3e0ac1612abdd2f55863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1593e6794b9adb1302758da7ee7b19ba3962ff8b4b25caca3ef8a3eba9a98e3c57b5763dda57c85da27dd14fb660bcd791f518a26f77e168badd67da8d7a98de"} 20:34:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:34:09 INFO - Copying logs to upload dir... 20:34:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:34:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.265428 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-28 20:34:09.159455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 20:34:09.162853) ========= 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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 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/0797d6481cfdc0082ca507dde9256719ca55812c33f25fc3a079e44939fe172d5dd35d58db44041c8d7c636014746afaed05f7eb5900b6eecfdaf2acf09b0465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76e1c4a8fae89a4e9e08f66988c40070ec7462ca85f335d08b65b99722a96b104ae823debf829e962647a3bab552d1c22412b33e7e6e3e0ac1612abdd2f55863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1593e6794b9adb1302758da7ee7b19ba3962ff8b4b25caca3ef8a3eba9a98e3c57b5763dda57c85da27dd14fb660bcd791f518a26f77e168badd67da8d7a98de"} build_url:https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/MObexsnyRia85ev_EHXnPQ/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/0797d6481cfdc0082ca507dde9256719ca55812c33f25fc3a079e44939fe172d5dd35d58db44041c8d7c636014746afaed05f7eb5900b6eecfdaf2acf09b0465", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/76e1c4a8fae89a4e9e08f66988c40070ec7462ca85f335d08b65b99722a96b104ae823debf829e962647a3bab552d1c22412b33e7e6e3e0ac1612abdd2f55863", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1593e6794b9adb1302758da7ee7b19ba3962ff8b4b25caca3ef8a3eba9a98e3c57b5763dda57c85da27dd14fb660bcd791f518a26f77e168badd67da8d7a98de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 20:34:09.188666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:34:09.188963) ========= 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=836cfdc75598d54cb747368e000001a9-1477710814.250368-619905236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 20:34:09.273210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 20:34:09.273532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 20:34:09.273804) ========= ========= Total master_lag: 0.17 =========