builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1479101892.38 results: success (0) buildid: 20161113185720 builduid: 7bb677893a9d49069e1ba7881fa26215 revision: ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.384560) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.385139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.385464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.401820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.402126) ========= 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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-13 21:38:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-11-13 21:38:12 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087533 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.504715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.505072) ========= 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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019134 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.559278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:12.560134) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 --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 ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 --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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-13 21:38:12,782 truncating revision to first 12 chars 2016-11-13 21:38:12,782 Setting DEBUG logging. 2016-11-13 21:38:12,782 attempt 1/10 2016-11-13 21:38:12,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ecfbd26aa2ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 21:38:13,099 unpacking tar archive at: mozilla-aurora-ecfbd26aa2ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:13.212754) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:13.213103) ========= script_repo_revision: ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:13.213533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:13.213852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 21:38:13.223190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-13 21:38:13.223539) ========= /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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:38:13 INFO - MultiFileLogger online at 20161113 21:38:13 in /builds/slave/test 21:38:13 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 21:38:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:38:13 INFO - {'append_to_log': False, 21:38:13 INFO - 'base_work_dir': '/builds/slave/test', 21:38:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:38:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:38:13 INFO - 'branch': 'Mozilla-Aurora', 21:38:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:38:13 INFO - 'config_files': ('talos/linux_config.py',), 21:38:13 INFO - 'default_actions': ('clobber', 21:38:13 INFO - 'read-buildbot-config', 21:38:13 INFO - 'download-and-extract', 21:38:13 INFO - 'populate-webroot', 21:38:13 INFO - 'create-virtualenv', 21:38:13 INFO - 'install', 21:38:13 INFO - 'run-tests'), 21:38:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:38:13 INFO - 'download_minidump_stackwalk': True, 21:38:13 INFO - 'download_symbols': 'ondemand', 21:38:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:38:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:38:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:38:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:38:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:38:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:38:13 INFO - 'installer_path': 'installer.exe', 21:38:13 INFO - 'log_level': 'info', 21:38:13 INFO - 'log_name': 'talos', 21:38:13 INFO - 'log_to_console': True, 21:38:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:38:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:38:13 INFO - 'opt_config_files': (), 21:38:13 INFO - 'pip_index': False, 21:38:13 INFO - 'sps_profile': False, 21:38:13 INFO - 'sps_profile_interval': 0, 21:38:13 INFO - 'suite': 'dromaeojs', 21:38:13 INFO - 'system_bits': '32', 21:38:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:38:13 INFO - 'title': 'talos-linux64-ix-025', 21:38:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:38:13 INFO - 'use_talos_json': True, 21:38:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:38:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:38:13 INFO - 'work_dir': 'build'} 21:38:13 INFO - [mozharness: 2016-11-14 05:38:13.536932Z] Running clobber step. 21:38:13 INFO - Running pre-action listener: _resource_record_pre_action 21:38:13 INFO - Running main action method: clobber 21:38:13 INFO - rmtree: /builds/slave/test/build 21:38:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:38:13 INFO - Running post-action listener: _resource_record_post_action 21:38:13 INFO - [mozharness: 2016-11-14 05:38:13.989718Z] Finished clobber step (success) 21:38:13 INFO - [mozharness: 2016-11-14 05:38:13.989819Z] Running read-buildbot-config step. 21:38:13 INFO - Running pre-action listener: _resource_record_pre_action 21:38:13 INFO - Running main action method: read_buildbot_config 21:38:13 INFO - Using buildbot properties: 21:38:13 INFO - { 21:38:13 INFO - "project": "", 21:38:13 INFO - "product": "firefox", 21:38:13 INFO - "script_repo_revision": "production", 21:38:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:38:13 INFO - "repository": "", 21:38:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:38:13 INFO - "buildid": "20161113185720", 21:38:13 INFO - "pgo_build": "True", 21:38:13 INFO - "basedir": "/builds/slave/test", 21:38:13 INFO - "buildnumber": 891, 21:38:13 INFO - "slavename": "talos-linux64-ix-025", 21:38:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:38:13 INFO - "platform": "ubuntu64_hw", 21:38:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:38:13 INFO - "branch": "mozilla-aurora", 21:38:13 INFO - "repo_path": "releases/mozilla-aurora", 21:38:13 INFO - "revision": "ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1", 21:38:13 INFO - "stage_platform": "linux64-pgo", 21:38:13 INFO - "builduid": "7bb677893a9d49069e1ba7881fa26215", 21:38:13 INFO - "slavebuilddir": "test" 21:38:13 INFO - } 21:38:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 21:38:13 INFO - Running post-action listener: _resource_record_post_action 21:38:13 INFO - [mozharness: 2016-11-14 05:38:13.992269Z] Finished read-buildbot-config step (success) 21:38:13 INFO - [mozharness: 2016-11-14 05:38:13.992358Z] Running download-and-extract step. 21:38:13 INFO - Running pre-action listener: _resource_record_pre_action 21:38:13 INFO - Running main action method: download_and_extract 21:38:13 INFO - mkdir: /builds/slave/test/build/tests 21:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:13 INFO - trying https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 21:38:13 INFO - Downloading https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/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 21:38:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/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 21:38:14 INFO - Downloaded 1361 bytes. 21:38:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 21:38:14 INFO - Using the following test package requirements: 21:38:14 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 21:38:14 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:38:14 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:38:14 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'jsshell-linux-x86_64.zip'], 21:38:14 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:38:14 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 21:38:14 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:38:14 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:38:14 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:38:14 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 21:38:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:38:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:38:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 21:38:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:14 INFO - Fetch https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:38:15 INFO - Expected file size: 21962623 21:38:19 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 21:38:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 21:38:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:38:19 INFO - Fetch https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:38:20 INFO - Expected file size: 21962623 21:38:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 21:38:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:38:24 INFO - Fetch https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:38:25 INFO - Expected file size: 14414089 21:38:25 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')]} 21:38:25 INFO - trying https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:38:25 INFO - Downloading https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/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 21:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/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 21:38:27 INFO - Downloaded 64075152 bytes. 21:38:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:38:27 INFO - mkdir: /builds/slave/test/properties 21:38:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:27 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:27 INFO - Contents: 21:38:27 INFO - build_url:https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 21:38:27 INFO - Running post-action listener: _resource_record_post_action 21:38:27 INFO - Running post-action listener: set_extra_try_arguments 21:38:27 INFO - [mozharness: 2016-11-14 05:38:27.921673Z] Finished download-and-extract step (success) 21:38:27 INFO - [mozharness: 2016-11-14 05:38:27.921951Z] Running populate-webroot step. 21:38:27 INFO - Running pre-action listener: _resource_record_pre_action 21:38:27 INFO - Running main action method: populate_webroot 21:38:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:27 INFO - '--tppagecycles', 21:38:27 INFO - '7'], 21:38:27 INFO - 'tests': ['tsvgm']}}, 21:38:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['damp', 'tps']}, 21:38:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['damp', 'tps']}, 21:38:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['dromaeo_dom']}, 21:38:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['basic_compositor_video']}, 21:38:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:38:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['a11yr', 21:38:27 INFO - 'ts_paint', 21:38:27 INFO - 'tpaint', 21:38:27 INFO - 'sessionrestore', 21:38:27 INFO - 'sessionrestore_no_auto_restore', 21:38:27 INFO - 'tabpaint']}, 21:38:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tsvgx', 21:38:27 INFO - 'tsvgr_opacity', 21:38:27 INFO - 'tart', 21:38:27 INFO - 'tscrollx', 21:38:27 INFO - 'cart']}, 21:38:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:27 INFO - 'tsvgr_opacity', 21:38:27 INFO - 'tart', 21:38:27 INFO - 'tscrollx', 21:38:27 INFO - 'cart']}, 21:38:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s'], 21:38:27 INFO - 'tests': ['tp5o']}, 21:38:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'tests': ['tp5o']}, 21:38:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--disable-e10s', 21:38:27 INFO - '--xperf_path', 21:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:27 INFO - 'tests': ['tp5n']}, 21:38:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:27 INFO - 'talos_options': ['--xperf_path', 21:38:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:27 INFO - 'tests': ['tp5n']}}, 21:38:27 INFO - 'talos.zip': {'path': '', 21:38:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:27 INFO - Running post-action listener: _resource_record_post_action 21:38:27 INFO - [mozharness: 2016-11-14 05:38:27.940133Z] Finished populate-webroot step (success) 21:38:27 INFO - [mozharness: 2016-11-14 05:38:27.940222Z] Running create-virtualenv step. 21:38:27 INFO - Running pre-action listener: _resource_record_pre_action 21:38:27 INFO - Running main action method: create_virtualenv 21:38:27 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:27 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 21:38:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:28 INFO - Using real prefix '/usr' 21:38:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:28 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:30 INFO - Installing pip.................done. 21:38:30 INFO - Return code: 0 21:38:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:30 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')]} 21:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 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')]} 21:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:30 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 21:38:30 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 21:38:30 INFO - Using env: {'DISPLAY': ':0', 21:38:30 INFO - 'HOME': '/home/cltbld', 21:38:30 INFO - 'LANG': 'en_US.UTF-8', 21:38:30 INFO - 'LANGUAGE': 'en_US:en', 21:38:30 INFO - 'LOGNAME': 'cltbld', 21:38:30 INFO - 'MAIL': '/var/mail/cltbld', 21:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:30 INFO - 'MOZ_NO_REMOTE': '1', 21:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:30 INFO - 'NO_EM_RESTART': '1', 21:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:30 INFO - 'PWD': '/builds/slave/test', 21:38:30 INFO - 'SHELL': '/bin/bash', 21:38:30 INFO - 'SHLVL': '1', 21:38:30 INFO - 'TERM': 'linux', 21:38:30 INFO - 'TMOUT': '86400', 21:38:30 INFO - 'USER': 'cltbld', 21:38:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:30 INFO - '_': '/tools/buildbot/bin/python'} 21:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:30 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 21:38:30 INFO - Cleaning up... 21:38:30 INFO - Return code: 0 21:38:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:30 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')]} 21:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 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')]} 21:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:30 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:30 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 21:38:30 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 21:38:30 INFO - Using env: {'DISPLAY': ':0', 21:38:30 INFO - 'HOME': '/home/cltbld', 21:38:30 INFO - 'LANG': 'en_US.UTF-8', 21:38:30 INFO - 'LANGUAGE': 'en_US:en', 21:38:30 INFO - 'LOGNAME': 'cltbld', 21:38:30 INFO - 'MAIL': '/var/mail/cltbld', 21:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:30 INFO - 'MOZ_NO_REMOTE': '1', 21:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:30 INFO - 'NO_EM_RESTART': '1', 21:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:30 INFO - 'PWD': '/builds/slave/test', 21:38:30 INFO - 'SHELL': '/bin/bash', 21:38:30 INFO - 'SHLVL': '1', 21:38:30 INFO - 'TERM': 'linux', 21:38:30 INFO - 'TMOUT': '86400', 21:38:30 INFO - 'USER': 'cltbld', 21:38:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:30 INFO - '_': '/tools/buildbot/bin/python'} 21:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:30 INFO - Downloading/unpacking psutil>=3.1.1 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:30 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 21:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:32 INFO - Installing collected packages: psutil 21:38:32 INFO - Running setup.py install for psutil 21:38:33 INFO - building 'psutil._psutil_linux' extension 21:38:33 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 21:38:33 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 21:38:33 INFO - building 'psutil._psutil_posix' extension 21:38:33 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 21:38:33 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 21:38:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:33 INFO - Successfully installed psutil 21:38:33 INFO - Cleaning up... 21:38:33 INFO - Return code: 0 21:38:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:38:33 INFO - Using env: {'DISPLAY': ':0', 21:38:33 INFO - 'HOME': '/home/cltbld', 21:38:33 INFO - 'LANG': 'en_US.UTF-8', 21:38:33 INFO - 'LANGUAGE': 'en_US:en', 21:38:33 INFO - 'LOGNAME': 'cltbld', 21:38:33 INFO - 'MAIL': '/var/mail/cltbld', 21:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:33 INFO - 'MOZ_NO_REMOTE': '1', 21:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:33 INFO - 'NO_EM_RESTART': '1', 21:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:33 INFO - 'PWD': '/builds/slave/test', 21:38:33 INFO - 'SHELL': '/bin/bash', 21:38:33 INFO - 'SHLVL': '1', 21:38:33 INFO - 'TERM': 'linux', 21:38:33 INFO - 'TMOUT': '86400', 21:38:33 INFO - 'USER': 'cltbld', 21:38:33 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:33 INFO - '_': '/tools/buildbot/bin/python'} 21:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:33 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 21:38:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:35 INFO - Installing collected packages: mozsystemmonitor 21:38:35 INFO - Running setup.py install for mozsystemmonitor 21:38:35 INFO - Successfully installed mozsystemmonitor 21:38:35 INFO - Cleaning up... 21:38:35 INFO - Return code: 0 21:38:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:35 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')]} 21:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:35 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')]} 21:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:35 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:35 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 21:38:35 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 21:38:35 INFO - Using env: {'DISPLAY': ':0', 21:38:35 INFO - 'HOME': '/home/cltbld', 21:38:35 INFO - 'LANG': 'en_US.UTF-8', 21:38:35 INFO - 'LANGUAGE': 'en_US:en', 21:38:35 INFO - 'LOGNAME': 'cltbld', 21:38:35 INFO - 'MAIL': '/var/mail/cltbld', 21:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:35 INFO - 'MOZ_NO_REMOTE': '1', 21:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:35 INFO - 'NO_EM_RESTART': '1', 21:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:35 INFO - 'PWD': '/builds/slave/test', 21:38:35 INFO - 'SHELL': '/bin/bash', 21:38:35 INFO - 'SHLVL': '1', 21:38:35 INFO - 'TERM': 'linux', 21:38:35 INFO - 'TMOUT': '86400', 21:38:35 INFO - 'USER': 'cltbld', 21:38:35 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:35 INFO - '_': '/tools/buildbot/bin/python'} 21:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:36 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:36 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 21:38:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:38 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:38 INFO - warning: no files found matching '*.txt' 21:38:38 INFO - no previously-included directories found matching 'build' 21:38:38 INFO - no previously-included directories found matching 'dist' 21:38:38 INFO - no previously-included directories found matching '.git*' 21:38:38 INFO - Installing collected packages: jsonschema, functools32 21:38:38 INFO - Running setup.py install for functools32 21:38:38 INFO - warning: no files found matching '*.txt' 21:38:38 INFO - no previously-included directories found matching 'build' 21:38:38 INFO - no previously-included directories found matching 'dist' 21:38:38 INFO - no previously-included directories found matching '.git*' 21:38:38 INFO - Successfully installed jsonschema functools32 21:38:38 INFO - Cleaning up... 21:38:38 INFO - Return code: 0 21:38:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:38 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')]} 21:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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')]} 21:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:38 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 21:38:38 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 21:38:38 INFO - Using env: {'DISPLAY': ':0', 21:38:38 INFO - 'HOME': '/home/cltbld', 21:38:38 INFO - 'LANG': 'en_US.UTF-8', 21:38:38 INFO - 'LANGUAGE': 'en_US:en', 21:38:38 INFO - 'LOGNAME': 'cltbld', 21:38:38 INFO - 'MAIL': '/var/mail/cltbld', 21:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:38 INFO - 'MOZ_NO_REMOTE': '1', 21:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:38 INFO - 'NO_EM_RESTART': '1', 21:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:38 INFO - 'PWD': '/builds/slave/test', 21:38:38 INFO - 'SHELL': '/bin/bash', 21:38:38 INFO - 'SHLVL': '1', 21:38:38 INFO - 'TERM': 'linux', 21:38:38 INFO - 'TMOUT': '86400', 21:38:38 INFO - 'USER': 'cltbld', 21:38:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:38 INFO - '_': '/tools/buildbot/bin/python'} 21:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:38 INFO - Cleaning up... 21:38:38 INFO - Return code: 0 21:38:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:38 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')]} 21:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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')]} 21:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:38 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:38 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 21:38:38 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 21:38:38 INFO - Using env: {'DISPLAY': ':0', 21:38:38 INFO - 'HOME': '/home/cltbld', 21:38:38 INFO - 'LANG': 'en_US.UTF-8', 21:38:38 INFO - 'LANGUAGE': 'en_US:en', 21:38:38 INFO - 'LOGNAME': 'cltbld', 21:38:38 INFO - 'MAIL': '/var/mail/cltbld', 21:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:38 INFO - 'MOZ_NO_REMOTE': '1', 21:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:38 INFO - 'NO_EM_RESTART': '1', 21:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:38 INFO - 'PWD': '/builds/slave/test', 21:38:38 INFO - 'SHELL': '/bin/bash', 21:38:38 INFO - 'SHLVL': '1', 21:38:38 INFO - 'TERM': 'linux', 21:38:38 INFO - 'TMOUT': '86400', 21:38:38 INFO - 'USER': 'cltbld', 21:38:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:38 INFO - '_': '/tools/buildbot/bin/python'} 21:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:38 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 21:38:40 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:40 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 21:38:40 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 21:38:40 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 21:38:40 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 21:38:40 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 21:38:40 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 21:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:38:41 INFO - Downloading docopt-0.6.1.tar.gz 21:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:41 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:41 INFO - Running setup.py install for blobuploader 21:38:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:41 INFO - Running setup.py install for requests 21:38:42 INFO - Running setup.py install for docopt 21:38:42 INFO - Successfully installed blobuploader requests docopt 21:38:42 INFO - Cleaning up... 21:38:42 INFO - Return code: 0 21:38:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:42 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 21:38:42 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 21:38:42 INFO - Using env: {'DISPLAY': ':0', 21:38:42 INFO - 'HOME': '/home/cltbld', 21:38:42 INFO - 'LANG': 'en_US.UTF-8', 21:38:42 INFO - 'LANGUAGE': 'en_US:en', 21:38:42 INFO - 'LOGNAME': 'cltbld', 21:38:42 INFO - 'MAIL': '/var/mail/cltbld', 21:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:42 INFO - 'MOZ_NO_REMOTE': '1', 21:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:42 INFO - 'NO_EM_RESTART': '1', 21:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:42 INFO - 'PWD': '/builds/slave/test', 21:38:42 INFO - 'SHELL': '/bin/bash', 21:38:42 INFO - 'SHLVL': '1', 21:38:42 INFO - 'TERM': 'linux', 21:38:42 INFO - 'TMOUT': '86400', 21:38:42 INFO - 'USER': 'cltbld', 21:38:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:42 INFO - '_': '/tools/buildbot/bin/python'} 21:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:42 INFO - Running setup.py (path:/tmp/pip-EUljIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:42 INFO - Running setup.py (path:/tmp/pip-TjNQ0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:42 INFO - Running setup.py (path:/tmp/pip-pzFasA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:42 INFO - Running setup.py (path:/tmp/pip-iwQR_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:42 INFO - Running setup.py (path:/tmp/pip-OzQjAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:42 INFO - Running setup.py (path:/tmp/pip-4Z5qs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:42 INFO - Running setup.py (path:/tmp/pip-d9t1Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:42 INFO - Running setup.py (path:/tmp/pip-OQX7S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:42 INFO - Running setup.py (path:/tmp/pip-4jPKgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:43 INFO - Running setup.py (path:/tmp/pip-zeR8_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:43 INFO - Running setup.py (path:/tmp/pip-QgZoc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:43 INFO - Running setup.py (path:/tmp/pip-OENPVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:43 INFO - Running setup.py (path:/tmp/pip-Gb5V3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:43 INFO - Running setup.py (path:/tmp/pip-XyYveL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:43 INFO - Running setup.py (path:/tmp/pip-ABsCvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:43 INFO - Running setup.py (path:/tmp/pip-EerjCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:43 INFO - Running setup.py (path:/tmp/pip-2yXfSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:43 INFO - Running setup.py install for manifestparser 21:38:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:43 INFO - Running setup.py install for mozcrash 21:38:43 INFO - Running setup.py install for mozdebug 21:38:43 INFO - Running setup.py install for mozdevice 21:38:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozfile 21:38:44 INFO - Running setup.py install for mozhttpd 21:38:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozinfo 21:38:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozInstall 21:38:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozleak 21:38:44 INFO - Running setup.py install for mozlog 21:38:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for moznetwork 21:38:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozprocess 21:38:44 INFO - Running setup.py install for mozprofile 21:38:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:44 INFO - Running setup.py install for mozrunner 21:38:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:45 INFO - Running setup.py install for mozscreenshot 21:38:45 INFO - Running setup.py install for moztest 21:38:45 INFO - Running setup.py install for mozversion 21:38:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:45 INFO - Cleaning up... 21:38:45 INFO - Return code: 0 21:38:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:45 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:45 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 21:38:45 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 21:38:45 INFO - Using env: {'DISPLAY': ':0', 21:38:45 INFO - 'HOME': '/home/cltbld', 21:38:45 INFO - 'LANG': 'en_US.UTF-8', 21:38:45 INFO - 'LANGUAGE': 'en_US:en', 21:38:45 INFO - 'LOGNAME': 'cltbld', 21:38:45 INFO - 'MAIL': '/var/mail/cltbld', 21:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:45 INFO - 'MOZ_NO_REMOTE': '1', 21:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:45 INFO - 'NO_EM_RESTART': '1', 21:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:45 INFO - 'PWD': '/builds/slave/test', 21:38:45 INFO - 'SHELL': '/bin/bash', 21:38:45 INFO - 'SHLVL': '1', 21:38:45 INFO - 'TERM': 'linux', 21:38:45 INFO - 'TMOUT': '86400', 21:38:45 INFO - 'USER': 'cltbld', 21:38:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:45 INFO - '_': '/tools/buildbot/bin/python'} 21:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:45 INFO - Running setup.py (path:/tmp/pip-P_GN5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:45 INFO - Running setup.py (path:/tmp/pip-prxELq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:45 INFO - Running setup.py (path:/tmp/pip-Y3i4Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:45 INFO - Running setup.py (path:/tmp/pip-GyEfW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:45 INFO - Running setup.py (path:/tmp/pip-mYpEDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:45 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)) 21:38:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:46 INFO - Running setup.py (path:/tmp/pip-8MWgyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:46 INFO - Running setup.py (path:/tmp/pip-A0opnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:46 INFO - Running setup.py (path:/tmp/pip-bjuN2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:46 INFO - Running setup.py (path:/tmp/pip-G2uR1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:46 INFO - Running setup.py (path:/tmp/pip-yh2jYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:46 INFO - Running setup.py (path:/tmp/pip-ljJ55A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:46 INFO - Running setup.py (path:/tmp/pip-Kqr74k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:46 INFO - Running setup.py (path:/tmp/pip-DwYDqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:46 INFO - Running setup.py (path:/tmp/pip-56kUPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:46 INFO - Running setup.py (path:/tmp/pip-MpKidF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:46 INFO - Running setup.py (path:/tmp/pip-hfj7CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:46 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)) 21:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:46 INFO - Running setup.py (path:/tmp/pip-nGjQF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 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)) 21:38:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:46 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 21:38:48 INFO - Downloading blessings-1.6.tar.gz 21:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:38:48 INFO - Installing collected packages: blessings 21:38:48 INFO - Running setup.py install for blessings 21:38:48 INFO - Successfully installed blessings 21:38:48 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:49 INFO - Reading from file tmpfile_stdout 21:38:49 INFO - Current package versions: 21:38:49 INFO - argparse == 1.2.1 21:38:49 INFO - blessings == 1.6 21:38:49 INFO - blobuploader == 1.2.4 21:38:49 INFO - docopt == 0.6.1 21:38:49 INFO - functools32 == 3.2.3-2 21:38:49 INFO - jsonschema == 2.5.1 21:38:49 INFO - manifestparser == 1.1 21:38:49 INFO - mozInstall == 1.12 21:38:49 INFO - mozcrash == 0.17 21:38:49 INFO - mozdebug == 0.1 21:38:49 INFO - mozdevice == 0.48 21:38:49 INFO - mozfile == 1.2 21:38:49 INFO - mozhttpd == 0.7 21:38:49 INFO - mozinfo == 0.9 21:38:49 INFO - mozleak == 0.1 21:38:49 INFO - mozlog == 3.4 21:38:49 INFO - moznetwork == 0.27 21:38:49 INFO - mozprocess == 0.23 21:38:49 INFO - mozprofile == 0.28 21:38:49 INFO - mozrunner == 6.12 21:38:49 INFO - mozscreenshot == 0.1 21:38:49 INFO - mozsystemmonitor == 0.3 21:38:49 INFO - moztest == 0.7 21:38:49 INFO - mozversion == 1.4 21:38:49 INFO - psutil == 3.1.1 21:38:49 INFO - requests == 1.2.3 21:38:49 INFO - wsgiref == 0.1.2 21:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:49 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 21:38:49 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 21:38:49 INFO - Using env: {'DISPLAY': ':0', 21:38:49 INFO - 'HOME': '/home/cltbld', 21:38:49 INFO - 'LANG': 'en_US.UTF-8', 21:38:49 INFO - 'LANGUAGE': 'en_US:en', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MAIL': '/var/mail/cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SHLVL': '1', 21:38:49 INFO - 'TERM': 'linux', 21:38:49 INFO - 'TMOUT': '86400', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - '_': '/tools/buildbot/bin/python'} 21:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 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)) 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f883af74f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24bcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, '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': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', '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 21:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:38:49 INFO - Using env: {'DISPLAY': ':0', 21:38:49 INFO - 'HOME': '/home/cltbld', 21:38:49 INFO - 'LANG': 'en_US.UTF-8', 21:38:49 INFO - 'LANGUAGE': 'en_US:en', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MAIL': '/var/mail/cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SHLVL': '1', 21:38:49 INFO - 'TERM': 'linux', 21:38:49 INFO - 'TMOUT': '86400', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - '_': '/tools/buildbot/bin/python'} 21:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Running post-action listener: _resource_record_post_action 21:38:49 INFO - Running post-action listener: _start_resource_monitoring 21:38:49 INFO - Starting resource monitoring. 21:38:49 INFO - [mozharness: 2016-11-14 05:38:49.728285Z] Finished create-virtualenv step (success) 21:38:49 INFO - [mozharness: 2016-11-14 05:38:49.728738Z] Running install step. 21:38:49 INFO - Running pre-action listener: _resource_record_pre_action 21:38:49 INFO - Running main action method: install 21:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:38:49 INFO - Reading from file tmpfile_stdout 21:38:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:38:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:38:50 INFO - Reading from file tmpfile_stdout 21:38:50 INFO - Output received: 21:38:50 INFO - Usage: mozinstall [options] installer 21:38:50 INFO - Options: 21:38:50 INFO - -h, --help show this help message and exit 21:38:50 INFO - -d DEST, --destination=DEST 21:38:50 INFO - Directory to install application into. [default: 21:38:50 INFO - "/builds/slave/test"] 21:38:50 INFO - --app=APP Application being installed. [default: firefox] 21:38:50 INFO - mkdir: /builds/slave/test/build/application 21:38:50 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'] 21:38:50 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 21:39:05 INFO - Reading from file tmpfile_stdout 21:39:05 INFO - Output received: 21:39:05 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:05 INFO - Running post-action listener: _resource_record_post_action 21:39:05 INFO - [mozharness: 2016-11-14 05:39:05.993961Z] Finished install step (success) 21:39:05 INFO - [mozharness: 2016-11-14 05:39:05.994206Z] Running run-tests step. 21:39:05 INFO - Running pre-action listener: _resource_record_pre_action 21:39:05 INFO - Running main action method: run_tests 21:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:06 INFO - Python 2.7.3 21:39:06 INFO - Return code: 0 21:39:06 INFO - grabbing minidump binary from tooltool 21:39:06 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')]} 21:39:06 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 0x24b9f60>, '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 0x24bad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24bb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:06 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 21:39:06 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 21:39:06 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 21:39:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:06 INFO - Return code: 0 21:39:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:06 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/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 21:39:06 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/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 21:39:06 INFO - Using env: {'DISPLAY': ':0', 21:39:06 INFO - 'HOME': '/home/cltbld', 21:39:06 INFO - 'LANG': 'en_US.UTF-8', 21:39:06 INFO - 'LANGUAGE': 'en_US:en', 21:39:06 INFO - 'LOGNAME': 'cltbld', 21:39:06 INFO - 'MAIL': '/var/mail/cltbld', 21:39:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:06 INFO - 'MOZ_NO_REMOTE': '1', 21:39:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:06 INFO - 'NO_EM_RESTART': '1', 21:39:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:06 INFO - 'PWD': '/builds/slave/test', 21:39:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:06 INFO - 'SHELL': '/bin/bash', 21:39:06 INFO - 'SHLVL': '1', 21:39:06 INFO - 'TERM': 'linux', 21:39:06 INFO - 'TMOUT': '86400', 21:39:06 INFO - 'USER': 'cltbld', 21:39:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479101642.584761-257128037', 21:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:06 INFO - '_': '/tools/buildbot/bin/python'} 21:39:06 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/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 21:39:06 INFO - mozversion application_buildid: 20161113185720 21:39:06 INFO - mozversion application_changeset: ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 21:39:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:39:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:06 INFO - mozversion application_name: Firefox 21:39:06 INFO - mozversion application_remotingname: firefox-dev 21:39:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:39:06 INFO - mozversion application_vendor: Mozilla 21:39:06 INFO - mozversion application_version: 51.0a2 21:39:06 INFO - mozversion platform_buildid: 20161113185720 21:39:06 INFO - mozversion platform_changeset: ecfbd26aa2aca52f50463f44a4b1a3fa0f7917a1 21:39:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:39:06 INFO - mozversion platform_version: 51.0a2 21:39:06 INFO - using testdate: 1479101946 21:39:06 INFO - actual date: 1479101946 21:39:06 INFO - starting webserver on 'localhost:51735' 21:39:06 INFO - SUITE-START | Running 2 tests 21:39:06 INFO - TEST-START | dromaeo_css 21:39:06 INFO - operating with platform_type : linux_ 21:39:06 INFO - Initialising browser for dromaeo_css test... 21:39:06 INFO - TEST-INFO | started process 6417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCaHKg/profile http://localhost:51735/getInfo.html) 21:39:10 INFO - PROCESS | 6417 | __metrics Screen width/height:1600/1200 21:39:10 INFO - PROCESS | 6417 | colorDepth:24 21:39:10 INFO - PROCESS | 6417 | Browser inner width/height: 1024/697 21:39:10 INFO - PROCESS | 6417 | __metrics 21:39:10 INFO - PROCESS | 6417 | 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" 21:39:10 INFO - PROCESS | 6417 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:39:11 INFO - PROCESS | 6417 | console.error: PushService: 21:39:11 INFO - PROCESS | 6417 | stateChangeProcessEnqueue: Error transitioning state 21:39:11 INFO - PROCESS | 6417 | UnknownError 21:39:12 INFO - TEST-INFO | 6417: exit 0 21:39:12 INFO - Browser initialized. 21:39:12 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:12 INFO - TEST-INFO | started process 6506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCaHKg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:23 INFO - PROCESS | 6506 | RSS: Main: 144584704 21:39:23 INFO - PROCESS | 6506 | 21:40:15 INFO - PROCESS | 6506 | 1479102015314 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] 21:42:24 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51735/tests/dromaeo/cssquery-ext.html) 21:42:25 INFO - PROCESS | 6506 | RSS: Main: 240799744 21:42:25 INFO - PROCESS | 6506 | 21:45:27 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-ext.html (next: http://localhost:51735/tests/dromaeo/cssquery-jquery.html) 21:45:28 INFO - PROCESS | 6506 | RSS: Main: 234471424 21:45:28 INFO - PROCESS | 6506 | 21:48:30 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51735/tests/dromaeo/cssquery-mootools.html) 21:48:30 INFO - PROCESS | 6506 | RSS: Main: 174886912 21:48:30 INFO - PROCESS | 6506 | 21:51:32 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51735/tests/dromaeo/cssquery-prototype.html) 21:51:33 INFO - PROCESS | 6506 | RSS: Main: 218357760 21:51:33 INFO - PROCESS | 6506 | 21:54:35 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51735/tests/dromaeo/cssquery-yui.html) 21:54:36 INFO - PROCESS | 6506 | RSS: Main: 176508928 21:54:36 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-yui.html (next: http://localhost:51735/tests/dromaeo/cssquery-dojo.html) 21:57:39 INFO - PROCESS | 6506 | RSS: Main: 264159232 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | __start_tp_report 21:57:39 INFO - PROCESS | 6506 | _x_x_mozilla_page_load 21:57:39 INFO - PROCESS | 6506 | _x_x_mozilla_page_load_details 21:57:39 INFO - PROCESS | 6506 | |i|pagename|runs| 21:57:39 INFO - PROCESS | 6506 | |0;dojo.html;3132.263917979275;3172.825494597797;3180.9045728628134;3192.297694507208;3224.4518431866595;5491.588130890184;5553.194786755918;5568.248286481324;5569.860753481165;5588.832335029951;5467.942153508009;5521.061419558675;5524.33707955046;5535.169724541321;5549.667019978804;4968.453470118275;4987.177115775893;5004.649674522785;5035.446100928895;5073.644844860843;4886.462489126193;5017.824376146836;5068.493150684921;5069.062223488666;5074.137396642561;4858.757062146896;4926.11329960607;4960.801567937297;4962.727050012248;4991.126552853254;5013.172826483626;5044.848654540369;5046.6719663221775;5119.129747942859;5141.254518094893;4922.926156107661;4993.500649935014;5021.698698078127;5050.242463630448;5054.1407960646775;5249.606279529051;5285.524302812727;5312.335958005249;5362.570994320445;5415.1335786274;5862.20860183874;5873.823785286406;5906.5570082244;5918;5938.792142275;5961.5230781537375;5965.433283838029;5970.13433052205;5975.521958243374;5976.611520251213;5405;5447.12845944647;5527.972360138174;5561.332640083216;5577.888442231214;6073.939260607337;6113.755449782047;6114.480269177081;6120.479759220516;6125.571210015256;5860.179574859523;5875.706214689249;5881.323647780475;5881.411858814085;5886.440788125121;5624.831255062355;5690.743916523684;5778.855528611818;5825.417458254141;5838.5329173666005;5858.033424484912;5858.414158584107;5863.5309175265875;5864.32560255576;5894.115882617556;5812.564057695689;5874.853128671732;5879.029960056543;5880.911786323209;5898.321693005273;4464.709793863389;4510.75190864499;4512.323151527297;4537.319402089647;4555.2256116460285;4082.755034697928;4083.1629515949753;4090.4682391288943;4111.958880411217;4129.112240868228;5608.495235428831;5613.129964855372;5621.690807005654;5632.97183514088;5634.661920284796;5782.797602083907;5836.445537673914;5870.765169393177;5960.642361458326;5969.701514924236;5576.776928922879;5619.831405057855;5626.85932851682;5645.717714114277;5651.745671444794;5161.819336323286;5168.431472538018;5170.741462926914;5172.353455818023;5200.115980283361;5743.74153163117;5899.528037756883;6114.174586430864;6120.234970628671;6131.938680613137;5767.452092051249;5769.68266745333;5829.271341082364;5845.1232315153065;5881.206037184926;6002.489788368038;6017.879642407215;6022.217111775616;6024.578279520391;6028.0355143176885;5730.1977723119635;5839.562032847469;5843.29880414353;5845.473907348359;5847.970760146172;5747.166660834239;5800.535957123336;5823.854403639943;5892.292924849045;5909.054551271776;5721.713914304185;5724.055530837365;5727.656340619576;5729.770809167753;5729.799457018984;5612.466815652507;5730.169125476699;5730.799422020376;5736;5743.741531631003;5574.526165275997;5617.4101719320515;5671.858203544944;5699.886002279848;5715.485606295453;5826.155207494805;5838.795642152504;5840.94159058404;5842.766289348378;5869.589128760946;5587.217789509391;5699.886002279848;5715.628484148517;5719.542436605145;5720.427957204246 21:57:39 INFO - PROCESS | 6506 | |1;ext.html;587.967661778602;635.9395857393547;636.0649844728251;640.5164101103666;644.7775517446479;36098.819505902466;39487.210255794904;39582;39658.60341396589;39711.80144099276;39693.20613587726;40427;47822.76088619552;48865;49096.26355604669;9195.862062069074;9327.16055555;9336.159745622892;9341.626334946593;9344.299177561676;9368.90631093687;9443.05569443057;9460.053994600554;9464.858027129598;9465.62137514502;8633.438826476291;8837.646494140226;8839.46963182208;9030.593623286968;11175.66473005807;10975.725606859813;11371.829422558669;11396.943015284953;11411.657650270423;11414.54341826326;11122.110231181567;11130.05394541465;11197.44012799365;11212.542369491995;11216.383098929555;35887.4616880747;36245;44427;46185.07629847418;46647.76676116631;3639.526861507987;3716.3310604091253;3773.52830896138;3784.5458544974504;3907.1404291055924;35040.54716169869;35366.82316588401;35441.261372459405;36078;37046.44430333547;4668.43978722552;4669.579737823612;4692.319613656035;4704.670673052888;4796.208625576775;379822;382622;383602;383705.9999999972;385487;65857;66191.66904165449;66204.00693989595;66378;66380;62729;64129;69096;70079;70454.64772676103;19729.309474168334;19871.205151794056;19890.104945277497;19891;19931.10310036052;15345;15441.613959651098;15470.071795692294;15471.14908680011;15476.535703928901;21140.577188456453;21165.25921592737;21372.35882923515;21452.78547214539;21492;6121.877562448815;7153.4992550520965;7336.266373362621;7434.3309102181065;7649.57927313992;808.9110197878229;903.5578207729255;958.3866325551653;986.6201512417771;1033.4729288063143;31720.524192137138;33246.335073298396;33260.1684957878;33443.50094073849;33499.66500335014;1082.5832054659013;1090.3239991205503;1094.8686157660973;1102.211918478276;1182.5624518928053;17081.48755537336;17526;17568.56078598045;17729.29082836698;17730.73403898917;616422;621582;623528;623907;624234;64236;64748;64875.351246486935;64958;65081.67459162674;1266.5250531050856;1271.3833790611545;1272.866349033338;1413.250976982201;1444.0830072903782;28416.57375139333;33284.500732488545;35617.64382356143;35650.8217458911;36276.27447450983;61552.69223653853;61968;62056.689716551125;62150.06774898471;62201.68899155475;517900;520124;523388;523820;524290;30576.929807456632;30870;49084.509154907995;50058.249126263865;50237.49762502328;46581.53418465772;46766;48361.75819120882;53080.73459632677;55322.72338638281;44724.55275447334;44829.55170448254;46613;47002.29496557623;48138;44209.778951105036;45837.541624583326;46461.535384647075;47005.05989880115;47193.292100619205;41709.79145104255;41729.1654166921;42154;42216.155676886905;42546.57453425426;38177.42733858939;40552.59447405488;40576.1884762309;40898.79550602228;41194.794026029675;28610.14169574916;28880;28911.566326504697;28934.565981510714;29238.853805730836 21:57:39 INFO - PROCESS | 6506 | |2;jquery.html;412.55444120350046;418.82618713234;427.19260597470804;428.8713385984204;442.8095918754936;18961.14674839632;20225.595488090246;20824.167033318667;21353.679694804552;21613.243536476228;16265.918670406661;19113.23547058116;19636.803631963678;19736.111874965623;20419;5237.607179461536;5476.288082549263;5478.01395748765;5480.095784195603;5487.2317875497465;5405.081136206834;5466.617336786407;5482.725863706799;5812.186293918855;6065;6073.149759033717;6074.696265186745;6087.360827113133;6089.391060893898;6096.664683442409;5869.266341707286;6007.7596896124105;6022;6051.152838602599;6088.056351265561;5861.413858614147;5870.735816888207;5876.706164691748;5885.470307672287;5895.882082358372;14547.927260363631;14664.266786660624;23816.166434174895;24044.639330409882;25010.749892501022;2305.319930620471;2406.4585468269497;2436.439618887666;2528.696556413242;2800.915972520828;10553.78892422155;10570.312929659625;10770.676879693621;11351.20541562091;12160.08799340053;1808.3128411203659;1947.0070264165236;2028.2698228637678;2174.3150907464096;2183.5742030304095;89113;98015.50992244993;100695;111019;112267.43866280698;16666.833331666527;18417.723734143998;18538.351157709414;18696.719549206773;18924.621507570046;35127.4730879037;35214.29571408557;35351.29297414089;35431.64568354283;35641.46537801935;10689.83965240522;10911.563537458413;11007.284526505751;11045.668629941114;11199;9331.393459425115;9363.672271470467;9378.95310523443;9396.812063758824;9602.375845570015;9233.630654773868;9470.14768670823;9534.237261019101;9615.711528654152;9672.129508344282;2875.25243436708;3263.8041717497026;3322.487580533463;3571.178628915312;3651.908702282411;899.4783025844994;910.977225569366;941.8304705153138;947.303731757158;1001.519270750044;18387.172577234058;19209.32767353136;19370.903145484463;19418;19696.70454943177;950.3062764182185;959.69289827256;970.403202030746;1012.3318609717699;1019.556492925565;9405.858912116324;10895.673129806119;10950.835737463944;10959.83560246597;11012.614558490575;528708;542933;554390;557876;565008;93926;95807.52096239474;96843;99079.50460247653;99281.50359248157;1032.2670903658336;1050.8844027157006;1077.9137668986461;1079.4009324824797;1088.2056099047738;17744.46766597004;17995.2801887923;18096;18442;18490.630187396448;44133.77933110314;44266.33600495931;44618;44725.55274447344;45388.319175211735;61827.381726183965;62110;62317.37682623116;62429;62455.6877215611;8983.730488085368;9257.67598134062;9268.212201962908;9281.67514137002;9404.670836520689;12218.327991960528;13845.376958036712;13887.305634718427;14242.928785356422;14292.213928234047;11752.76494470123;11965.282083075042;12244.571439999558;12318.58336291338;12456.564020259248;12069.456874440846;12127.514899403925;12243.632691019284;12290.385480726107;12476.18904771187;11931.940340298243;12051.216670916363;12197.573084941985;12227.510899563918;12470.875291246972;8978.326625502983;9074.954625226832;9085.13691199335;9161.587728552364;9404.95297523508;9248;11893.345865977455;11913.285202887855;12236.632901012983;12517.93741031289 21:57:39 INFO - PROCESS | 6506 | |3;mootools.html;1500.5723368839879;1539.7459419195834;1690.1464760296055;1848.2237460266688;1855.6845336292838;8931.821363572724;9690.079442452956;9693.757656058593;9705.757356066102;9708.223342132631;8263.958680206606;8472.745817625466;8476.957615211932;8895.110488951117;9490.525473726304;2480.3179125740385;2539.9111031113916;2547.6051212062066;2547.8089143314232;2558.2325302409295;2449.8040156787415;2490.663760392342;2491.6262560615874;2491.6636254105647;2492.4142826435773;2461.396957745355;2480.6775119234476;2498.8750562471896;2505.9373515662073;2509.6737424134835;2436.890339934698;2440.1947357372023;2457.901683932658;2458.7418321076207;2473.5300292944285;2423.09134074722;2443.780059794627;2444.877756112205;2445.1075357494387;2449.5223431430877;9501.572429240701;9553.044695530461;9560.665376711782;9568.760780980461;9574.664886729;5301.6818990860675;5452.345718513764;5471.343438787331;5475.534579560742;5478.863028424282;3636.2000359920776;3717.107894105395;3774.5281839770028;3776.7922764247955;3795.6773674237725;1223.8347823043864;1263.5072321794507;1276.8340115784981;1328.0477697784243;1339.5043833781563;12036.217645852992;12062.69843253917;12443.751124977449;12711.872881271162;12747.42636581356;4835.661503694708;4843.75781210938;4853.39332583427;4946.1344264753525;4956.083124621957;10274;10281;10307.793844123076;10313.27807053499;10315.587376505006;5538.972305138448;5546.77812887488;5549.694766787785;5550.195221692913;5553.527950124204;4649.209634362167;4728.881777955578;4823.3729615149805;5223.4515375884985;5223.52988231061;3981.2833689936087;4032.495938007749;4062.471878655815;4088.059746258318;4122;1268.7081971146688;1272.465564462928;1281.9423125959167;1284.5504073574175;1296.7795474769123;783.6473586885924;895.4716717136921;939.957701903416;964.8890377606665;977.7066879935991;5775.075987841925;5808.6224395414165;5843;5889.38161493037;6037.607555508966;479.38638542665444;482.93480380148935;489.84080173942897;490.14959046055066;490.6001608688907;3802.8098595070137;4043.393490976377;4096.078382363944;4120.134771697917;4148.315527937917;11518.078553715683;11810.055195584333;11924.761504769856;11947.880521194851;11964.282143071443;11704.473298701409;11836.70408239801;11849.822252666218;11860.762784744256;11863.703407414883;8622.31021518277;8672;8788.648454061893;8794.076621954731;8803.075677053945;5919.763209471573;5987.191729116514;6043.3352331244405;6047.818565443044;6168.599041062316;10275.84586231222;10780.568777249136;10831.67504974852;10865.728356790827;10932.617358392736;10665.680029599125;10910.509027093958;10930.617428389969;10936.726581835517;11048.392338421463;7033.648317583998;7637.656305466378;8005.919940800517;8154.551499667576;8349;9118.088191180828;9290.210332121846;9294.488803115622;9301.953490232505;9317.534123293945;7850.960745196237;7911.485753426009;7919.208079192034;8096.109427963037;8186;7639.274268944441;7708.075030996316;7739.3421559165845;7766.029246344207;7767.572783496962;7391.2239214881665;7407.740729074457;7475.289847464483;7491.9625401872645;7495.1005879294835;5288.312519372457;5294.8941021180135;5358.437364076872;5373.623846330719;5382.381026181883;5015.623828212826;5161.716105614077;5189.065968125623;5207.947920520898;5235.0576896159055 21:57:39 INFO - PROCESS | 6506 | |4;prototype.html;341.55427167546355;347.60373174580974;353.8230884557722;354.7179991906434;359.9370110230709;5567.638103523268;5614.578906582003;5646.096624540074;5650.237217975582;5673.319201695797;5287.47125287471;5407.540359069474;5416.593755468346;5416.674999500033;5579.553635709143;4153.937690934638;4280.529141794408;4283.807228674717;4324.54592267812;4345.891352716176;4325.762083085429;4352.281873490871;4353.151135528573;4356.956430435703;4362.650987920974;4096.897577560555;4280.850170244042;4286.892827679302;4301.204277208726;4310.07333423314;4298.376735373385;4299.226139294926;4306.966328081254;4317.114991426765;4325.221460137174;3787.1100291431767;3787.3750831112834;3804.4863943367845;3807.5240594925635;3816.5229346331707;5206.661566998171;5398.595105367113;5431.782728690848;5437.972810135963;5469.808556700496;4929.408470983469;4953.23224900141;4983.277424773388;4990.90018199634;4997.525235102659;5785.739641716133;5788.18965344852;5808.099744539603;5816.738246778863;5834.353529044347;4092.3043082676018;4166.58334166584;4189.937150942738;4200.957990420118;4212.473440819897;6055.7274922628585;6059.575829691923;6079.088136779475;6083.665398403086;6087.726052327655;4300.8709738707885;4303.397524346594;4304.634106100953;4306.827726890952;4308.719933204332;4234.216669916013;4308.526062133163;4339.522652508222;4339.633015600076;4340.65274778017;4936.555709986047;4950.3069570260195;4953.18272485036;4954.256861470736;4958.8760280993265;5872.530197584183;5884.911726324109;5898.726206955181;5912.526997840162;5937.228160339128;1419.6450887278181;1427.4789701758991;1457.1330058615108;1484.7401704701633;1493.7684658877674;1008.8184126857236;1013.2906965124295;1029.1149611334247;1030.258214085857;1032.7056788815153;5576.470235327637;5624.662520248717;5635.323761148688;5644.153376993484;5653.575981801381;5941.435563621449;5941.494972927263;5957.374475680078;5976.6989708962365;5984.491318237911;5462.552423607747;5594.901911783081;5598.944010559842;5610.18652295423;5637.46444087811;3156.9684303157132;3166.794158379698;3167.920801979923;3169.952450713241;3182.3158021025592;6002.849928751816;6135.9079613805825;6142.969285153546;6165.599236049642;6182.629042257479;6083.11794789753;6119.204503414528;6123.693815309217;6131.448169664752;6145.293291271471;6161.291451483136;6167.691615419211;6168.136460895388;6171.228596425447;6181.721822517998;5701.971490142523;5849.327327357239;5924.407559244041;5933.525317974465;5986.161937328865;5856.619319744203;5870;5874.823755287348;5886.6173698709445;5887.646741195542;5848.766049357978;6031.185789918305;6107.725152368243;6114.144019837137;6115.357887421935;4250.638695710775;4264.8294068238165;4265.594768496988;4269.530351661253;4282.336237883133;5922.5261979040715;5926.7925622603;5938.346781853907;5957.791477298274;5962.940370596412;5649.4633009864;5674.375818659862;5703.971480142739;5761.971190144022;5843.853903652443;5818.799660186795;5840.94159058404;5843.772807710428;5869.735861886311;5880.411958804086;5630.971845140748;5778.306603207642;5784.82645520635;5805.448482394166;5812.854678633068;5901.970490147522;5914.763409463573;5922.200502932222;5923.674197919156;5934.554908381802;5650.23721797552;5779.537636988946;5782.826515204551;5786.594938354275;5788.363280039276 21:57:39 INFO - PROCESS | 6506 | |5;yui.html;749.7113611259664;781.7537475695156;814.4787336104893;827.8592639251327;882.554310073413;15883.602909927258;16207.432739854108;16210;16302.7554586681;16399.262033208506;16157.111358875258;16473.917630411863;16474.258658360373;16489.67020659586;16504.33982640696;707.3421717802441;714.7855643307013;837.3175861672718;857.918497742715;866.6706651472432;855.5422848775906;858.6865793985213;861.9138086191393;861.9569021548929;863.6027427383411;913.137085454246;916.0152835701614;917.8302014127374;918.2699753695795;918.9586468608895;743.0971369785709;755.8034910923144;864.8313578852126;871.7820544863785;880.828238493494;650.9121268628722;654.9246836613803;654.9607023578601;655.2562841175253;655.7639249870043;15873.841261587468;15905.284262208228;15950;15967.520974370787;15983.520494385188;14720.411183552646;14859.554213373616;15035;15166.772498412422;15355.385784568603;13047.478100875953;13103.541376051888;13211.735765284737;13471.12437691547;13586.932065339708;4478.126765280772;4485.955140448619;4554.612857907082;4557.703749256288;4678.8596342109795;85804;86129;86188.56905715493;86471.56764216202;86487.56756216178;10330;10756.462176891124;10794.784104318027;10846.67459976202;10904.400257985886;22246.55506889853;22436.214732484284;22504.21235256758;22549.210777622706;22584;8658.653653853902;8687.870576824973;8869.201771840566;8938.46369217836;8965.686200982935;4191.077962848169;4332.090261045216;4347.347897815353;4470.552944705503;4518.774061296922;3706.79612621303;3858;3860.3244432224246;3863.632954869283;3868.883933482;602.764921680545;608.5435923057706;614.3089024847047;615.350804900834;617.5831313863124;661.6228749612675;701;740.2486476226634;776.2935728487049;778.093521047984;9594.232461403071;9680.951595241979;9745.561449734638;9850.408975461496;10261.333013354108;679.9524033317621;730.3463400256741;737.1927739125649;742.6509540515949;788.4559653838833;4581.725096494154;4877.3903262092235;4974.825881094144;5011.198208286657;5020.698758074527;76700.61649691715;102970;106009;113874;131386;111534.44232778784;115242;115584;115807.42096289633;115894;95616.52191739136;96733.09800705849;98058;99389.5091573627;99442.5027874856;9325.813483730422;9472.431654100776;9824.312298139348;9848.556814943202;9864.062914023156;56544.71727641336;56702;58076.70961645165;58454.41545584489;58963.705181473815;80578;86428.6785660727;87134.56432717796;88347;92283.53858230666;12401.93799030999;12907.419166137359;12958.481660733465;13081.149725267827;13318.134321269086;13844.653883652587;13982.510612128526;14580.34388452501;14821.407143714561;15398.692026159639;12198.756024879276;12287.631371058882;12601.085576625306;12978.480860765463;13013.609591712264;12039.4582243801;12054.77812465718;12412.56556020535;12489.437975291316;12607.684807879876;12658.620241392404;12876.613701588967;12892.290923998895;12929.482820687068;13013.804792928304;10419.270651054354;10465.215108866712;10718.303310285119;10733.892661073289;10765.078842479634;10988.505517251582;11210.66368008961;11269.492872820907;11273.300234860253;11296 21:57:39 INFO - PROCESS | 6506 | __end_tp_report 21:57:39 INFO - PROCESS | 6506 | __start_cc_report 21:57:39 INFO - PROCESS | 6506 | _x_x_mozilla_cycle_collect,855 21:57:39 INFO - PROCESS | 6506 | __end_cc_report 21:57:39 INFO - PROCESS | 6506 | __startTimestamp1479103059310__endTimestamp 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | ------- Summary: start ------- 21:57:39 INFO - PROCESS | 6506 | Number of tests: 6 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#0] dojo.html Cycles:165 Average:5470.55 Median:5699.89 stddev:610.39 (10.7%) stddev-sans-first:584.05 21:57:39 INFO - PROCESS | 6506 | Values: 3132.3 3172.8 3180.9 3192.3 3224.5 5491.6 5553.2 5568.2 5569.9 5588.8 5467.9 5521.1 5524.3 5535.2 5549.7 4968.5 4987.2 5004.6 5035.4 5073.6 4886.5 5017.8 5068.5 5069.1 5074.1 4858.8 4926.1 4960.8 4962.7 4991.1 5013.2 5044.8 5046.7 5119.1 5141.3 4922.9 4993.5 5021.7 5050.2 5054.1 5249.6 5285.5 5312.3 5362.6 5415.1 5862.2 5873.8 5906.6 5918.0 5938.8 5961.5 5965.4 5970.1 5975.5 5976.6 5405.0 5447.1 5528.0 5561.3 5577.9 6073.9 6113.8 6114.5 6120.5 6125.6 5860.2 5875.7 5881.3 5881.4 5886.4 5624.8 5690.7 5778.9 5825.4 5838.5 5858.0 5858.4 5863.5 5864.3 5894.1 5812.6 5874.9 5879.0 5880.9 5898.3 4464.7 4510.8 4512.3 4537.3 4555.2 4082.8 4083.2 4090.5 4112.0 4129.1 5608.5 5613.1 5621.7 5633.0 5634.7 5782.8 5836.4 5870.8 5960.6 5969.7 5576.8 5619.8 5626.9 5645.7 5651.7 5161.8 5168.4 5170.7 5172.4 5200.1 5743.7 5899.5 6114.2 6120.2 6131.9 5767.5 5769.7 5829.3 5845.1 5881.2 6002.5 6017.9 6022.2 6024.6 6028.0 5730.2 5839.6 5843.3 5845.5 5848.0 5747.2 5800.5 5823.9 5892.3 5909.1 5721.7 5724.1 5727.7 5729.8 5729.8 5612.5 5730.2 5730.8 5736.0 5743.7 5574.5 5617.4 5671.9 5699.9 5715.5 5826.2 5838.8 5840.9 5842.8 5869.6 5587.2 5699.9 5715.6 5719.5 5720.4 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#1] ext.html Cycles:180 Average:68221.47 Median:42185.08 stddev:137729.57 (326.5%) stddev-sans-first:138022.32 21:57:39 INFO - PROCESS | 6506 | Values: 588.0 635.9 636.1 640.5 644.8 36098.8 39487.2 39582.0 39658.6 39711.8 39693.2 40427.0 47822.8 48865.0 49096.3 9195.9 9327.2 9336.2 9341.6 9344.3 9368.9 9443.1 9460.1 9464.9 9465.6 8633.4 8837.6 8839.5 9030.6 11175.7 10975.7 11371.8 11396.9 11411.7 11414.5 11122.1 11130.1 11197.4 11212.5 11216.4 35887.5 36245.0 44427.0 46185.1 46647.8 3639.5 3716.3 3773.5 3784.5 3907.1 35040.5 35366.8 35441.3 36078.0 37046.4 4668.4 4669.6 4692.3 4704.7 4796.2 379822.0 382622.0 383602.0 383706.0 385487.0 65857.0 66191.7 66204.0 66378.0 66380.0 62729.0 64129.0 69096.0 70079.0 70454.6 19729.3 19871.2 19890.1 19891.0 19931.1 15345.0 15441.6 15470.1 15471.1 15476.5 21140.6 21165.3 21372.4 21452.8 21492.0 6121.9 7153.5 7336.3 7434.3 7649.6 808.9 903.6 958.4 986.6 1033.5 31720.5 33246.3 33260.2 33443.5 33499.7 1082.6 1090.3 1094.9 1102.2 1182.6 17081.5 17526.0 17568.6 17729.3 17730.7 616422.0 621582.0 623528.0 623907.0 624234.0 64236.0 64748.0 64875.4 64958.0 65081.7 1266.5 1271.4 1272.9 1413.3 1444.1 28416.6 33284.5 35617.6 35650.8 36276.3 61552.7 61968.0 62056.7 62150.1 62201.7 517900.0 520124.0 523388.0 523820.0 524290.0 30576.9 30870.0 49084.5 50058.2 50237.5 46581.5 46766.0 48361.8 53080.7 55322.7 44724.6 44829.6 46613.0 47002.3 48138.0 44209.8 45837.5 46461.5 47005.1 47193.3 41709.8 41729.2 42154.0 42216.2 42546.6 38177.4 40552.6 40576.2 40898.8 41194.8 28610.1 28880.0 28911.6 28934.6 29238.9 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#2] jquery.html Cycles:180 Average:32750.27 Median:3293.15 stddev:90743.10 (2755.5%) stddev-sans-first:90965.17 21:57:39 INFO - PROCESS | 6506 | Values: 412.6 418.8 427.2 428.9 442.8 18961.1 20225.6 20824.2 21353.7 21613.2 16265.9 19113.2 19636.8 19736.1 20419.0 5237.6 5476.3 5478.0 5480.1 5487.2 5405.1 5466.6 5482.7 5812.2 6065.0 6073.1 6074.7 6087.4 6089.4 6096.7 5869.3 6007.8 6022.0 6051.2 6088.1 5861.4 5870.7 5876.7 5885.5 5895.9 14547.9 14664.3 23816.2 24044.6 25010.7 2305.3 2406.5 2436.4 2528.7 2800.9 10553.8 10570.3 10770.7 11351.2 12160.1 1808.3 1947.0 2028.3 2174.3 2183.6 89113.0 98015.5 100695.0 111019.0 112267.4 16666.8 18417.7 18538.4 18696.7 18924.6 35127.5 35214.3 35351.3 35431.6 35641.5 10689.8 10911.6 11007.3 11045.7 11199.0 9331.4 9363.7 9379.0 9396.8 9602.4 9233.6 9470.1 9534.2 9615.7 9672.1 2875.3 3263.8 3322.5 3571.2 3651.9 899.5 911.0 941.8 947.3 1001.5 18387.2 19209.3 19370.9 19418.0 19696.7 950.3 959.7 970.4 1012.3 1019.6 9405.9 10895.7 10950.8 10959.8 11012.6 528708.0 542933.0 554390.0 557876.0 565008.0 93926.0 95807.5 96843.0 99079.5 99281.5 1032.3 1050.9 1077.9 1079.4 1088.2 17744.5 17995.3 18096.0 18442.0 18490.6 44133.8 44266.3 44618.0 44725.6 45388.3 61827.4 62110.0 62317.4 62429.0 62455.7 8983.7 9257.7 9268.2 9281.7 9404.7 12218.3 13845.4 13887.3 14242.9 14292.2 11752.8 11965.3 12244.6 12318.6 12456.6 12069.5 12127.5 12243.6 12290.4 12476.2 11931.9 12051.2 12197.6 12227.5 12470.9 8978.3 9075.0 9085.1 9161.6 9405.0 9248.0 11893.3 11913.3 12236.6 12517.9 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#3] mootools.html Cycles:180 Average:6053.23 Median:4839.71 stddev:3489.05 (72.1%) stddev-sans-first:3482.07 21:57:39 INFO - PROCESS | 6506 | Values: 1500.6 1539.7 1690.1 1848.2 1855.7 8931.8 9690.1 9693.8 9705.8 9708.2 8264.0 8472.7 8477.0 8895.1 9490.5 2480.3 2539.9 2547.6 2547.8 2558.2 2449.8 2490.7 2491.6 2491.7 2492.4 2461.4 2480.7 2498.9 2505.9 2509.7 2436.9 2440.2 2457.9 2458.7 2473.5 2423.1 2443.8 2444.9 2445.1 2449.5 9501.6 9553.0 9560.7 9568.8 9574.7 5301.7 5452.3 5471.3 5475.5 5478.9 3636.2 3717.1 3774.5 3776.8 3795.7 1223.8 1263.5 1276.8 1328.0 1339.5 12036.2 12062.7 12443.8 12711.9 12747.4 4835.7 4843.8 4853.4 4946.1 4956.1 10274.0 10281.0 10307.8 10313.3 10315.6 5539.0 5546.8 5549.7 5550.2 5553.5 4649.2 4728.9 4823.4 5223.5 5223.5 3981.3 4032.5 4062.5 4088.1 4122.0 1268.7 1272.5 1281.9 1284.6 1296.8 783.6 895.5 940.0 964.9 977.7 5775.1 5808.6 5843.0 5889.4 6037.6 479.4 482.9 489.8 490.1 490.6 3802.8 4043.4 4096.1 4120.1 4148.3 11518.1 11810.1 11924.8 11947.9 11964.3 11704.5 11836.7 11849.8 11860.8 11863.7 8622.3 8672.0 8788.6 8794.1 8803.1 5919.8 5987.2 6043.3 6047.8 6168.6 10275.8 10780.6 10831.7 10865.7 10932.6 10665.7 10910.5 10930.6 10936.7 11048.4 7033.6 7637.7 8005.9 8154.6 8349.0 9118.1 9290.2 9294.5 9302.0 9317.5 7851.0 7911.5 7919.2 8096.1 8186.0 7639.3 7708.1 7739.3 7766.0 7767.6 7391.2 7407.7 7475.3 7492.0 7495.1 5288.3 5294.9 5358.4 5373.6 5382.4 5015.6 5161.7 5189.1 5207.9 5235.1 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#4] prototype.html Cycles:180 Average:4903.70 Median:5612.38 stddev:1440.91 (25.7%) stddev-sans-first:1403.68 21:57:39 INFO - PROCESS | 6506 | Values: 341.6 347.6 353.8 354.7 359.9 5567.6 5614.6 5646.1 5650.2 5673.3 5287.5 5407.5 5416.6 5416.7 5579.6 4153.9 4280.5 4283.8 4324.5 4345.9 4325.8 4352.3 4353.2 4357.0 4362.7 4096.9 4280.9 4286.9 4301.2 4310.1 4298.4 4299.2 4307.0 4317.1 4325.2 3787.1 3787.4 3804.5 3807.5 3816.5 5206.7 5398.6 5431.8 5438.0 5469.8 4929.4 4953.2 4983.3 4990.9 4997.5 5785.7 5788.2 5808.1 5816.7 5834.4 4092.3 4166.6 4189.9 4201.0 4212.5 6055.7 6059.6 6079.1 6083.7 6087.7 4300.9 4303.4 4304.6 4306.8 4308.7 4234.2 4308.5 4339.5 4339.6 4340.7 4936.6 4950.3 4953.2 4954.3 4958.9 5872.5 5884.9 5898.7 5912.5 5937.2 1419.6 1427.5 1457.1 1484.7 1493.8 1008.8 1013.3 1029.1 1030.3 1032.7 5576.5 5624.7 5635.3 5644.2 5653.6 5941.4 5941.5 5957.4 5976.7 5984.5 5462.6 5594.9 5598.9 5610.2 5637.5 3157.0 3166.8 3167.9 3170.0 3182.3 6002.8 6135.9 6143.0 6165.6 6182.6 6083.1 6119.2 6123.7 6131.4 6145.3 6161.3 6167.7 6168.1 6171.2 6181.7 5702.0 5849.3 5924.4 5933.5 5986.2 5856.6 5870.0 5874.8 5886.6 5887.6 5848.8 6031.2 6107.7 6114.1 6115.4 4250.6 4264.8 4265.6 4269.5 4282.3 5922.5 5926.8 5938.3 5957.8 5962.9 5649.5 5674.4 5704.0 5762.0 5843.9 5818.8 5840.9 5843.8 5869.7 5880.4 5631.0 5778.3 5784.8 5805.4 5812.9 5902.0 5914.8 5922.2 5923.7 5934.6 5650.2 5779.5 5782.8 5786.6 5788.4 21:57:39 INFO - PROCESS | 6506 | 21:57:39 INFO - PROCESS | 6506 | [#5] yui.html Cycles:180 Average:22217.51 Median:4502.36 stddev:32657.03 (725.3%) stddev-sans-first:32708.86 21:57:39 INFO - PROCESS | 6506 | Values: 749.7 781.8 814.5 827.9 882.6 15883.6 16207.4 16210.0 16302.8 16399.3 16157.1 16473.9 16474.3 16489.7 16504.3 707.3 714.8 837.3 857.9 866.7 855.5 858.7 861.9 862.0 863.6 913.1 916.0 917.8 918.3 919.0 743.1 755.8 864.8 871.8 880.8 650.9 654.9 655.0 655.3 655.8 15873.8 15905.3 15950.0 15967.5 15983.5 14720.4 14859.6 15035.0 15166.8 15355.4 13047.5 13103.5 13211.7 13471.1 13586.9 4478.1 4486.0 4554.6 4557.7 4678.9 85804.0 86129.0 86188.6 86471.6 86487.6 10330.0 10756.5 10794.8 10846.7 10904.4 22246.6 22436.2 22504.2 22549.2 22584.0 8658.7 8687.9 8869.2 8938.5 8965.7 4191.1 4332.1 4347.3 4470.6 4518.8 3706.8 3858.0 3860.3 3863.6 3868.9 602.8 608.5 614.3 615.4 617.6 661.6 701.0 740.2 776.3 778.1 9594.2 9681.0 9745.6 9850.4 10261.3 680.0 730.3 737.2 742.7 788.5 4581.7 4877.4 4974.8 5011.2 5020.7 76700.6 102970.0 106009.0 113874.0 131386.0 111534.4 115242.0 115584.0 115807.4 115894.0 95616.5 96733.1 98058.0 99389.5 99442.5 9325.8 9472.4 9824.3 9848.6 9864.1 56544.7 56702.0 58076.7 58454.4 58963.7 80578.0 86428.7 87134.6 88347.0 92283.5 12401.9 12907.4 12958.5 13081.1 13318.1 13844.7 13982.5 14580.3 14821.4 15398.7 12198.8 12287.6 12601.1 12978.5 13013.6 12039.5 12054.8 12412.6 12489.4 12607.7 12658.6 12876.6 12892.3 12929.5 13013.8 10419.3 10465.2 10718.3 10733.9 10765.1 10988.5 11210.7 11269.5 11273.3 11296.0 21:57:39 INFO - PROCESS | 6506 | -------- Summary: end -------- 21:57:39 INFO - PROCESS | 6506 | 21:57:40 INFO - TEST-INFO | 6506: exit 0 21:57:40 INFO - TEST-OK | dromaeo_css | took 1113751ms 21:57:40 INFO - TEST-START | kraken 21:57:40 INFO - operating with platform_type : linux_ 21:57:40 INFO - Initialising browser for kraken test... 21:57:40 INFO - TEST-INFO | started process 6823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwj06H/profile http://localhost:51735/getInfo.html) 21:57:44 INFO - PROCESS | 6823 | __metrics Screen width/height:1600/1200 21:57:44 INFO - PROCESS | 6823 | colorDepth:24 21:57:44 INFO - PROCESS | 6823 | Browser inner width/height: 1024/697 21:57:44 INFO - PROCESS | 6823 | __metrics 21:57:44 INFO - PROCESS | 6823 | 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" 21:57:44 INFO - PROCESS | 6823 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:57:45 INFO - PROCESS | 6823 | console.error: PushService: 21:57:45 INFO - PROCESS | 6823 | stateChangeProcessEnqueue: Error transitioning state 21:57:45 INFO - PROCESS | 6823 | UnknownError 21:57:45 INFO - TEST-INFO | 6823: exit 0 21:57:45 INFO - Browser initialized. 21:57:45 INFO - Running cycle 1/1 for kraken test... 21:57:45 INFO - TEST-INFO | started process 6914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXwj06H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:57 INFO - PROCESS | 6914 | RSS: Main: 144842752 21:57:57 INFO - PROCESS | 6914 | 21:58:00 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:00 INFO - PROCESS | 6914 | RSS: Main: 186408960 21:58:00 INFO - PROCESS | 6914 | 21:58:03 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-dft) 21:58:04 INFO - PROCESS | 6914 | RSS: Main: 175177728 21:58:04 INFO - PROCESS | 6914 | 21:58:06 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-fft) 21:58:07 INFO - PROCESS | 6914 | RSS: Main: 267792384 21:58:07 INFO - PROCESS | 6914 | 21:58:09 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator) 21:58:10 INFO - PROCESS | 6914 | RSS: Main: 173985792 21:58:10 INFO - PROCESS | 6914 | 21:58:12 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:12 INFO - PROCESS | 6914 | RSS: Main: 175742976 21:58:12 INFO - PROCESS | 6914 | 21:58:15 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:16 INFO - PROCESS | 6914 | RSS: Main: 210755584 21:58:16 INFO - PROCESS | 6914 | 21:58:19 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:20 INFO - PROCESS | 6914 | RSS: Main: 210247680 21:58:20 INFO - PROCESS | 6914 | 21:58:23 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial) 21:58:23 INFO - PROCESS | 6914 | RSS: Main: 209903616 21:58:23 INFO - PROCESS | 6914 | 21:58:25 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:25 INFO - PROCESS | 6914 | RSS: Main: 172212224 21:58:25 INFO - PROCESS | 6914 | 21:58:27 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:28 INFO - PROCESS | 6914 | RSS: Main: 179331072 21:58:28 INFO - PROCESS | 6914 | 21:58:30 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:30 INFO - PROCESS | 6914 | RSS: Main: 188903424 21:58:30 INFO - PROCESS | 6914 | 21:58:33 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:33 INFO - PROCESS | 6914 | RSS: Main: 197009408 21:58:33 INFO - PROCESS | 6914 | 21:58:36 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:37 INFO - PROCESS | 6914 | RSS: Main: 193380352 21:58:37 INFO - PROCESS | 6914 | 21:58:38 INFO - PROCESS | 6914 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51735/tests/kraken/driver.html?testName=ai-astar) 21:58:39 INFO - PROCESS | 6914 | RSS: Main: 244277248 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | __start_tp_report 21:58:39 INFO - PROCESS | 6914 | _x_x_mozilla_page_load 21:58:39 INFO - PROCESS | 6914 | _x_x_mozilla_page_load_details 21:58:39 INFO - PROCESS | 6914 | |i|pagename|runs| 21:58:39 INFO - PROCESS | 6914 | |0;ai-astar;109;110;111;110;112;110;110;113;112;111 21:58:39 INFO - PROCESS | 6914 | |1;audio-beat-detection;150;122;120;163;120;121;117;117;147;117 21:58:39 INFO - PROCESS | 6914 | |2;audio-dft;162;169;160;162;161;160;161;160;159;160 21:58:39 INFO - PROCESS | 6914 | |3;audio-fft;84;75;75;105;76;76;76;75;111;74 21:58:39 INFO - PROCESS | 6914 | |4;audio-oscillator;81;81;108;82;81;81;100;82;82;111 21:58:39 INFO - PROCESS | 6914 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;118 21:58:39 INFO - PROCESS | 6914 | |6;imaging-darkroom;146;145;146;147;147;146;146;148;146;146 21:58:39 INFO - PROCESS | 6914 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;94 21:58:39 INFO - PROCESS | 6914 | |8;json-parse-financial;49;50;49;49;50;50;49;50;49;48 21:58:39 INFO - PROCESS | 6914 | |9;json-stringify-tinderbox;59;59;59;59;59;59;59;59;59;59 21:58:39 INFO - PROCESS | 6914 | |10;stanford-crypto-aes;82;83;77;80;73;73;78;72;74;73 21:58:39 INFO - PROCESS | 6914 | |11;stanford-crypto-ccm;122;122;120;123;118;118;128;122;154;119 21:58:39 INFO - PROCESS | 6914 | |12;stanford-crypto-pbkdf2;154;156;157;157;154;157;153;159;154;156 21:58:39 INFO - PROCESS | 6914 | |13;stanford-crypto-sha256-iterative;64;63;63;62;62;62;63;61;60;61 21:58:39 INFO - PROCESS | 6914 | __end_tp_report 21:58:39 INFO - PROCESS | 6914 | __start_cc_report 21:58:39 INFO - PROCESS | 6914 | _x_x_mozilla_cycle_collect,1581 21:58:39 INFO - PROCESS | 6914 | __end_cc_report 21:58:39 INFO - PROCESS | 6914 | __startTimestamp1479103119060__endTimestamp 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | ------- Summary: start ------- 21:58:39 INFO - PROCESS | 6914 | Number of tests: 14 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 21:58:39 INFO - PROCESS | 6914 | Values: 109.0 110.0 111.0 110.0 112.0 110.0 110.0 113.0 112.0 111.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:121.50 stddev:17.08 (14.1%) stddev-sans-first:16.41 21:58:39 INFO - PROCESS | 6914 | Values: 150.0 122.0 120.0 163.0 120.0 121.0 117.0 117.0 147.0 117.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:2.84 (1.8%) stddev-sans-first:3.00 21:58:39 INFO - PROCESS | 6914 | Values: 162.0 169.0 160.0 162.0 161.0 160.0 161.0 160.0 159.0 160.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:13.70 (18.1%) stddev-sans-first:14.52 21:58:39 INFO - PROCESS | 6914 | Values: 84.0 75.0 75.0 105.0 76.0 76.0 76.0 75.0 111.0 74.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.00 stddev:12.33 (15.2%) stddev-sans-first:12.75 21:58:39 INFO - PROCESS | 6914 | Values: 81.0 81.0 108.0 82.0 81.0 81.0 100.0 82.0 82.0 111.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:58:39 INFO - PROCESS | 6914 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 21:58:39 INFO - PROCESS | 6914 | Values: 146.0 145.0 146.0 147.0 147.0 146.0 146.0 148.0 146.0 146.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:58:39 INFO - PROCESS | 6914 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.50 stddev:0.67 (1.4%) stddev-sans-first:0.71 21:58:39 INFO - PROCESS | 6914 | Values: 49.0 50.0 49.0 49.0 50.0 50.0 49.0 50.0 49.0 48.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 21:58:39 INFO - PROCESS | 6914 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.50 stddev:4.09 (5.3%) stddev-sans-first:3.82 21:58:39 INFO - PROCESS | 6914 | Values: 82.0 83.0 77.0 80.0 73.0 73.0 78.0 72.0 74.0 73.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.00 stddev:10.74 (8.8%) stddev-sans-first:11.35 21:58:39 INFO - PROCESS | 6914 | Values: 122.0 122.0 120.0 123.0 118.0 118.0 128.0 122.0 154.0 119.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.50 stddev:1.89 (1.2%) stddev-sans-first:1.90 21:58:39 INFO - PROCESS | 6914 | Values: 154.0 156.0 157.0 157.0 154.0 157.0 153.0 159.0 154.0 156.0 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - PROCESS | 6914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.20 (1.9%) stddev-sans-first:1.05 21:58:39 INFO - PROCESS | 6914 | Values: 64.0 63.0 63.0 62.0 62.0 62.0 63.0 61.0 60.0 61.0 21:58:39 INFO - PROCESS | 6914 | -------- Summary: end -------- 21:58:39 INFO - PROCESS | 6914 | 21:58:39 INFO - TEST-INFO | 6914: exit 0 21:58:39 INFO - TEST-OK | kraken | took 59888ms 21:58:39 INFO - SUITE-END | took 1173s 21:58:40 INFO - Completed test suite (00:19:33) 21:58:40 INFO - javascript benchmark 21:58:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.263917979275, 3172.825494597797, 3180.9045728628134, 3192.297694507208, 3224.4518431866595, 5491.588130890184, 5553.194786755918, 5568.248286481324, 5569.860753481165, 5588.832335029951, 5467.942153508009, 5521.061419558675, 5524.33707955046, 5535.169724541321, 5549.667019978804, 4968.453470118275, 4987.177115775893, 5004.649674522785, 5035.446100928895, 5073.644844860843, 4886.462489126193, 5017.824376146836, 5068.493150684921, 5069.062223488666, 5074.137396642561, 4858.757062146896, 4926.11329960607, 4960.801567937297, 4962.727050012248, 4991.126552853254, 5013.172826483626, 5044.848654540369, 5046.6719663221775, 5119.129747942859, 5141.254518094893, 4922.926156107661, 4993.500649935014, 5021.698698078127, 5050.242463630448, 5054.1407960646775, 5249.606279529051, 5285.524302812727, 5312.335958005249, 5362.570994320445, 5415.1335786274, 5862.20860183874, 5873.823785286406, 5906.5570082244, 5918.0, 5938.792142275, 5961.5230781537375, 5965.433283838029, 5970.13433052205, 5975.521958243374, 5976.611520251213, 5405.0, 5447.12845944647, 5527.972360138174, 5561.332640083216, 5577.888442231214, 6073.939260607337, 6113.755449782047, 6114.480269177081, 6120.479759220516, 6125.571210015256, 5860.179574859523, 5875.706214689249, 5881.323647780475, 5881.411858814085, 5886.440788125121, 5624.831255062355, 5690.743916523684, 5778.855528611818, 5825.417458254141, 5838.5329173666005, 5858.033424484912, 5858.414158584107, 5863.5309175265875, 5864.32560255576, 5894.115882617556, 5812.564057695689, 5874.853128671732, 5879.029960056543, 5880.911786323209, 5898.321693005273, 4464.709793863389, 4510.75190864499, 4512.323151527297, 4537.319402089647, 4555.2256116460285, 4082.755034697928, 4083.1629515949753, 4090.4682391288943, 4111.958880411217, 4129.112240868228, 5608.495235428831, 5613.129964855372, 5621.690807005654, 5632.97183514088, 5634.661920284796, 5782.797602083907, 5836.445537673914, 5870.765169393177, 5960.642361458326, 5969.701514924236, 5576.776928922879, 5619.831405057855, 5626.85932851682, 5645.717714114277, 5651.745671444794, 5161.819336323286, 5168.431472538018, 5170.741462926914, 5172.353455818023, 5200.115980283361, 5743.74153163117, 5899.528037756883, 6114.174586430864, 6120.234970628671, 6131.938680613137, 5767.452092051249, 5769.68266745333, 5829.271341082364, 5845.1232315153065, 5881.206037184926, 6002.489788368038, 6017.879642407215, 6022.217111775616, 6024.578279520391, 6028.0355143176885, 5730.1977723119635, 5839.562032847469, 5843.29880414353, 5845.473907348359, 5847.970760146172, 5747.166660834239, 5800.535957123336, 5823.854403639943, 5892.292924849045, 5909.054551271776, 5721.713914304185, 5724.055530837365, 5727.656340619576, 5729.770809167753, 5729.799457018984, 5612.466815652507, 5730.169125476699, 5730.799422020376, 5736.0, 5743.741531631003, 5574.526165275997, 5617.4101719320515, 5671.858203544944, 5699.886002279848, 5715.485606295453, 5826.155207494805, 5838.795642152504, 5840.94159058404, 5842.766289348378, 5869.589128760946, 5587.217789509391, 5699.886002279848, 5715.628484148517, 5719.542436605145, 5720.427957204246], "value": 5429.912186553803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.967661778602, 635.9395857393547, 636.0649844728251, 640.5164101103666, 644.7775517446479, 36098.819505902466, 39487.210255794904, 39582.0, 39658.60341396589, 39711.80144099276, 39693.20613587726, 40427.0, 47822.76088619552, 48865.0, 49096.26355604669, 9195.862062069074, 9327.16055555, 9336.159745622892, 9341.626334946593, 9344.299177561676, 9368.90631093687, 9443.05569443057, 9460.053994600554, 9464.858027129598, 9465.62137514502, 8633.438826476291, 8837.646494140226, 8839.46963182208, 9030.593623286968, 11175.66473005807, 10975.725606859813, 11371.829422558669, 11396.943015284953, 11411.657650270423, 11414.54341826326, 11122.110231181567, 11130.05394541465, 11197.44012799365, 11212.542369491995, 11216.383098929555, 35887.4616880747, 36245.0, 44427.0, 46185.07629847418, 46647.76676116631, 3639.526861507987, 3716.3310604091253, 3773.52830896138, 3784.5458544974504, 3907.1404291055924, 35040.54716169869, 35366.82316588401, 35441.261372459405, 36078.0, 37046.44430333547, 4668.43978722552, 4669.579737823612, 4692.319613656035, 4704.670673052888, 4796.208625576775, 379822.0, 382622.0, 383602.0, 383705.9999999972, 385487.0, 65857.0, 66191.66904165449, 66204.00693989595, 66378.0, 66380.0, 62729.0, 64129.0, 69096.0, 70079.0, 70454.64772676103, 19729.309474168334, 19871.205151794056, 19890.104945277497, 19891.0, 19931.10310036052, 15345.0, 15441.613959651098, 15470.071795692294, 15471.14908680011, 15476.535703928901, 21140.577188456453, 21165.25921592737, 21372.35882923515, 21452.78547214539, 21492.0, 6121.877562448815, 7153.4992550520965, 7336.266373362621, 7434.3309102181065, 7649.57927313992, 808.9110197878229, 903.5578207729255, 958.3866325551653, 986.6201512417771, 1033.4729288063143, 31720.524192137138, 33246.335073298396, 33260.1684957878, 33443.50094073849, 33499.66500335014, 1082.5832054659013, 1090.3239991205503, 1094.8686157660973, 1102.211918478276, 1182.5624518928053, 17081.48755537336, 17526.0, 17568.56078598045, 17729.29082836698, 17730.73403898917, 616422.0, 621582.0, 623528.0, 623907.0, 624234.0, 64236.0, 64748.0, 64875.351246486935, 64958.0, 65081.67459162674, 1266.5250531050856, 1271.3833790611545, 1272.866349033338, 1413.250976982201, 1444.0830072903782, 28416.57375139333, 33284.500732488545, 35617.64382356143, 35650.8217458911, 36276.27447450983, 61552.69223653853, 61968.0, 62056.689716551125, 62150.06774898471, 62201.68899155475, 517900.0, 520124.0, 523388.0, 523820.0, 524290.0, 30576.929807456632, 30870.0, 49084.509154907995, 50058.249126263865, 50237.49762502328, 46581.53418465772, 46766.0, 48361.75819120882, 53080.73459632677, 55322.72338638281, 44724.55275447334, 44829.55170448254, 46613.0, 47002.29496557623, 48138.0, 44209.778951105036, 45837.541624583326, 46461.535384647075, 47005.05989880115, 47193.292100619205, 41709.79145104255, 41729.1654166921, 42154.0, 42216.155676886905, 42546.57453425426, 38177.42733858939, 40552.59447405488, 40576.1884762309, 40898.79550602228, 41194.794026029675, 28610.14169574916, 28880.0, 28911.566326504697, 28934.565981510714, 29238.853805730836], "value": 21932.67883488975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.55444120350046, 418.82618713234, 427.19260597470804, 428.8713385984204, 442.8095918754936, 18961.14674839632, 20225.595488090246, 20824.167033318667, 21353.679694804552, 21613.243536476228, 16265.918670406661, 19113.23547058116, 19636.803631963678, 19736.111874965623, 20419.0, 5237.607179461536, 5476.288082549263, 5478.01395748765, 5480.095784195603, 5487.2317875497465, 5405.081136206834, 5466.617336786407, 5482.725863706799, 5812.186293918855, 6065.0, 6073.149759033717, 6074.696265186745, 6087.360827113133, 6089.391060893898, 6096.664683442409, 5869.266341707286, 6007.7596896124105, 6022.0, 6051.152838602599, 6088.056351265561, 5861.413858614147, 5870.735816888207, 5876.706164691748, 5885.470307672287, 5895.882082358372, 14547.927260363631, 14664.266786660624, 23816.166434174895, 24044.639330409882, 25010.749892501022, 2305.319930620471, 2406.4585468269497, 2436.439618887666, 2528.696556413242, 2800.915972520828, 10553.78892422155, 10570.312929659625, 10770.676879693621, 11351.20541562091, 12160.08799340053, 1808.3128411203659, 1947.0070264165236, 2028.2698228637678, 2174.3150907464096, 2183.5742030304095, 89113.0, 98015.50992244993, 100695.0, 111019.0, 112267.43866280698, 16666.833331666527, 18417.723734143998, 18538.351157709414, 18696.719549206773, 18924.621507570046, 35127.4730879037, 35214.29571408557, 35351.29297414089, 35431.64568354283, 35641.46537801935, 10689.83965240522, 10911.563537458413, 11007.284526505751, 11045.668629941114, 11199.0, 9331.393459425115, 9363.672271470467, 9378.95310523443, 9396.812063758824, 9602.375845570015, 9233.630654773868, 9470.14768670823, 9534.237261019101, 9615.711528654152, 9672.129508344282, 2875.25243436708, 3263.8041717497026, 3322.487580533463, 3571.178628915312, 3651.908702282411, 899.4783025844994, 910.977225569366, 941.8304705153138, 947.303731757158, 1001.519270750044, 18387.172577234058, 19209.32767353136, 19370.903145484463, 19418.0, 19696.70454943177, 950.3062764182185, 959.69289827256, 970.403202030746, 1012.3318609717699, 1019.556492925565, 9405.858912116324, 10895.673129806119, 10950.835737463944, 10959.83560246597, 11012.614558490575, 528708.0, 542933.0, 554390.0, 557876.0, 565008.0, 93926.0, 95807.52096239474, 96843.0, 99079.50460247653, 99281.50359248157, 1032.2670903658336, 1050.8844027157006, 1077.9137668986461, 1079.4009324824797, 1088.2056099047738, 17744.46766597004, 17995.2801887923, 18096.0, 18442.0, 18490.630187396448, 44133.77933110314, 44266.33600495931, 44618.0, 44725.55274447344, 45388.319175211735, 61827.381726183965, 62110.0, 62317.37682623116, 62429.0, 62455.6877215611, 8983.730488085368, 9257.67598134062, 9268.212201962908, 9281.67514137002, 9404.670836520689, 12218.327991960528, 13845.376958036712, 13887.305634718427, 14242.928785356422, 14292.213928234047, 11752.76494470123, 11965.282083075042, 12244.571439999558, 12318.58336291338, 12456.564020259248, 12069.456874440846, 12127.514899403925, 12243.632691019284, 12290.385480726107, 12476.18904771187, 11931.940340298243, 12051.216670916363, 12197.573084941985, 12227.510899563918, 12470.875291246972, 8978.326625502983, 9074.954625226832, 9085.13691199335, 9161.587728552364, 9404.95297523508, 9248.0, 11893.345865977455, 11913.285202887855, 12236.632901012983, 12517.93741031289], "value": 10361.350019463998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.5723368839879, 1539.7459419195834, 1690.1464760296055, 1848.2237460266688, 1855.6845336292838, 8931.821363572724, 9690.079442452956, 9693.757656058593, 9705.757356066102, 9708.223342132631, 8263.958680206606, 8472.745817625466, 8476.957615211932, 8895.110488951117, 9490.525473726304, 2480.3179125740385, 2539.9111031113916, 2547.6051212062066, 2547.8089143314232, 2558.2325302409295, 2449.8040156787415, 2490.663760392342, 2491.6262560615874, 2491.6636254105647, 2492.4142826435773, 2461.396957745355, 2480.6775119234476, 2498.8750562471896, 2505.9373515662073, 2509.6737424134835, 2436.890339934698, 2440.1947357372023, 2457.901683932658, 2458.7418321076207, 2473.5300292944285, 2423.09134074722, 2443.780059794627, 2444.877756112205, 2445.1075357494387, 2449.5223431430877, 9501.572429240701, 9553.044695530461, 9560.665376711782, 9568.760780980461, 9574.664886729, 5301.6818990860675, 5452.345718513764, 5471.343438787331, 5475.534579560742, 5478.863028424282, 3636.2000359920776, 3717.107894105395, 3774.5281839770028, 3776.7922764247955, 3795.6773674237725, 1223.8347823043864, 1263.5072321794507, 1276.8340115784981, 1328.0477697784243, 1339.5043833781563, 12036.217645852992, 12062.69843253917, 12443.751124977449, 12711.872881271162, 12747.42636581356, 4835.661503694708, 4843.75781210938, 4853.39332583427, 4946.1344264753525, 4956.083124621957, 10274.0, 10281.0, 10307.793844123076, 10313.27807053499, 10315.587376505006, 5538.972305138448, 5546.77812887488, 5549.694766787785, 5550.195221692913, 5553.527950124204, 4649.209634362167, 4728.881777955578, 4823.3729615149805, 5223.4515375884985, 5223.52988231061, 3981.2833689936087, 4032.495938007749, 4062.471878655815, 4088.059746258318, 4122.0, 1268.7081971146688, 1272.465564462928, 1281.9423125959167, 1284.5504073574175, 1296.7795474769123, 783.6473586885924, 895.4716717136921, 939.957701903416, 964.8890377606665, 977.7066879935991, 5775.075987841925, 5808.6224395414165, 5843.0, 5889.38161493037, 6037.607555508966, 479.38638542665444, 482.93480380148935, 489.84080173942897, 490.14959046055066, 490.6001608688907, 3802.8098595070137, 4043.393490976377, 4096.078382363944, 4120.134771697917, 4148.315527937917, 11518.078553715683, 11810.055195584333, 11924.761504769856, 11947.880521194851, 11964.282143071443, 11704.473298701409, 11836.70408239801, 11849.822252666218, 11860.762784744256, 11863.703407414883, 8622.31021518277, 8672.0, 8788.648454061893, 8794.076621954731, 8803.075677053945, 5919.763209471573, 5987.191729116514, 6043.3352331244405, 6047.818565443044, 6168.599041062316, 10275.84586231222, 10780.568777249136, 10831.67504974852, 10865.728356790827, 10932.617358392736, 10665.680029599125, 10910.509027093958, 10930.617428389969, 10936.726581835517, 11048.392338421463, 7033.648317583998, 7637.656305466378, 8005.919940800517, 8154.551499667576, 8349.0, 9118.088191180828, 9290.210332121846, 9294.488803115622, 9301.953490232505, 9317.534123293945, 7850.960745196237, 7911.485753426009, 7919.208079192034, 8096.109427963037, 8186.0, 7639.274268944441, 7708.075030996316, 7739.3421559165845, 7766.029246344207, 7767.572783496962, 7391.2239214881665, 7407.740729074457, 7475.289847464483, 7491.9625401872645, 7495.1005879294835, 5288.312519372457, 5294.8941021180135, 5358.437364076872, 5373.623846330719, 5382.381026181883, 5015.623828212826, 5161.716105614077, 5189.065968125623, 5207.947920520898, 5235.0576896159055], "value": 4758.8013272969265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.55427167546355, 347.60373174580974, 353.8230884557722, 354.7179991906434, 359.9370110230709, 5567.638103523268, 5614.578906582003, 5646.096624540074, 5650.237217975582, 5673.319201695797, 5287.47125287471, 5407.540359069474, 5416.593755468346, 5416.674999500033, 5579.553635709143, 4153.937690934638, 4280.529141794408, 4283.807228674717, 4324.54592267812, 4345.891352716176, 4325.762083085429, 4352.281873490871, 4353.151135528573, 4356.956430435703, 4362.650987920974, 4096.897577560555, 4280.850170244042, 4286.892827679302, 4301.204277208726, 4310.07333423314, 4298.376735373385, 4299.226139294926, 4306.966328081254, 4317.114991426765, 4325.221460137174, 3787.1100291431767, 3787.3750831112834, 3804.4863943367845, 3807.5240594925635, 3816.5229346331707, 5206.661566998171, 5398.595105367113, 5431.782728690848, 5437.972810135963, 5469.808556700496, 4929.408470983469, 4953.23224900141, 4983.277424773388, 4990.90018199634, 4997.525235102659, 5785.739641716133, 5788.18965344852, 5808.099744539603, 5816.738246778863, 5834.353529044347, 4092.3043082676018, 4166.58334166584, 4189.937150942738, 4200.957990420118, 4212.473440819897, 6055.7274922628585, 6059.575829691923, 6079.088136779475, 6083.665398403086, 6087.726052327655, 4300.8709738707885, 4303.397524346594, 4304.634106100953, 4306.827726890952, 4308.719933204332, 4234.216669916013, 4308.526062133163, 4339.522652508222, 4339.633015600076, 4340.65274778017, 4936.555709986047, 4950.3069570260195, 4953.18272485036, 4954.256861470736, 4958.8760280993265, 5872.530197584183, 5884.911726324109, 5898.726206955181, 5912.526997840162, 5937.228160339128, 1419.6450887278181, 1427.4789701758991, 1457.1330058615108, 1484.7401704701633, 1493.7684658877674, 1008.8184126857236, 1013.2906965124295, 1029.1149611334247, 1030.258214085857, 1032.7056788815153, 5576.470235327637, 5624.662520248717, 5635.323761148688, 5644.153376993484, 5653.575981801381, 5941.435563621449, 5941.494972927263, 5957.374475680078, 5976.6989708962365, 5984.491318237911, 5462.552423607747, 5594.901911783081, 5598.944010559842, 5610.18652295423, 5637.46444087811, 3156.9684303157132, 3166.794158379698, 3167.920801979923, 3169.952450713241, 3182.3158021025592, 6002.849928751816, 6135.9079613805825, 6142.969285153546, 6165.599236049642, 6182.629042257479, 6083.11794789753, 6119.204503414528, 6123.693815309217, 6131.448169664752, 6145.293291271471, 6161.291451483136, 6167.691615419211, 6168.136460895388, 6171.228596425447, 6181.721822517998, 5701.971490142523, 5849.327327357239, 5924.407559244041, 5933.525317974465, 5986.161937328865, 5856.619319744203, 5870.0, 5874.823755287348, 5886.6173698709445, 5887.646741195542, 5848.766049357978, 6031.185789918305, 6107.725152368243, 6114.144019837137, 6115.357887421935, 4250.638695710775, 4264.8294068238165, 4265.594768496988, 4269.530351661253, 4282.336237883133, 5922.5261979040715, 5926.7925622603, 5938.346781853907, 5957.791477298274, 5962.940370596412, 5649.4633009864, 5674.375818659862, 5703.971480142739, 5761.971190144022, 5843.853903652443, 5818.799660186795, 5840.94159058404, 5843.772807710428, 5869.735861886311, 5880.411958804086, 5630.971845140748, 5778.306603207642, 5784.82645520635, 5805.448482394166, 5812.854678633068, 5901.970490147522, 5914.763409463573, 5922.200502932222, 5923.674197919156, 5934.554908381802, 5650.23721797552, 5779.537636988946, 5782.826515204551, 5786.594938354275, 5788.363280039276], "value": 4446.051166289525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.7113611259664, 781.7537475695156, 814.4787336104893, 827.8592639251327, 882.554310073413, 15883.602909927258, 16207.432739854108, 16210.0, 16302.7554586681, 16399.262033208506, 16157.111358875258, 16473.917630411863, 16474.258658360373, 16489.67020659586, 16504.33982640696, 707.3421717802441, 714.7855643307013, 837.3175861672718, 857.918497742715, 866.6706651472432, 855.5422848775906, 858.6865793985213, 861.9138086191393, 861.9569021548929, 863.6027427383411, 913.137085454246, 916.0152835701614, 917.8302014127374, 918.2699753695795, 918.9586468608895, 743.0971369785709, 755.8034910923144, 864.8313578852126, 871.7820544863785, 880.828238493494, 650.9121268628722, 654.9246836613803, 654.9607023578601, 655.2562841175253, 655.7639249870043, 15873.841261587468, 15905.284262208228, 15950.0, 15967.520974370787, 15983.520494385188, 14720.411183552646, 14859.554213373616, 15035.0, 15166.772498412422, 15355.385784568603, 13047.478100875953, 13103.541376051888, 13211.735765284737, 13471.12437691547, 13586.932065339708, 4478.126765280772, 4485.955140448619, 4554.612857907082, 4557.703749256288, 4678.8596342109795, 85804.0, 86129.0, 86188.56905715493, 86471.56764216202, 86487.56756216178, 10330.0, 10756.462176891124, 10794.784104318027, 10846.67459976202, 10904.400257985886, 22246.55506889853, 22436.214732484284, 22504.21235256758, 22549.210777622706, 22584.0, 8658.653653853902, 8687.870576824973, 8869.201771840566, 8938.46369217836, 8965.686200982935, 4191.077962848169, 4332.090261045216, 4347.347897815353, 4470.552944705503, 4518.774061296922, 3706.79612621303, 3858.0, 3860.3244432224246, 3863.632954869283, 3868.883933482, 602.764921680545, 608.5435923057706, 614.3089024847047, 615.350804900834, 617.5831313863124, 661.6228749612675, 701.0, 740.2486476226634, 776.2935728487049, 778.093521047984, 9594.232461403071, 9680.951595241979, 9745.561449734638, 9850.408975461496, 10261.333013354108, 679.9524033317621, 730.3463400256741, 737.1927739125649, 742.6509540515949, 788.4559653838833, 4581.725096494154, 4877.3903262092235, 4974.825881094144, 5011.198208286657, 5020.698758074527, 76700.61649691715, 102970.0, 106009.0, 113874.0, 131386.0, 111534.44232778784, 115242.0, 115584.0, 115807.42096289633, 115894.0, 95616.52191739136, 96733.09800705849, 98058.0, 99389.5091573627, 99442.5027874856, 9325.813483730422, 9472.431654100776, 9824.312298139348, 9848.556814943202, 9864.062914023156, 56544.71727641336, 56702.0, 58076.70961645165, 58454.41545584489, 58963.705181473815, 80578.0, 86428.6785660727, 87134.56432717796, 88347.0, 92283.53858230666, 12401.93799030999, 12907.419166137359, 12958.481660733465, 13081.149725267827, 13318.134321269086, 13844.653883652587, 13982.510612128526, 14580.34388452501, 14821.407143714561, 15398.692026159639, 12198.756024879276, 12287.631371058882, 12601.085576625306, 12978.480860765463, 13013.609591712264, 12039.4582243801, 12054.77812465718, 12412.56556020535, 12489.437975291316, 12607.684807879876, 12658.620241392404, 12876.613701588967, 12892.290923998895, 12929.482820687068, 13013.804792928304, 10419.270651054354, 10465.215108866712, 10718.303310285119, 10733.892661073289, 10765.078842479634, 10988.505517251582, 11210.66368008961, 11269.492872820907, 11273.300234860253, 11296.0], "value": 7806.684558751619, "unit": "score"}], "name": "dromaeo_css", "value": 7671.512799010256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 110.0, 112.0, 110.0, 110.0, 113.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 120.0, 163.0, 120.0, 121.0, 117.0, 117.0, 147.0, 117.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 75.0, 105.0, 76.0, 76.0, 76.0, 75.0, 111.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 108.0, 82.0, 81.0, 81.0, 100.0, 82.0, 82.0, 111.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 49.0, 50.0, 50.0, 49.0, 50.0, 49.0, 48.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 77.0, 80.0, 73.0, 73.0, 78.0, 72.0, 74.0, 73.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 120.0, 123.0, 118.0, 118.0, 128.0, 122.0, 154.0, 119.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 157.0, 157.0, 154.0, 157.0, 153.0, 159.0, 154.0, 156.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0, 61.0, 60.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1459.1999999999998, "alertThreshold": 2.0}]} 21:58:40 INFO - Return code: 0 21:58:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:40 INFO - # TBPL SUCCESS # 21:58:40 INFO - Running post-action listener: _resource_record_post_action 21:58:40 INFO - [mozharness: 2016-11-14 05:58:40.367693Z] Finished run-tests step (success) 21:58:40 INFO - Running post-run listener: _resource_record_post_run 21:58:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2195456; Write bytes: 368058368; Read time: 380; Write time: 287136 21:58:40 INFO - TinderboxPrint: CPU usage
12.9% 21:58:40 INFO - TinderboxPrint: I/O read bytes / time
2,195,456 / 380 21:58:40 INFO - TinderboxPrint: I/O write bytes / time
368,058,368 / 287,136 21:58:40 INFO - TinderboxPrint: CPU idle
8,268.2 (87.1%) 21:58:40 INFO - TinderboxPrint: CPU user
1,183.3 (12.5%) 21:58:40 INFO - TinderboxPrint: Swap in / out
0 / 0 21:58:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118861824; Read time: 0; Write time: 85432 21:58:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 458752; Write bytes: 249196544; Read time: 312; Write time: 201704 21:58:41 INFO - Running post-run listener: _upload_blobber_files 21:58:41 INFO - Blob upload gear active. 21:58:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:41 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 21:58:41 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'] 21:58:41 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 21:58:41 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:42 INFO - (blobuploader) - INFO - Done attempting. 21:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:46 INFO - (blobuploader) - INFO - Done attempting. 21:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:47 INFO - (blobuploader) - INFO - Done attempting. 21:58:47 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:47 INFO - Return code: 0 21:58:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0074b1ea759879655b563b735ed6d20381d5481cbebef13c31ad3706f741be8518a2b0043f98393ffdcf45ecb78db2af4ea656b3e06e58d0d018988eb154d77a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d6a3ed52cde0e4c2d07340f7a96d4487165f2793f274882e09d6c205b19425eb7de3d01026e7d0f4e696b2890f51956685b857203c3ffef8519fb84635e553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f5c3bc13f07807958c43e6580460293752959463abdb5b882bb018f7045848c6a51ec69135ad0e931449d8764eacaa2d317cd202e1b8c0b4955c0a51a2804f"} 21:58:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:47 INFO - Contents: 21:58:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0074b1ea759879655b563b735ed6d20381d5481cbebef13c31ad3706f741be8518a2b0043f98393ffdcf45ecb78db2af4ea656b3e06e58d0d018988eb154d77a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d6a3ed52cde0e4c2d07340f7a96d4487165f2793f274882e09d6c205b19425eb7de3d01026e7d0f4e696b2890f51956685b857203c3ffef8519fb84635e553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f5c3bc13f07807958c43e6580460293752959463abdb5b882bb018f7045848c6a51ec69135ad0e931449d8764eacaa2d317cd202e1b8c0b4955c0a51a2804f"} 21:58:47 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:47 INFO - Copying logs to upload dir... 21:58:47 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.175893 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-13 21:58:47.410240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 21:58:47.414109) ========= 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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 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/0074b1ea759879655b563b735ed6d20381d5481cbebef13c31ad3706f741be8518a2b0043f98393ffdcf45ecb78db2af4ea656b3e06e58d0d018988eb154d77a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d6a3ed52cde0e4c2d07340f7a96d4487165f2793f274882e09d6c205b19425eb7de3d01026e7d0f4e696b2890f51956685b857203c3ffef8519fb84635e553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f5c3bc13f07807958c43e6580460293752959463abdb5b882bb018f7045848c6a51ec69135ad0e931449d8764eacaa2d317cd202e1b8c0b4955c0a51a2804f"} build_url:https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/exBPSDqETN67Y_0QfRLo1w/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/0074b1ea759879655b563b735ed6d20381d5481cbebef13c31ad3706f741be8518a2b0043f98393ffdcf45ecb78db2af4ea656b3e06e58d0d018988eb154d77a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69d6a3ed52cde0e4c2d07340f7a96d4487165f2793f274882e09d6c205b19425eb7de3d01026e7d0f4e696b2890f51956685b857203c3ffef8519fb84635e553", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f5c3bc13f07807958c43e6580460293752959463abdb5b882bb018f7045848c6a51ec69135ad0e931449d8764eacaa2d317cd202e1b8c0b4955c0a51a2804f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 21:58:47.443963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:58:47.444725) ========= 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=232498196343f89f466a4a9a000001c8-1479101642.584761-257128037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:58:47.528176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 21:58:47.528894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 21:58:47.529613) ========= ========= Total master_lag: 0.17 =========