builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1479750388.43 results: success (0) buildid: 20161121065208 builduid: 19da6d4dc396488c895f46babe4621ac revision: 83e1d3c7f75096287834ddea0f4d478ab3032604 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.433186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.433637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.433914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.448255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.448577) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 09:46:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-11-21 09:46:28 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.553044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.553381) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:28.602950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 09:46:28.603317) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 83e1d3c7f75096287834ddea0f4d478ab3032604 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 83e1d3c7f75096287834ddea0f4d478ab3032604 --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=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 09:46:28,735 truncating revision to first 12 chars 2016-11-21 09:46:28,735 Setting DEBUG logging. 2016-11-21 09:46:28,735 attempt 1/10 2016-11-21 09:46:28,735 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/83e1d3c7f750?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 09:46:29,725 unpacking tar archive at: mozilla-beta-83e1d3c7f750/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327176 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 09:46:29.947533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:29.948302) ========= script_repo_revision: 83e1d3c7f75096287834ddea0f4d478ab3032604 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:29.949175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:29.949794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:46:29.960247) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-21 09:46:29.960563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:46:30 INFO - MultiFileLogger online at 20161121 09:46:30 in /builds/slave/test 09:46:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:46:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:30 INFO - {'append_to_log': False, 09:46:30 INFO - 'base_work_dir': '/builds/slave/test', 09:46:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:46:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:30 INFO - 'branch': 'Mozilla-Beta', 09:46:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:30 INFO - 'config_files': ('talos/linux_config.py',), 09:46:30 INFO - 'default_actions': ('clobber', 09:46:30 INFO - 'read-buildbot-config', 09:46:30 INFO - 'download-and-extract', 09:46:30 INFO - 'populate-webroot', 09:46:30 INFO - 'create-virtualenv', 09:46:30 INFO - 'install', 09:46:30 INFO - 'run-tests'), 09:46:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:30 INFO - 'download_minidump_stackwalk': True, 09:46:30 INFO - 'download_symbols': 'ondemand', 09:46:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:30 INFO - 'installer_path': 'installer.exe', 09:46:30 INFO - 'log_level': 'info', 09:46:30 INFO - 'log_name': 'talos', 09:46:30 INFO - 'log_to_console': True, 09:46:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:46:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:46:30 INFO - 'opt_config_files': (), 09:46:30 INFO - 'pip_index': False, 09:46:30 INFO - 'sps_profile': False, 09:46:30 INFO - 'sps_profile_interval': 0, 09:46:30 INFO - 'suite': 'dromaeojs', 09:46:30 INFO - 'system_bits': '32', 09:46:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:30 INFO - 'title': 'talos-linux64-ix-042', 09:46:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:30 INFO - 'use_talos_json': True, 09:46:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:30 INFO - 'work_dir': 'build'} 09:46:30 INFO - [mozharness: 2016-11-21 17:46:30.189194Z] Running clobber step. 09:46:30 INFO - Running pre-action listener: _resource_record_pre_action 09:46:30 INFO - Running main action method: clobber 09:46:30 INFO - rmtree: /builds/slave/test/build 09:46:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:30 INFO - Running post-action listener: _resource_record_post_action 09:46:30 INFO - [mozharness: 2016-11-21 17:46:30.641490Z] Finished clobber step (success) 09:46:30 INFO - [mozharness: 2016-11-21 17:46:30.641591Z] Running read-buildbot-config step. 09:46:30 INFO - Running pre-action listener: _resource_record_pre_action 09:46:30 INFO - Running main action method: read_buildbot_config 09:46:30 INFO - Using buildbot properties: 09:46:30 INFO - { 09:46:30 INFO - "project": "", 09:46:30 INFO - "product": "firefox", 09:46:30 INFO - "script_repo_revision": "production", 09:46:30 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:46:30 INFO - "repository": "", 09:46:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:46:30 INFO - "buildid": "20161121065208", 09:46:30 INFO - "pgo_build": "True", 09:46:30 INFO - "basedir": "/builds/slave/test", 09:46:30 INFO - "buildnumber": 24, 09:46:30 INFO - "slavename": "talos-linux64-ix-042", 09:46:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:46:30 INFO - "platform": "ubuntu64_hw", 09:46:30 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:46:30 INFO - "branch": "mozilla-beta", 09:46:30 INFO - "repo_path": "releases/mozilla-beta", 09:46:30 INFO - "revision": "83e1d3c7f75096287834ddea0f4d478ab3032604", 09:46:30 INFO - "stage_platform": "linux64-pgo", 09:46:30 INFO - "builduid": "19da6d4dc396488c895f46babe4621ac", 09:46:30 INFO - "slavebuilddir": "test" 09:46:30 INFO - } 09:46:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 09:46:30 INFO - Running post-action listener: _resource_record_post_action 09:46:30 INFO - [mozharness: 2016-11-21 17:46:30.644317Z] Finished read-buildbot-config step (success) 09:46:30 INFO - [mozharness: 2016-11-21 17:46:30.644406Z] Running download-and-extract step. 09:46:30 INFO - Running pre-action listener: _resource_record_pre_action 09:46:30 INFO - Running main action method: download_and_extract 09:46:30 INFO - mkdir: /builds/slave/test/build/tests 09:46: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')]} 09:46:30 INFO - trying https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 09:46:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 09:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:46:31 INFO - Downloaded 1327 bytes. 09:46:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 09:46:31 INFO - Using the following test package requirements: 09:46:31 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 09:46:31 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:46:31 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 09:46:31 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'jsshell-linux-x86_64.zip'], 09:46:31 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:46:31 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 09:46:31 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 09:46:31 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 09:46:31 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:46:31 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 09:46:31 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:46:31 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:46:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 09:46:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:46:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 09:46:31 INFO - Expected file size: 21962706 09:46:35 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:46:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 09:46:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:46:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 09:46:36 INFO - Expected file size: 21962706 09:46:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 09:46:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:46:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 09:46:41 INFO - Expected file size: 14414089 09:46: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')]} 09:46:42 INFO - trying https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 09:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 09:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:46:43 INFO - Downloaded 56982735 bytes. 09:46:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 09:46:43 INFO - mkdir: /builds/slave/test/properties 09:46:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:46:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:46:43 INFO - Contents: 09:46:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 09:46:43 INFO - Running post-action listener: _resource_record_post_action 09:46:43 INFO - Running post-action listener: set_extra_try_arguments 09:46:43 INFO - [mozharness: 2016-11-21 17:46:43.793651Z] Finished download-and-extract step (success) 09:46:43 INFO - [mozharness: 2016-11-21 17:46:43.793878Z] Running populate-webroot step. 09:46:43 INFO - Running pre-action listener: _resource_record_pre_action 09:46:43 INFO - Running main action method: populate_webroot 09:46:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:46:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:46:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:46:43 INFO - '--tppagecycles', 09:46:43 INFO - '7'], 09:46:43 INFO - 'tests': ['tsvgm']}}, 09:46:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:46:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:46:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:46:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:46:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:46:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['damp', 'tps']}, 09:46:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'tests': ['damp', 'tps']}, 09:46:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['dromaeo_dom']}, 09:46:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:46:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['basic_compositor_video']}, 09:46:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:46:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['a11yr', 09:46:43 INFO - 'ts_paint', 09:46:43 INFO - 'tpaint', 09:46:43 INFO - 'sessionrestore', 09:46:43 INFO - 'sessionrestore_no_auto_restore', 09:46:43 INFO - 'tabpaint']}, 09:46:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['tsvgx', 09:46:43 INFO - 'tsvgr_opacity', 09:46:43 INFO - 'tart', 09:46:43 INFO - 'tscrollx', 09:46:43 INFO - 'cart']}, 09:46:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:46:43 INFO - 'tsvgr_opacity', 09:46:43 INFO - 'tart', 09:46:43 INFO - 'tscrollx', 09:46:43 INFO - 'cart']}, 09:46:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'talos_options': ['--disable-e10s'], 09:46:43 INFO - 'tests': ['tp5o']}, 09:46:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'tests': ['tp5o']}, 09:46:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'talos_options': ['--disable-e10s', 09:46:43 INFO - '--xperf_path', 09:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:43 INFO - 'tests': ['tp5n']}, 09:46:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:46:43 INFO - 'talos_options': ['--xperf_path', 09:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:46:43 INFO - 'tests': ['tp5n']}}, 09:46:43 INFO - 'talos.zip': {'path': '', 09:46:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:46:43 INFO - Running post-action listener: _resource_record_post_action 09:46:43 INFO - [mozharness: 2016-11-21 17:46:43.815646Z] Finished populate-webroot step (success) 09:46:43 INFO - [mozharness: 2016-11-21 17:46:43.815739Z] Running create-virtualenv step. 09:46:43 INFO - Running pre-action listener: _resource_record_pre_action 09:46:43 INFO - Running main action method: create_virtualenv 09:46:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:46:43 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 09:46:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:46:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:46:43 INFO - Using real prefix '/usr' 09:46:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:46:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:46 INFO - Installing pip.................done. 09:46:46 INFO - Return code: 0 09:46:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:46:46 INFO - Using env: {'DISPLAY': ':0', 09:46:46 INFO - 'HOME': '/home/cltbld', 09:46:46 INFO - 'LANG': 'en_US.UTF-8', 09:46:46 INFO - 'LANGUAGE': 'en_US:en', 09:46:46 INFO - 'LOGNAME': 'cltbld', 09:46:46 INFO - 'MAIL': '/var/mail/cltbld', 09:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:46 INFO - 'MOZ_NO_REMOTE': '1', 09:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:46 INFO - 'NO_EM_RESTART': '1', 09:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:46 INFO - 'PWD': '/builds/slave/test', 09:46:46 INFO - 'SHELL': '/bin/bash', 09:46:46 INFO - 'SHLVL': '1', 09:46:46 INFO - 'TERM': 'linux', 09:46:46 INFO - 'TMOUT': '86400', 09:46:46 INFO - 'USER': 'cltbld', 09:46:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:46 INFO - '_': '/tools/buildbot/bin/python'} 09:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:46:46 INFO - Cleaning up... 09:46:46 INFO - Return code: 0 09:46:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:46:46 INFO - Using env: {'DISPLAY': ':0', 09:46:46 INFO - 'HOME': '/home/cltbld', 09:46:46 INFO - 'LANG': 'en_US.UTF-8', 09:46:46 INFO - 'LANGUAGE': 'en_US:en', 09:46:46 INFO - 'LOGNAME': 'cltbld', 09:46:46 INFO - 'MAIL': '/var/mail/cltbld', 09:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:46 INFO - 'MOZ_NO_REMOTE': '1', 09:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:46 INFO - 'NO_EM_RESTART': '1', 09:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:46 INFO - 'PWD': '/builds/slave/test', 09:46:46 INFO - 'SHELL': '/bin/bash', 09:46:46 INFO - 'SHLVL': '1', 09:46:46 INFO - 'TERM': 'linux', 09:46:46 INFO - 'TMOUT': '86400', 09:46:46 INFO - 'USER': 'cltbld', 09:46:46 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:46 INFO - '_': '/tools/buildbot/bin/python'} 09:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:46 INFO - Downloading/unpacking psutil>=3.1.1 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:48 INFO - Installing collected packages: psutil 09:46:48 INFO - Running setup.py install for psutil 09:46:48 INFO - building 'psutil._psutil_linux' extension 09:46:48 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 09:46:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:46:49 INFO - building 'psutil._psutil_posix' extension 09:46:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:46:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:49 INFO - Successfully installed psutil 09:46:49 INFO - Cleaning up... 09:46:49 INFO - Return code: 0 09:46:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46: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')]} 09:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46: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')]} 09:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:46:49 INFO - Using env: {'DISPLAY': ':0', 09:46:49 INFO - 'HOME': '/home/cltbld', 09:46:49 INFO - 'LANG': 'en_US.UTF-8', 09:46:49 INFO - 'LANGUAGE': 'en_US:en', 09:46:49 INFO - 'LOGNAME': 'cltbld', 09:46:49 INFO - 'MAIL': '/var/mail/cltbld', 09:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:49 INFO - 'MOZ_NO_REMOTE': '1', 09:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:49 INFO - 'NO_EM_RESTART': '1', 09:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:49 INFO - 'PWD': '/builds/slave/test', 09:46:49 INFO - 'SHELL': '/bin/bash', 09:46:49 INFO - 'SHLVL': '1', 09:46:49 INFO - 'TERM': 'linux', 09:46:49 INFO - 'TMOUT': '86400', 09:46:49 INFO - 'USER': 'cltbld', 09:46:49 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:49 INFO - '_': '/tools/buildbot/bin/python'} 09:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:51 INFO - Installing collected packages: mozsystemmonitor 09:46:51 INFO - Running setup.py install for mozsystemmonitor 09:46:51 INFO - Successfully installed mozsystemmonitor 09:46:51 INFO - Cleaning up... 09:46:51 INFO - Return code: 0 09:46:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:51 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')]} 09:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:51 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')]} 09:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:51 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 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:51 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 09:46:51 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 09:46:51 INFO - Using env: {'DISPLAY': ':0', 09:46:51 INFO - 'HOME': '/home/cltbld', 09:46:51 INFO - 'LANG': 'en_US.UTF-8', 09:46:51 INFO - 'LANGUAGE': 'en_US:en', 09:46:51 INFO - 'LOGNAME': 'cltbld', 09:46:51 INFO - 'MAIL': '/var/mail/cltbld', 09:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:51 INFO - 'MOZ_NO_REMOTE': '1', 09:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:51 INFO - 'NO_EM_RESTART': '1', 09:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:51 INFO - 'PWD': '/builds/slave/test', 09:46:51 INFO - 'SHELL': '/bin/bash', 09:46:51 INFO - 'SHLVL': '1', 09:46:51 INFO - 'TERM': 'linux', 09:46:51 INFO - 'TMOUT': '86400', 09:46:51 INFO - 'USER': 'cltbld', 09:46:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:51 INFO - '_': '/tools/buildbot/bin/python'} 09:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:52 INFO - Downloading/unpacking jsonschema==2.5.1 09:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:54 INFO - warning: no files found matching '*.txt' 09:46:54 INFO - no previously-included directories found matching 'build' 09:46:54 INFO - no previously-included directories found matching 'dist' 09:46:54 INFO - no previously-included directories found matching '.git*' 09:46:54 INFO - Installing collected packages: jsonschema, functools32 09:46:54 INFO - Running setup.py install for functools32 09:46:54 INFO - warning: no files found matching '*.txt' 09:46:54 INFO - no previously-included directories found matching 'build' 09:46:54 INFO - no previously-included directories found matching 'dist' 09:46:54 INFO - no previously-included directories found matching '.git*' 09:46:54 INFO - Successfully installed jsonschema functools32 09:46:54 INFO - Cleaning up... 09:46:54 INFO - Return code: 0 09:46:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:46:54 INFO - Cleaning up... 09:46:54 INFO - Return code: 0 09:46:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:46:54 INFO - Using env: {'DISPLAY': ':0', 09:46:54 INFO - 'HOME': '/home/cltbld', 09:46:54 INFO - 'LANG': 'en_US.UTF-8', 09:46:54 INFO - 'LANGUAGE': 'en_US:en', 09:46:54 INFO - 'LOGNAME': 'cltbld', 09:46:54 INFO - 'MAIL': '/var/mail/cltbld', 09:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:54 INFO - 'MOZ_NO_REMOTE': '1', 09:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:54 INFO - 'NO_EM_RESTART': '1', 09:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:54 INFO - 'PWD': '/builds/slave/test', 09:46:54 INFO - 'SHELL': '/bin/bash', 09:46:54 INFO - 'SHLVL': '1', 09:46:54 INFO - 'TERM': 'linux', 09:46:54 INFO - 'TMOUT': '86400', 09:46:54 INFO - 'USER': 'cltbld', 09:46:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:54 INFO - '_': '/tools/buildbot/bin/python'} 09:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:57 INFO - Downloading docopt-0.6.1.tar.gz 09:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:57 INFO - Running setup.py install for blobuploader 09:46:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:57 INFO - Running setup.py install for requests 09:46:58 INFO - Running setup.py install for docopt 09:46:58 INFO - Successfully installed blobuploader requests docopt 09:46:58 INFO - Cleaning up... 09:46:58 INFO - Return code: 0 09:46:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:46:58 INFO - Using env: {'DISPLAY': ':0', 09:46:58 INFO - 'HOME': '/home/cltbld', 09:46:58 INFO - 'LANG': 'en_US.UTF-8', 09:46:58 INFO - 'LANGUAGE': 'en_US:en', 09:46:58 INFO - 'LOGNAME': 'cltbld', 09:46:58 INFO - 'MAIL': '/var/mail/cltbld', 09:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:58 INFO - 'MOZ_NO_REMOTE': '1', 09:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:58 INFO - 'NO_EM_RESTART': '1', 09:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:58 INFO - 'PWD': '/builds/slave/test', 09:46:58 INFO - 'SHELL': '/bin/bash', 09:46:58 INFO - 'SHLVL': '1', 09:46:58 INFO - 'TERM': 'linux', 09:46:58 INFO - 'TMOUT': '86400', 09:46:58 INFO - 'USER': 'cltbld', 09:46:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:58 INFO - '_': '/tools/buildbot/bin/python'} 09:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:58 INFO - Running setup.py (path:/tmp/pip-etO7fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:58 INFO - Running setup.py (path:/tmp/pip-lQfy0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:58 INFO - Running setup.py (path:/tmp/pip-rUEq3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:58 INFO - Running setup.py (path:/tmp/pip-OoIwnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:58 INFO - Running setup.py (path:/tmp/pip-E_ztiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:58 INFO - Running setup.py (path:/tmp/pip-pyfTL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:59 INFO - Running setup.py (path:/tmp/pip-yJDMid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:59 INFO - Running setup.py (path:/tmp/pip-Rli3EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:59 INFO - Running setup.py (path:/tmp/pip-3R5GLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:59 INFO - Running setup.py (path:/tmp/pip-LoKJP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:59 INFO - Running setup.py (path:/tmp/pip-rNMOUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:59 INFO - Running setup.py (path:/tmp/pip-wtSW7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:59 INFO - Running setup.py (path:/tmp/pip-EHo3Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:59 INFO - Running setup.py (path:/tmp/pip-8ualkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:59 INFO - Running setup.py (path:/tmp/pip-zMQGtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:59 INFO - Running setup.py (path:/tmp/pip-cWD0o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:59 INFO - Running setup.py (path:/tmp/pip-ctMJT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:59 INFO - Running setup.py install for manifestparser 09:46:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:59 INFO - Running setup.py install for mozcrash 09:47:00 INFO - Running setup.py install for mozdebug 09:47:00 INFO - Running setup.py install for mozdevice 09:47:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for mozfile 09:47:00 INFO - Running setup.py install for mozhttpd 09:47:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for mozinfo 09:47:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for mozInstall 09:47:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for mozleak 09:47:00 INFO - Running setup.py install for mozlog 09:47:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for moznetwork 09:47:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:00 INFO - Running setup.py install for mozprocess 09:47:01 INFO - Running setup.py install for mozprofile 09:47:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:01 INFO - Running setup.py install for mozrunner 09:47:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:01 INFO - Running setup.py install for mozscreenshot 09:47:01 INFO - Running setup.py install for moztest 09:47:01 INFO - Running setup.py install for mozversion 09:47:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:01 INFO - Cleaning up... 09:47:01 INFO - Return code: 0 09:47:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:01 INFO - Using env: {'DISPLAY': ':0', 09:47:01 INFO - 'HOME': '/home/cltbld', 09:47:01 INFO - 'LANG': 'en_US.UTF-8', 09:47:01 INFO - 'LANGUAGE': 'en_US:en', 09:47:01 INFO - 'LOGNAME': 'cltbld', 09:47:01 INFO - 'MAIL': '/var/mail/cltbld', 09:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:01 INFO - 'MOZ_NO_REMOTE': '1', 09:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:01 INFO - 'NO_EM_RESTART': '1', 09:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:01 INFO - 'PWD': '/builds/slave/test', 09:47:01 INFO - 'SHELL': '/bin/bash', 09:47:01 INFO - 'SHLVL': '1', 09:47:01 INFO - 'TERM': 'linux', 09:47:01 INFO - 'TMOUT': '86400', 09:47:01 INFO - 'USER': 'cltbld', 09:47:01 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:01 INFO - '_': '/tools/buildbot/bin/python'} 09:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:01 INFO - Running setup.py (path:/tmp/pip-7Yflxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:01 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)) 09:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:01 INFO - Running setup.py (path:/tmp/pip-f71YUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:02 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)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:02 INFO - Running setup.py (path:/tmp/pip-7MWHYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:02 INFO - Running setup.py (path:/tmp/pip-a707cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:02 INFO - Running setup.py (path:/tmp/pip-6pVmsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:02 INFO - Running setup.py (path:/tmp/pip-JBXHXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:02 INFO - Running setup.py (path:/tmp/pip-MCVYh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:02 INFO - Running setup.py (path:/tmp/pip-xAAqSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:02 INFO - Running setup.py (path:/tmp/pip-00d3m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:02 INFO - Running setup.py (path:/tmp/pip-1XhHdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:02 INFO - Running setup.py (path:/tmp/pip-pwOiM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:02 INFO - Running setup.py (path:/tmp/pip-IQv1A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:02 INFO - Running setup.py (path:/tmp/pip-MlZ6Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:02 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)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:02 INFO - Running setup.py (path:/tmp/pip-4woi3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:02 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)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:02 INFO - Running setup.py (path:/tmp/pip-gEft8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:02 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)) 09:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:02 INFO - Running setup.py (path:/tmp/pip-gmtuHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:03 INFO - Running setup.py (path:/tmp/pip-hlzz1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:05 INFO - Downloading blessings-1.6.tar.gz 09:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:05 INFO - Installing collected packages: blessings 09:47:05 INFO - Running setup.py install for blessings 09:47:05 INFO - Successfully installed blessings 09:47:05 INFO - Cleaning up... 09:47:05 INFO - Return code: 0 09:47:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:05 INFO - Reading from file tmpfile_stdout 09:47:05 INFO - Current package versions: 09:47:05 INFO - argparse == 1.2.1 09:47:05 INFO - blessings == 1.6 09:47:05 INFO - blobuploader == 1.2.4 09:47:05 INFO - docopt == 0.6.1 09:47:05 INFO - functools32 == 3.2.3-2 09:47:05 INFO - jsonschema == 2.5.1 09:47:05 INFO - manifestparser == 1.1 09:47:05 INFO - mozInstall == 1.12 09:47:05 INFO - mozcrash == 0.17 09:47:05 INFO - mozdebug == 0.1 09:47:05 INFO - mozdevice == 0.48 09:47:05 INFO - mozfile == 1.2 09:47:05 INFO - mozhttpd == 0.7 09:47:05 INFO - mozinfo == 0.9 09:47:05 INFO - mozleak == 0.1 09:47:05 INFO - mozlog == 3.4 09:47:05 INFO - moznetwork == 0.27 09:47:05 INFO - mozprocess == 0.23 09:47:05 INFO - mozprofile == 0.28 09:47:05 INFO - mozrunner == 6.12 09:47:05 INFO - mozscreenshot == 0.1 09:47:05 INFO - mozsystemmonitor == 0.3 09:47:05 INFO - moztest == 0.7 09:47:05 INFO - mozversion == 1.4 09:47:05 INFO - psutil == 3.1.1 09:47:05 INFO - requests == 1.2.3 09:47:05 INFO - wsgiref == 0.1.2 09:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:05 INFO - Using env: {'DISPLAY': ':0', 09:47:05 INFO - 'HOME': '/home/cltbld', 09:47:05 INFO - 'LANG': 'en_US.UTF-8', 09:47:05 INFO - 'LANGUAGE': 'en_US:en', 09:47:05 INFO - 'LOGNAME': 'cltbld', 09:47:05 INFO - 'MAIL': '/var/mail/cltbld', 09:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:05 INFO - 'MOZ_NO_REMOTE': '1', 09:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:05 INFO - 'NO_EM_RESTART': '1', 09:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:05 INFO - 'PWD': '/builds/slave/test', 09:47:05 INFO - 'SHELL': '/bin/bash', 09:47:05 INFO - 'SHLVL': '1', 09:47:05 INFO - 'TERM': 'linux', 09:47:05 INFO - 'TMOUT': '86400', 09:47:05 INFO - 'USER': 'cltbld', 09:47:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:05 INFO - '_': '/tools/buildbot/bin/python'} 09:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:47:05 INFO - Cleaning up... 09:47:05 INFO - Return code: 0 09:47:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a47069f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', '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 09:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:47:05 INFO - Using env: {'DISPLAY': ':0', 09:47:05 INFO - 'HOME': '/home/cltbld', 09:47:05 INFO - 'LANG': 'en_US.UTF-8', 09:47:05 INFO - 'LANGUAGE': 'en_US:en', 09:47:05 INFO - 'LOGNAME': 'cltbld', 09:47:05 INFO - 'MAIL': '/var/mail/cltbld', 09:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:05 INFO - 'MOZ_NO_REMOTE': '1', 09:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:05 INFO - 'NO_EM_RESTART': '1', 09:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:05 INFO - 'PWD': '/builds/slave/test', 09:47:05 INFO - 'SHELL': '/bin/bash', 09:47:05 INFO - 'SHLVL': '1', 09:47:05 INFO - 'TERM': 'linux', 09:47:05 INFO - 'TMOUT': '86400', 09:47:05 INFO - 'USER': 'cltbld', 09:47:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:05 INFO - '_': '/tools/buildbot/bin/python'} 09:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:47:05 INFO - Cleaning up... 09:47:05 INFO - Return code: 0 09:47:05 INFO - Running post-action listener: _resource_record_post_action 09:47:05 INFO - Running post-action listener: _start_resource_monitoring 09:47:05 INFO - Starting resource monitoring. 09:47:05 INFO - [mozharness: 2016-11-21 17:47:05.998969Z] Finished create-virtualenv step (success) 09:47:05 INFO - [mozharness: 2016-11-21 17:47:05.999526Z] Running install step. 09:47:05 INFO - Running pre-action listener: _resource_record_pre_action 09:47:05 INFO - Running main action method: install 09:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:06 INFO - Reading from file tmpfile_stdout 09:47:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:47:06 INFO - Reading from file tmpfile_stdout 09:47:06 INFO - Output received: 09:47:06 INFO - Usage: mozinstall [options] installer 09:47:06 INFO - Options: 09:47:06 INFO - -h, --help show this help message and exit 09:47:06 INFO - -d DEST, --destination=DEST 09:47:06 INFO - Directory to install application into. [default: 09:47:06 INFO - "/builds/slave/test"] 09:47:06 INFO - --app=APP Application being installed. [default: firefox] 09:47:06 INFO - mkdir: /builds/slave/test/build/application 09:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:47:20 INFO - Reading from file tmpfile_stdout 09:47:20 INFO - Output received: 09:47:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:47:20 INFO - Running post-action listener: _resource_record_post_action 09:47:20 INFO - [mozharness: 2016-11-21 17:47:20.375456Z] Finished install step (success) 09:47:20 INFO - [mozharness: 2016-11-21 17:47:20.375698Z] Running run-tests step. 09:47:20 INFO - Running pre-action listener: _resource_record_pre_action 09:47:20 INFO - Running main action method: run_tests 09:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:47:20 INFO - Python 2.7.3 09:47:20 INFO - Return code: 0 09:47:20 INFO - grabbing minidump binary from tooltool 09:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:20 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 0x22f9f60>, '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 0x22fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:47:20 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 09:47:20 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 09:47:20 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 09:47:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:47:20 INFO - Return code: 0 09:47:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:47:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:47:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:47:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:47:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:47:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 09:47:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 09:47:20 INFO - Using env: {'DISPLAY': ':0', 09:47:20 INFO - 'HOME': '/home/cltbld', 09:47:20 INFO - 'LANG': 'en_US.UTF-8', 09:47:20 INFO - 'LANGUAGE': 'en_US:en', 09:47:20 INFO - 'LOGNAME': 'cltbld', 09:47:20 INFO - 'MAIL': '/var/mail/cltbld', 09:47:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:47:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:20 INFO - 'MOZ_NO_REMOTE': '1', 09:47:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:47:20 INFO - 'NO_EM_RESTART': '1', 09:47:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:20 INFO - 'PWD': '/builds/slave/test', 09:47:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:47:20 INFO - 'SHELL': '/bin/bash', 09:47:20 INFO - 'SHLVL': '1', 09:47:20 INFO - 'TERM': 'linux', 09:47:20 INFO - 'TMOUT': '86400', 09:47:20 INFO - 'USER': 'cltbld', 09:47:20 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723', 09:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:20 INFO - '_': '/tools/buildbot/bin/python'} 09:47:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 09:47:20 INFO - mozversion application_buildid: 20161121065208 09:47:20 INFO - mozversion application_changeset: 83e1d3c7f75096287834ddea0f4d478ab3032604 09:47:20 INFO - mozversion application_display_name: Firefox 09:47:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:47:20 INFO - mozversion application_name: Firefox 09:47:20 INFO - mozversion application_remotingname: firefox 09:47:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:20 INFO - mozversion application_vendor: Mozilla 09:47:20 INFO - mozversion application_version: 51.0 09:47:20 INFO - mozversion platform_buildid: 20161121065208 09:47:20 INFO - mozversion platform_changeset: 83e1d3c7f75096287834ddea0f4d478ab3032604 09:47:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:47:20 INFO - mozversion platform_version: 51.0 09:47:20 INFO - using testdate: 1479750440 09:47:20 INFO - actual date: 1479750440 09:47:20 INFO - starting webserver on 'localhost:33248' 09:47:20 INFO - SUITE-START | Running 2 tests 09:47:20 INFO - TEST-START | dromaeo_css 09:47:20 INFO - operating with platform_type : linux_ 09:47:20 INFO - Initialising browser for dromaeo_css test... 09:47:20 INFO - TEST-INFO | started process 27261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT92LIQ/profile http://localhost:33248/getInfo.html) 09:47:24 INFO - PROCESS | 27261 | __metrics Screen width/height:1600/1200 09:47:24 INFO - PROCESS | 27261 | colorDepth:24 09:47:24 INFO - PROCESS | 27261 | Browser inner width/height: 1024/697 09:47:24 INFO - PROCESS | 27261 | __metrics 09:47:25 INFO - PROCESS | 27261 | 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" 09:47:25 INFO - PROCESS | 27261 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:47:25 INFO - PROCESS | 27261 | console.error: PushService: 09:47:25 INFO - PROCESS | 27261 | stateChangeProcessEnqueue: Error transitioning state 09:47:25 INFO - PROCESS | 27261 | UnknownError 09:47:26 INFO - TEST-INFO | 27261: exit 0 09:47:26 INFO - Browser initialized. 09:47:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:47:26 INFO - TEST-INFO | started process 27353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT92LIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:38 INFO - PROCESS | 27353 | RSS: Main: 142872576 09:47:38 INFO - PROCESS | 27353 | 09:48:29 INFO - PROCESS | 27353 | 1479750509248 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] 09:50:38 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33248/tests/dromaeo/cssquery-ext.html) 09:50:39 INFO - PROCESS | 27353 | RSS: Main: 244322304 09:50:39 INFO - PROCESS | 27353 | 09:53:41 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-ext.html (next: http://localhost:33248/tests/dromaeo/cssquery-jquery.html) 09:53:42 INFO - PROCESS | 27353 | RSS: Main: 245620736 09:53:42 INFO - PROCESS | 27353 | 09:56:43 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33248/tests/dromaeo/cssquery-mootools.html) 09:56:44 INFO - PROCESS | 27353 | RSS: Main: 213258240 09:56:44 INFO - PROCESS | 27353 | 09:59:46 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33248/tests/dromaeo/cssquery-prototype.html) 09:59:46 INFO - PROCESS | 27353 | RSS: Main: 175493120 09:59:46 INFO - PROCESS | 27353 | 10:02:49 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33248/tests/dromaeo/cssquery-yui.html) 10:02:50 INFO - PROCESS | 27353 | RSS: Main: 177373184 10:02:50 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | Cycle 1(1): loaded http://localhost:33248/tests/dromaeo/cssquery-yui.html (next: http://localhost:33248/tests/dromaeo/cssquery-dojo.html) 10:05:52 INFO - PROCESS | 27353 | RSS: Main: 266747904 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | __start_tp_report 10:05:52 INFO - PROCESS | 27353 | _x_x_mozilla_page_load 10:05:52 INFO - PROCESS | 27353 | _x_x_mozilla_page_load_details 10:05:52 INFO - PROCESS | 27353 | |i|pagename|runs| 10:05:52 INFO - PROCESS | 27353 | |0;dojo.html;3121.703438173374;3160.4785210440273;3170.461021626323;3190.505471651892;3205.27881226724;5566.721663916803;5643.379228284885;5667.886642267152;5678.744456499458;5704.315482142144;5644.74598643061;5711.514521265697;5714.799982000631;5723.112917497794;5724.742386592603;5141.280220769096;5175.611829112831;5191.5846732261325;5198.870028249286;5246;5048.949510504903;5061.215511595708;5255.369355677324;5260.974110048542;5261.552768014723;5022.924656130161;5073;5109.2591574221715;5120.155174396239;5148.845534633967;5098.643094983353;5107.897842043157;5163.741812909339;5171.948280517222;5196.194589838581;4929.088118698017;5054.1660625996665;5073.416557095944;5108.66793658411;5128.512791284859;5473.8357849264585;5485.725713714299;5491.121420572729;5511.614187006911;5542.334919809648;5893.882122357529;5901.940980590182;5982.192404025488;5986.700664966777;5989.251343582052;5906.173135760954;6032.758689652409;6048.516118710492;6054.091886217103;6058.1215723719815;5550.361708403505;5572.331320241557;5619;5621.01632214365;5624.29696287964;6199.659018753921;6209.316975132731;6209.9068513972325;6213.1922850029205;6214.502839772807;5759.366469688414;5954.85112872173;5966.134910438049;5969.880602388015;5970.880582388415;5890.528757699374;5964.7315870785915;6034.637921724623;6035.245594300713;6068.726907289182;6020.337762846083;6037.426444487766;6042.546808989343;6046.486048685823;6047;6015.759369625253;6069.575129740964;6073.362296958844;6076.3316035236085;6093.908591371133;4424.093060922568;4498.212812757754;4536.432945881765;4568.634509239253;4594.310853372021;4087.0395457067566;4089.479203075824;4090.4682391288943;4099.631033206966;4110.506739191316;5724.055530837365;5736.368999410061;5736.770529178786;5739;5739.741711622987;5895.970520147372;5972.940270597325;5975.282966044103;6022.066579680157;6102.145699602059;5737.942620573825;5758.74085666146;5761.683107429131;5770.682612456355;5796.101604251347;5229.50319719626;5239.73801309933;5241.397239317451;5243.842684719464;5246;6087.4521293083835;6117.522930757244;6136.3046386708;6188.44304012641;6232.065190221412;5996.400359963969;6087.086936959491;6095.512359011357;6130.049842274455;6133.202683651097;6161.383861613803;6251.374862513894;6254.28075771274;6258.155149055002;6260.311365749672;5591.608587398843;5629.4652008059165;5963.674167074931;5984.700764961647;6015.39846015395;5904.763809447574;5965;5997.070454079625;6049.879002420015;6082.574219804571;5828.358880523224;5869.941300586939;5885.47030767233;5886.470217680258;5912.911306330322;5577.051901176728;5886.41135886425;5890.52875769946;5893.557983151195;5913.05391137416;5660.122680984454;5781.248437703071;5849.034909240098;5864.472197502245;5954.047352423591;5959;5967.343592204941;5985.132155837467;5989.431004054608;5993.880122397615;5681.488666020078;5737.196792449144;5829.854253643693;5840.1531777892815;5841.532677385884 10:05:52 INFO - PROCESS | 27353 | |1;ext.html;579.5189992306383;600.9789657361991;623.694389749023;650.8437974886026;666.9333066693329;35625.46561801572;36280.09299767507;38934.22131557374;38945.221095578105;38946.61053389472;39321.80339098308;47996.52003479964;49139.75430122853;49258.261126083045;53451.73274133634;9398.577064032117;9542.761430964247;9544.093311135432;9549.665761698341;9550;8799.560021998874;9058.864117038249;9448.149666530011;9536.332456728032;9549.761255968588;11205.159613029015;11467.483963221675;11473.082153427706;11787.646370608896;11792.823107653392;11373;11465.140114491447;11466.369349685763;11466.827997580001;11467.426628668616;11201.71995700114;11269.43652817364;11274.210805243636;11289.209755317132;11289.322640641587;46868.531314686756;47419.28871066937;47423.051538969376;47443;47468.28797568005;3828.119532507511;3857.614238576148;4035.5762644922156;4182.163567286555;4616.838410655611;35005.29989400223;36879;37635.811820940995;37660.62339376626;38283.61716382856;4785.736784476852;4868.294097355863;4919.950800492021;4924.064427758714;5006.3241462402475;383108;385413;390096;392830;393920.03039984906;40601.593984060375;41807.70057646859;71194;72149;72172.63913680398;43039.56960430418;43497.78251108788;43648.56351436509;43665.126697466505;43679.344809827875;16392.016479011298;16476.176191190392;16485.17574121289;16494.83505164933;16512.25694843735;13503.86496135026;13604.523841665494;13642.52251171224;13662.180269183682;13693;9212.769680758034;9429.764255893657;9617.759556011015;9710.611575537041;9915;3746.250749850041;3779.508663873734;3794.3739283017994;3797.1963317424;3808.3906574947873;1055.621607907709;1071.2822408985999;1075.4031512510476;1178.9410529473491;1217.245307909102;35530;35750.45333386224;36042.27915441676;37050.07374815597;38649.80675096607;1091.9945400272948;1092.3445932440472;1122.3826895207767;1186.3119390753343;1211.3337664284609;18583.72124418135;18656.440306790817;18845.717314240297;18867;18952.620947581247;579678.6096417115;585217;587220;587906;588674;66889.66555167291;67388;67396;67422.66288668526;67429;1280.750253700538;1311.2329287366997;1340.3231368159018;1357.6198664373992;1441.4234306277574;33070.5039424404;34580;34893;35301;35420.46869296911;60132.39867601268;61087.69456152691;61186.69406652938;61198.08202877049;61250.69374653098;524188;524861;526233;526806;529223;32108.67891321057;33200.1699957503;33211.33577328488;33217.667823321455;33234;53849.038302893714;53960;54324;54786.17820732772;56326.155107672595;45520.317195241434;47145.34991275426;47803.76098119487;47967.520324797704;48661;45287.978969171134;47064.7646761764;47470.52529474661;47502.76248618735;48499;45073.32390014218;46139.538604613525;46400.767996159804;46597.3010404851;46846;38763.80618096892;40528.59471405248;40870.59129408668;41066.38400424056;41157.794211028755;30338.393232135677;30443.54334685026;30463.390732185675;30595;30786 10:05:52 INFO - PROCESS | 27353 | |2;jquery.html;389.6921432068666;411.63775877228056;427.63009996353156;430.2212994479992;442.9645628349732;14679.48621798236;16314.755278670815;20190.89904550479;20517.33010897208;21778.237761678345;20244.39266821994;20265.898670506627;20583;20781.48046298843;20842.791572084276;5833.329167145769;5849.64902105875;6007.729652165663;6037.879242415149;6041.697915104227;4423.734575925455;5905.379935106795;5941.792037278696;5974.6713930733795;5976.701164941757;4563.06457176278;4570.200214962385;6672.799816005503;6682.6658667066695;6727.4618030557685;6470.0618410330235;6635.004749287597;6717.395434410902;6722.731090756389;6731.427828634572;5917.644941303535;5919.437653422918;5924.822255332347;5928.614640048383;5931.6441013539325;23693.88153059241;24187.153449629353;24224.636630450557;24316.878415607986;24364.634530482057;2598;2631.6447279617196;2696.0968075694664;2793.3714914144357;2940.7059294070636;15423.305951232222;15482.30329635169;15523.844761552353;15884.84115158845;16327.83672163275;2026.3515674984012;2048.262625454835;2050.4156315450027;2069.461939895623;2143.906607630104;87590.56204718935;88064;88888.5555572231;89952;90299.54850225706;10590.364578125183;10614.416207108528;10641.73395665099;11050;11489.597864074718;16111.597210069842;16118.113503757406;16150.75773863393;16161.515154545383;16173.676526469404;8443.240108390275;8731.738047858575;8842.425242359355;8947.373683842068;9027.322950778718;8559.058503564604;8681.696140635047;8702;8834.514101724339;8897.377183597215;6795.18457785059;6855.6572171391235;6894.448444124458;6923.584584924921;6925;2005.7292265543965;2016.183445704492;2025.7771645119026;2042.2239548971593;2054.496648321171;966.1739212972948;1039.095986491757;1041.5885725138528;1069.8127827630133;1125.307935619588;20386.69419958702;20799.480012999797;20953.580928381347;21060;21064.89467552683;1036.9481525923673;1039.9064084232455;1040.266612038511;1043.1967385113421;1046.7540128069897;11550.711232219093;11861.584844530573;11950;11971.940140299243;12036.45835937385;490455;502218;505670;517178;518460;86482;87396.56301718578;87672.56163719269;88140;88743.55628221818;1092.3009274064445;1104.216006635282;1129.9661010169707;1133.3596517967487;1150.6375491720082;17969.82030179734;18088.72866906971;18176.636467270844;18305.084745762924;18314.71796974199;44135;44355.33466998062;44381.556184437744;44626.77686611546;44788.32817507675;56505.71747141238;58512.707436462544;59908;59960.400395997225;60887.39112608817;8201;8423.873641895254;8509.191626795444;8651;8738.956305218433;10316.48417579103;13686.384112715152;13924.930375348058;13934.442622294995;14411.279436028366;11842.822357664814;12101.026092930708;12143.817842732542;12271.75456490883;12563.811542827048;12118.394080296126;12167.634970950885;12236.938815306223;12383;12676.492940282655;11339.433028348385;11825;11951.163418560966;11982.700432489257;12367.319797410868;8622.26710729595;8651.264642505457;8666.133386661284;8679.86980195285;8701.608427620899;10092.495375231356;11544.480498377761;11651.184417090722;11779.882201178221;11903.821442678194 10:05:52 INFO - PROCESS | 27353 | |3;mootools.html;1431.219985108116;1504.3832028868167;1508.3212554350541;1668.3743596151444;1842.8433583145431;8183.304419124374;9307.255419566436;9709.174720148796;9712.368696034753;9949.900500995005;9687.0797274259;9837.65568205113;9843.606255749779;9852.113309802135;9854.113129818315;2569.6402503649506;2591.468748906479;2592.8055395845295;2593.922182334533;2596.480703859226;2492.102842976527;2550.3369124027795;2550.6429099926027;2551.400420901087;2554.0422341621893;2472.09768434521;2498.537770512452;2535.290118766748;2536.759007894247;2539.9746002539923;2463.4210960424284;2483.1681386735463;2487.8507289562594;2491.0533997080993;2497.5254701606727;2447;2473.060237109905;2478.2689106713383;2482.640017197496;2484.0560586977012;9112.681056163068;9593.760155996086;9724.805503889882;9796.65711700087;9924.404535727806;5823;5976.342602313742;5989.161517387569;5993.041113421831;6007.849803754941;3654.908627284339;3834.118152824866;3844.9807750961345;3900.3759398496386;3922.5489068756888;1333.3599872061466;1336.1849271944204;1338.886194673454;1370.0820450298324;1381.7443772902045;14106.012579119466;14209.147451152963;14210.14739115646;14263.643408914757;14288.428462861577;5048.646594738407;5075.416327122428;5115.565176959925;5181.5077567631015;5208.218767184952;10902.563897444172;10953.616623418142;10969.506372213269;10975.780484390427;10981.121510279318;5951.464368206795;5957.076653118774;5962.284525856839;5966.85082872923;5971.253593300838;4742.383490146328;4890.364252647133;5023.49765023502;5537.473939975695;5554.222408862763;3998.8600398985895;4102.323116685773;4147.52303485103;4191.769452680071;4206.053637931441;1218.865924748277;1219.9329036903055;1222.773786849418;1229.6495498782983;1252.0984890878735;887.8890138732659;1022.4325499347784;1033.1270076785104;1036.2435422141878;1039.8856125826153;6381.936180638134;6594.10979517759;6690.762208991352;6756.729730810713;6805;476.780680886789;482.95653391194963;485.83481616250646;532.3824363738123;536.3028063517412;4496.19068567661;4501.504834468205;4558.270676691714;4568.451785785727;4734.242521196592;11562.595309164139;12039.939800300943;12066.939665301617;12074.27554346742;12081.335526546125;11808.704782380337;11886.405679716152;12013.159078864395;12142.150049496628;12162.695932601579;8904.243139333099;9016.323775716848;9027.909720902708;9096.499692516843;9104.726858194264;6353.205849268841;6396.10454536356;6406;6522.15212022434;6545.901811472927;10840.186985975926;11026.779464410827;11030.338179709242;11054.11567074616;11189.552417903193;11004.614838480615;11177.66467005991;11285.548578056785;11321.207515474167;11332.886671133183;8669.6965606206;8787.736367908972;8877.20105190536;8894.866577001221;8928.687495937871;9447.291453140904;9611.471369074769;9723.756906077122;9734.075262850018;9734.318597698093;8514.91485085166;8546.359023073419;8599.95700021496;8710.085441028854;8791.5164665944;8144.30773384269;8353.624086915981;8385.916140838513;8416.789580260542;8524.531150786766;7506.924930750841;7693.115291741521;7750.728724494616;7752.992111025531;7767;5588.748506317144;5609.214709940693;5649.71751412436;5689.118186681071;5758.395368486249;5866.472017518444;5936.228290322403;5943.435373639497;5965.254343207099;6019.277686677627 10:05:52 INFO - PROCESS | 27353 | |4;prototype.html;350.3431066749844;351.5500159795461;359.08970759125623;360.44311538672747;363.5746176972941;5583.6928968906695;5600.467955544222;5610.579206559504;5640.4359564043625;5651.830445086649;5489.505944465007;5559.277293951791;5564.33228012638;5577.326801959416;5589.524890384322;3829.215010922768;4133.586641335865;4293.270144075499;4356.106998065389;4370.584794444522;4366.279563871974;4366.694331396803;4380.58384453478;4382.838547784823;4391.516933137353;4365.4106695596165;4389.604935555815;4407.118576284756;4409.581089796464;4442.62237709795;4138.8344466221315;4320.82716691332;4357.760323182224;4419.4033805436175;4439.7558134302435;3787.9393769744515;3797.544294684628;3802;3807.200487897545;3816.8473261069526;5379.623426360156;5410.6202918255985;5418.701971391612;5435.701036442994;5492.258545096441;4799.984006717187;4918.778654960535;4927.384076990376;4928.408590969071;4947.437844751809;5750.338711048241;5758.48173664368;5767.769289228426;5768.394318596529;5823.5341172706085;4134.883581433026;4217.283061879488;4231.344141658048;4236.152769446092;4237.533871274158;5666.801661941812;5798.797042103548;5959.851003724898;6053.485453736438;6065.332813390523;4170.77060761655;4249.660027197817;4293.763842988666;4304.978475107667;4330.826766929351;4358.869233922987;4360.607545320873;4380.69335146543;4384.934225986613;4387.692861499664;4869.269609558594;4893.877653058702;4989.151844186425;5000.549950504472;5013.3983921928875;5738.368779434259;5775.826725198251;5794.0439827428845;5797.913031304533;5824.301083869963;1474.1818290848469;1476.7964109250927;1494.6338147154017;1504.8946573739734;1509.9094054356774;927.6057675487891;946.2099147212155;950.7718147644515;954.3319676226669;979.5298256836616;4969.229769385751;4971.850844474671;4987.177115775857;4996.375453068366;5022.271770593244;5217.34783152106;5221.451747566451;5229.9341760005345;5229.9603154769675;5237.764300606482;4677.298405239241;4971.831619569398;4982.526659967298;4982.725950072709;5011.69462047455;2776.8333899966065;2804.8036637435594;2810.4800611886867;2823.110720123155;2838;5307.867303317448;5380.677159370451;5431.429699881455;5444.7822087116865;5464.617476776588;5043.411325432477;5192.948070519246;5265.894682106336;5294.92057619136;5299.205119232069;5325.467453254643;5340.30576025122;5343.702208050498;5380.24676545284;5406.378266499324;5178.223266510054;5178.948210517847;5179.766910489112;5182.663126896739;5208.322918020633;4993.950060499348;5122.6937131031345;5151;5167.457416971164;5220.216967454912;5356.143017117242;5863.648181109147;5979.40205979416;5994.880102398015;6084.543659225487;4262;4269.146170765921;4292.849750258726;4300.61294483498;4329.350597410414;5855.443732845373;6079.392060793885;6104.908426373697;6111.816645500642;6114.449699527064;5807.680577568105;5829.358770535153;5835.766569337179;5867.32525759526;5885;5793.362730099601;5796.333421656564;5847.561432892465;5861.736221869941;5861.824145275648;5715.714214289352;5751.798687045934;5802;5822.195119512964;5849.3858144894175;5876.382979787061;5881.2942446906645;5886.911696324473;5889.852753681193;5947.9702601486715;5492.588055895744;5575.804846830341;5675.262215911905;5718;5794.333651629948 10:05:52 INFO - PROCESS | 27353 | |5;yui.html;799.7280924485674;844.4595458906301;866.8743032260327;892.2549671024694;894.0165817600638;15965.84034159658;16612.169391530406;16718.749218761714;16782.580435489104;16808.411705590308;15476;15716.371345146208;15725.449609263678;15871.84128158718;16513.33946642133;729.8503806719636;747.8504299140167;848.6987119572556;850.6469815026757;877.0308808766317;877.214892671059;877.4472082587961;878.1876763993313;881.3389957531851;882.4176043811054;915.2037727177365;917.7476194046624;917.9541022948825;918.6187732091174;919.7746552094746;913.3743385780762;914.2822884036033;915.1351972386097;915.7893684452613;916.3081873185736;673.2157037051828;673.2795908378038;674.4604316546743;677.2178134254943;677.4918810891832;15646.9217653911;15651.295691693902;15671.529854104396;15672.843271567366;15683.215839208107;16331.18344082803;16670.33318667252;16683.249253783608;16827.91586042074;17849;12937.935310323388;13032.348382580833;13106.60680179596;13195.538156164585;13539.187648741008;4174.269502836992;4258.063226090286;4271.1671224111315;4272.4445822042935;4336.544662810423;87140.12859871384;87786.12213877907;87807;89769;90020;13326;13473.730525389634;13535.45858165682;13537.390817413043;13605.659858503617;24920.5015899681;25216.747832521807;25220.369490762878;25334.23997280048;25340.74659253384;9026.323025773094;9244.953775231215;9277.953610231905;9292.117248861347;9382.812343753087;4881.707097574157;4974.477679843637;5181.274621552986;5271.841844744664;5383.300170977748;3664.6335366463672;3958;3960.940585891214;3965.147493288957;3973.7417067890497;632.8639342541376;634.0552576660834;636.4780879678619;648.9448396886318;654.8101050695341;592.5022980696236;619.6870580356981;643.3074154354067;703.085988215318;750.3696894608446;9013.684521041732;9903.306768526278;10197.643082492077;10353.171746260281;10401.68794936138;697.7034760226883;710.3429327871698;716.8852983522611;748.745426554974;752.8230865746546;4482.394876691605;4836.564709176191;4881.011649905393;4944.332515110486;4980.228064649985;78042.21957780463;79386.20613793904;116207;116380.41809790897;140946;113898;116361.41819290849;118354.40822795831;119641.40179299221;120359;55608;86530.56734716285;95578.52210739041;97271;99533.50233248933;9157.221636161;9482.241420686467;9487.857682134636;9507.904920950701;9529.428234305964;50313;58843;62709.372906272176;62719;62732.37267627448;52896.471035289156;55175.44824551864;68750;80749;80961.59519202367;14480.710385792436;14559.781603275747;14751.409943602135;15115.54653360357;15288.617784555476;17242.568935776704;17520.649587008444;17589.824101759332;17645.647087058445;18717.06414679288;15410.768838467207;15588.22058897028;16178.433754818525;16915.407960721317;16934.15329233558;14607.488737894122;14848.62878428048;15683.843161568238;15790;15885.126318052618;14108.082974606617;14868.256587170814;15640.921795391405;16451.91774041122;16954.237059332114;12123.272603643809;12500;12560.12079154487;12910.80633790475;13185.934070329587;11599.88400115988;13116.737665246832;13149.408276627384;13212.471501139848;13417.530386436429 10:05:52 INFO - PROCESS | 27353 | __end_tp_report 10:05:52 INFO - PROCESS | 27353 | __start_cc_report 10:05:52 INFO - PROCESS | 27353 | _x_x_mozilla_cycle_collect,865 10:05:52 INFO - PROCESS | 27353 | __end_cc_report 10:05:52 INFO - PROCESS | 27353 | __startTimestamp1479751552913__endTimestamp 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | ------- Summary: start ------- 10:05:52 INFO - PROCESS | 27353 | Number of tests: 6 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#0] dojo.html Cycles:165 Average:5589.85 Median:5796.10 stddev:647.94 (11.2%) stddev-sans-first:620.32 10:05:52 INFO - PROCESS | 27353 | Values: 3121.7 3160.5 3170.5 3190.5 3205.3 5566.7 5643.4 5667.9 5678.7 5704.3 5644.7 5711.5 5714.8 5723.1 5724.7 5141.3 5175.6 5191.6 5198.9 5246.0 5048.9 5061.2 5255.4 5261.0 5261.6 5022.9 5073.0 5109.3 5120.2 5148.8 5098.6 5107.9 5163.7 5171.9 5196.2 4929.1 5054.2 5073.4 5108.7 5128.5 5473.8 5485.7 5491.1 5511.6 5542.3 5893.9 5901.9 5982.2 5986.7 5989.3 5906.2 6032.8 6048.5 6054.1 6058.1 5550.4 5572.3 5619.0 5621.0 5624.3 6199.7 6209.3 6209.9 6213.2 6214.5 5759.4 5954.9 5966.1 5969.9 5970.9 5890.5 5964.7 6034.6 6035.2 6068.7 6020.3 6037.4 6042.5 6046.5 6047.0 6015.8 6069.6 6073.4 6076.3 6093.9 4424.1 4498.2 4536.4 4568.6 4594.3 4087.0 4089.5 4090.5 4099.6 4110.5 5724.1 5736.4 5736.8 5739.0 5739.7 5896.0 5972.9 5975.3 6022.1 6102.1 5737.9 5758.7 5761.7 5770.7 5796.1 5229.5 5239.7 5241.4 5243.8 5246.0 6087.5 6117.5 6136.3 6188.4 6232.1 5996.4 6087.1 6095.5 6130.0 6133.2 6161.4 6251.4 6254.3 6258.2 6260.3 5591.6 5629.5 5963.7 5984.7 6015.4 5904.8 5965.0 5997.1 6049.9 6082.6 5828.4 5869.9 5885.5 5886.5 5912.9 5577.1 5886.4 5890.5 5893.6 5913.1 5660.1 5781.2 5849.0 5864.5 5954.0 5959.0 5967.3 5985.1 5989.4 5993.9 5681.5 5737.2 5829.9 5840.2 5841.5 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#1] ext.html Cycles:180 Average:66712.92 Median:40565.09 stddev:134728.14 (332.1%) stddev-sans-first:135014.58 10:05:52 INFO - PROCESS | 27353 | Values: 579.5 601.0 623.7 650.8 666.9 35625.5 36280.1 38934.2 38945.2 38946.6 39321.8 47996.5 49139.8 49258.3 53451.7 9398.6 9542.8 9544.1 9549.7 9550.0 8799.6 9058.9 9448.1 9536.3 9549.8 11205.2 11467.5 11473.1 11787.6 11792.8 11373.0 11465.1 11466.4 11466.8 11467.4 11201.7 11269.4 11274.2 11289.2 11289.3 46868.5 47419.3 47423.1 47443.0 47468.3 3828.1 3857.6 4035.6 4182.2 4616.8 35005.3 36879.0 37635.8 37660.6 38283.6 4785.7 4868.3 4920.0 4924.1 5006.3 383108.0 385413.0 390096.0 392830.0 393920.0 40601.6 41807.7 71194.0 72149.0 72172.6 43039.6 43497.8 43648.6 43665.1 43679.3 16392.0 16476.2 16485.2 16494.8 16512.3 13503.9 13604.5 13642.5 13662.2 13693.0 9212.8 9429.8 9617.8 9710.6 9915.0 3746.3 3779.5 3794.4 3797.2 3808.4 1055.6 1071.3 1075.4 1178.9 1217.2 35530.0 35750.5 36042.3 37050.1 38649.8 1092.0 1092.3 1122.4 1186.3 1211.3 18583.7 18656.4 18845.7 18867.0 18952.6 579678.6 585217.0 587220.0 587906.0 588674.0 66889.7 67388.0 67396.0 67422.7 67429.0 1280.8 1311.2 1340.3 1357.6 1441.4 33070.5 34580.0 34893.0 35301.0 35420.5 60132.4 61087.7 61186.7 61198.1 61250.7 524188.0 524861.0 526233.0 526806.0 529223.0 32108.7 33200.2 33211.3 33217.7 33234.0 53849.0 53960.0 54324.0 54786.2 56326.2 45520.3 47145.3 47803.8 47967.5 48661.0 45288.0 47064.8 47470.5 47502.8 48499.0 45073.3 46139.5 46400.8 46597.3 46846.0 38763.8 40528.6 40870.6 41066.4 41157.8 30338.4 30443.5 30463.4 30595.0 30786.0 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#2] jquery.html Cycles:180 Average:30200.14 Median:24205.90 stddev:83464.34 (344.8%) stddev-sans-first:83668.47 10:05:52 INFO - PROCESS | 27353 | Values: 389.7 411.6 427.6 430.2 443.0 14679.5 16314.8 20190.9 20517.3 21778.2 20244.4 20265.9 20583.0 20781.5 20842.8 5833.3 5849.6 6007.7 6037.9 6041.7 4423.7 5905.4 5941.8 5974.7 5976.7 4563.1 4570.2 6672.8 6682.7 6727.5 6470.1 6635.0 6717.4 6722.7 6731.4 5917.6 5919.4 5924.8 5928.6 5931.6 23693.9 24187.2 24224.6 24316.9 24364.6 2598.0 2631.6 2696.1 2793.4 2940.7 15423.3 15482.3 15523.8 15884.8 16327.8 2026.4 2048.3 2050.4 2069.5 2143.9 87590.6 88064.0 88888.6 89952.0 90299.5 10590.4 10614.4 10641.7 11050.0 11489.6 16111.6 16118.1 16150.8 16161.5 16173.7 8443.2 8731.7 8842.4 8947.4 9027.3 8559.1 8681.7 8702.0 8834.5 8897.4 6795.2 6855.7 6894.4 6923.6 6925.0 2005.7 2016.2 2025.8 2042.2 2054.5 966.2 1039.1 1041.6 1069.8 1125.3 20386.7 20799.5 20953.6 21060.0 21064.9 1036.9 1039.9 1040.3 1043.2 1046.8 11550.7 11861.6 11950.0 11971.9 12036.5 490455.0 502218.0 505670.0 517178.0 518460.0 86482.0 87396.6 87672.6 88140.0 88743.6 1092.3 1104.2 1130.0 1133.4 1150.6 17969.8 18088.7 18176.6 18305.1 18314.7 44135.0 44355.3 44381.6 44626.8 44788.3 56505.7 58512.7 59908.0 59960.4 60887.4 8201.0 8423.9 8509.2 8651.0 8739.0 10316.5 13686.4 13924.9 13934.4 14411.3 11842.8 12101.0 12143.8 12271.8 12563.8 12118.4 12167.6 12236.9 12383.0 12676.5 11339.4 11825.0 11951.2 11982.7 12367.3 8622.3 8651.3 8666.1 8679.9 8701.6 10092.5 11544.5 11651.2 11779.9 11903.8 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#3] mootools.html Cycles:180 Average:6392.16 Median:479.87 stddev:3694.22 (769.8%) stddev-sans-first:3685.77 10:05:52 INFO - PROCESS | 27353 | Values: 1431.2 1504.4 1508.3 1668.4 1842.8 8183.3 9307.3 9709.2 9712.4 9949.9 9687.1 9837.7 9843.6 9852.1 9854.1 2569.6 2591.5 2592.8 2593.9 2596.5 2492.1 2550.3 2550.6 2551.4 2554.0 2472.1 2498.5 2535.3 2536.8 2540.0 2463.4 2483.2 2487.9 2491.1 2497.5 2447.0 2473.1 2478.3 2482.6 2484.1 9112.7 9593.8 9724.8 9796.7 9924.4 5823.0 5976.3 5989.2 5993.0 6007.8 3654.9 3834.1 3845.0 3900.4 3922.5 1333.4 1336.2 1338.9 1370.1 1381.7 14106.0 14209.1 14210.1 14263.6 14288.4 5048.6 5075.4 5115.6 5181.5 5208.2 10902.6 10953.6 10969.5 10975.8 10981.1 5951.5 5957.1 5962.3 5966.9 5971.3 4742.4 4890.4 5023.5 5537.5 5554.2 3998.9 4102.3 4147.5 4191.8 4206.1 1218.9 1219.9 1222.8 1229.6 1252.1 887.9 1022.4 1033.1 1036.2 1039.9 6381.9 6594.1 6690.8 6756.7 6805.0 476.8 483.0 485.8 532.4 536.3 4496.2 4501.5 4558.3 4568.5 4734.2 11562.6 12039.9 12066.9 12074.3 12081.3 11808.7 11886.4 12013.2 12142.2 12162.7 8904.2 9016.3 9027.9 9096.5 9104.7 6353.2 6396.1 6406.0 6522.2 6545.9 10840.2 11026.8 11030.3 11054.1 11189.6 11004.6 11177.7 11285.5 11321.2 11332.9 8669.7 8787.7 8877.2 8894.9 8928.7 9447.3 9611.5 9723.8 9734.1 9734.3 8514.9 8546.4 8600.0 8710.1 8791.5 8144.3 8353.6 8385.9 8416.8 8524.5 7506.9 7693.1 7750.7 7753.0 7767.0 5588.7 5609.2 5649.7 5689.1 5758.4 5866.5 5936.2 5943.4 5965.3 6019.3 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#4] prototype.html Cycles:180 Average:4726.80 Median:5212.84 stddev:1361.58 (26.1%) stddev-sans-first:1325.19 10:05:52 INFO - PROCESS | 27353 | Values: 350.3 351.6 359.1 360.4 363.6 5583.7 5600.5 5610.6 5640.4 5651.8 5489.5 5559.3 5564.3 5577.3 5589.5 3829.2 4133.6 4293.3 4356.1 4370.6 4366.3 4366.7 4380.6 4382.8 4391.5 4365.4 4389.6 4407.1 4409.6 4442.6 4138.8 4320.8 4357.8 4419.4 4439.8 3787.9 3797.5 3802.0 3807.2 3816.8 5379.6 5410.6 5418.7 5435.7 5492.3 4800.0 4918.8 4927.4 4928.4 4947.4 5750.3 5758.5 5767.8 5768.4 5823.5 4134.9 4217.3 4231.3 4236.2 4237.5 5666.8 5798.8 5959.9 6053.5 6065.3 4170.8 4249.7 4293.8 4305.0 4330.8 4358.9 4360.6 4380.7 4384.9 4387.7 4869.3 4893.9 4989.2 5000.5 5013.4 5738.4 5775.8 5794.0 5797.9 5824.3 1474.2 1476.8 1494.6 1504.9 1509.9 927.6 946.2 950.8 954.3 979.5 4969.2 4971.9 4987.2 4996.4 5022.3 5217.3 5221.5 5229.9 5230.0 5237.8 4677.3 4971.8 4982.5 4982.7 5011.7 2776.8 2804.8 2810.5 2823.1 2838.0 5307.9 5380.7 5431.4 5444.8 5464.6 5043.4 5192.9 5265.9 5294.9 5299.2 5325.5 5340.3 5343.7 5380.2 5406.4 5178.2 5178.9 5179.8 5182.7 5208.3 4994.0 5122.7 5151.0 5167.5 5220.2 5356.1 5863.6 5979.4 5994.9 6084.5 4262.0 4269.1 4292.8 4300.6 4329.4 5855.4 6079.4 6104.9 6111.8 6114.4 5807.7 5829.4 5835.8 5867.3 5885.0 5793.4 5796.3 5847.6 5861.7 5861.8 5715.7 5751.8 5802.0 5822.2 5849.4 5876.4 5881.3 5886.9 5889.9 5948.0 5492.6 5575.8 5675.3 5718.0 5794.3 10:05:52 INFO - PROCESS | 27353 | 10:05:52 INFO - PROCESS | 27353 | [#5] yui.html Cycles:180 Average:22292.02 Median:4409.47 stddev:31619.33 (717.1%) stddev-sans-first:31666.85 10:05:52 INFO - PROCESS | 27353 | Values: 799.7 844.5 866.9 892.3 894.0 15965.8 16612.2 16718.7 16782.6 16808.4 15476.0 15716.4 15725.4 15871.8 16513.3 729.9 747.9 848.7 850.6 877.0 877.2 877.4 878.2 881.3 882.4 915.2 917.7 918.0 918.6 919.8 913.4 914.3 915.1 915.8 916.3 673.2 673.3 674.5 677.2 677.5 15646.9 15651.3 15671.5 15672.8 15683.2 16331.2 16670.3 16683.2 16827.9 17849.0 12937.9 13032.3 13106.6 13195.5 13539.2 4174.3 4258.1 4271.2 4272.4 4336.5 87140.1 87786.1 87807.0 89769.0 90020.0 13326.0 13473.7 13535.5 13537.4 13605.7 24920.5 25216.7 25220.4 25334.2 25340.7 9026.3 9245.0 9278.0 9292.1 9382.8 4881.7 4974.5 5181.3 5271.8 5383.3 3664.6 3958.0 3960.9 3965.1 3973.7 632.9 634.1 636.5 648.9 654.8 592.5 619.7 643.3 703.1 750.4 9013.7 9903.3 10197.6 10353.2 10401.7 697.7 710.3 716.9 748.7 752.8 4482.4 4836.6 4881.0 4944.3 4980.2 78042.2 79386.2 116207.0 116380.4 140946.0 113898.0 116361.4 118354.4 119641.4 120359.0 55608.0 86530.6 95578.5 97271.0 99533.5 9157.2 9482.2 9487.9 9507.9 9529.4 50313.0 58843.0 62709.4 62719.0 62732.4 52896.5 55175.4 68750.0 80749.0 80961.6 14480.7 14559.8 14751.4 15115.5 15288.6 17242.6 17520.6 17589.8 17645.6 18717.1 15410.8 15588.2 16178.4 16915.4 16934.2 14607.5 14848.6 15683.8 15790.0 15885.1 14108.1 14868.3 15640.9 16451.9 16954.2 12123.3 12500.0 12560.1 12910.8 13185.9 11599.9 13116.7 13149.4 13212.5 13417.5 10:05:52 INFO - PROCESS | 27353 | -------- Summary: end -------- 10:05:52 INFO - PROCESS | 27353 | 10:05:53 INFO - TEST-INFO | 27353: exit 0 10:05:53 INFO - TEST-OK | dromaeo_css | took 1112964ms 10:05:53 INFO - TEST-START | kraken 10:05:53 INFO - operating with platform_type : linux_ 10:05:53 INFO - Initialising browser for kraken test... 10:05:53 INFO - TEST-INFO | started process 27657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplVzf2H/profile http://localhost:33248/getInfo.html) 10:05:57 INFO - PROCESS | 27657 | __metrics Screen width/height:1600/1200 10:05:57 INFO - PROCESS | 27657 | colorDepth:24 10:05:57 INFO - PROCESS | 27657 | Browser inner width/height: 1024/697 10:05:57 INFO - PROCESS | 27657 | __metrics 10:05:57 INFO - PROCESS | 27657 | 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" 10:05:57 INFO - PROCESS | 27657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:58 INFO - PROCESS | 27657 | console.error: PushService: 10:05:58 INFO - PROCESS | 27657 | stateChangeProcessEnqueue: Error transitioning state 10:05:58 INFO - PROCESS | 27657 | UnknownError 10:05:58 INFO - TEST-INFO | 27657: exit 0 10:05:58 INFO - Browser initialized. 10:05:58 INFO - Running cycle 1/1 for kraken test... 10:05:58 INFO - TEST-INFO | started process 27748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplVzf2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:10 INFO - PROCESS | 27748 | RSS: Main: 142618624 10:06:10 INFO - PROCESS | 27748 | 10:06:13 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33248/tests/kraken/driver.html?testName=audio-beat-detection) 10:06:14 INFO - PROCESS | 27748 | RSS: Main: 186564608 10:06:14 INFO - PROCESS | 27748 | 10:06:16 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33248/tests/kraken/driver.html?testName=audio-dft) 10:06:17 INFO - PROCESS | 27748 | RSS: Main: 174309376 10:06:17 INFO - PROCESS | 27748 | 10:06:19 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33248/tests/kraken/driver.html?testName=audio-fft) 10:06:20 INFO - PROCESS | 27748 | RSS: Main: 265265152 10:06:20 INFO - PROCESS | 27748 | 10:06:22 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33248/tests/kraken/driver.html?testName=audio-oscillator) 10:06:23 INFO - PROCESS | 27748 | RSS: Main: 171896832 10:06:23 INFO - PROCESS | 27748 | 10:06:25 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:25 INFO - PROCESS | 27748 | RSS: Main: 173592576 10:06:25 INFO - PROCESS | 27748 | 10:06:28 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33248/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:29 INFO - PROCESS | 27748 | RSS: Main: 208977920 10:06:29 INFO - PROCESS | 27748 | 10:06:32 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33248/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:33 INFO - PROCESS | 27748 | RSS: Main: 207867904 10:06:33 INFO - PROCESS | 27748 | 10:06:36 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33248/tests/kraken/driver.html?testName=json-parse-financial) 10:06:36 INFO - PROCESS | 27748 | RSS: Main: 208236544 10:06:36 INFO - PROCESS | 27748 | 10:06:38 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:38 INFO - PROCESS | 27748 | RSS: Main: 170139648 10:06:38 INFO - PROCESS | 27748 | 10:06:40 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:41 INFO - PROCESS | 27748 | RSS: Main: 176766976 10:06:41 INFO - PROCESS | 27748 | 10:06:43 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:43 INFO - PROCESS | 27748 | RSS: Main: 186949632 10:06:43 INFO - PROCESS | 27748 | 10:06:46 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:46 INFO - PROCESS | 27748 | RSS: Main: 194879488 10:06:46 INFO - PROCESS | 27748 | 10:06:49 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:50 INFO - PROCESS | 27748 | RSS: Main: 192106496 10:06:50 INFO - PROCESS | 27748 | 10:06:51 INFO - PROCESS | 27748 | Cycle 1(1): loaded http://localhost:33248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33248/tests/kraken/driver.html?testName=ai-astar) 10:06:52 INFO - PROCESS | 27748 | RSS: Main: 243404800 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | __start_tp_report 10:06:52 INFO - PROCESS | 27748 | _x_x_mozilla_page_load 10:06:52 INFO - PROCESS | 27748 | _x_x_mozilla_page_load_details 10:06:52 INFO - PROCESS | 27748 | |i|pagename|runs| 10:06:52 INFO - PROCESS | 27748 | |0;ai-astar;111;111;110;111;112;112;111;110;111;111 10:06:52 INFO - PROCESS | 27748 | |1;audio-beat-detection;145;117;116;157;117;120;116;116;145;127 10:06:52 INFO - PROCESS | 27748 | |2;audio-dft;161;161;161;162;169;161;161;161;162;160 10:06:52 INFO - PROCESS | 27748 | |3;audio-fft;75;76;76;106;75;76;75;76;98;76 10:06:52 INFO - PROCESS | 27748 | |4;audio-oscillator;81;82;120;82;82;81;100;82;81;115 10:06:52 INFO - PROCESS | 27748 | |5;imaging-gaussian-blur;116;117;116;116;116;116;116;116;117;117 10:06:52 INFO - PROCESS | 27748 | |6;imaging-darkroom;147;145;145;145;147;146;145;145;146;145 10:06:52 INFO - PROCESS | 27748 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;94 10:06:52 INFO - PROCESS | 27748 | |8;json-parse-financial;49;59;48;49;56;49;49;50;48;48 10:06:52 INFO - PROCESS | 27748 | |9;json-stringify-tinderbox;58;58;58;57;59;58;58;58;58;58 10:06:52 INFO - PROCESS | 27748 | |10;stanford-crypto-aes;72;73;74;73;74;74;72;74;76;78 10:06:52 INFO - PROCESS | 27748 | |11;stanford-crypto-ccm;122;130;133;123;131;126;137;121;167;134 10:06:52 INFO - PROCESS | 27748 | |12;stanford-crypto-pbkdf2;157;153;151;152;155;152;156;154;153;152 10:06:52 INFO - PROCESS | 27748 | |13;stanford-crypto-sha256-iterative;62;61;66;61;62;66;61;62;61;60 10:06:52 INFO - PROCESS | 27748 | __end_tp_report 10:06:52 INFO - PROCESS | 27748 | __start_cc_report 10:06:52 INFO - PROCESS | 27748 | _x_x_mozilla_cycle_collect,1586 10:06:52 INFO - PROCESS | 27748 | __end_cc_report 10:06:52 INFO - PROCESS | 27748 | __startTimestamp1479751612002__endTimestamp 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | ------- Summary: start ------- 10:06:52 INFO - PROCESS | 27748 | Number of tests: 14 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:06:52 INFO - PROCESS | 27748 | Values: 111.0 111.0 110.0 111.0 112.0 112.0 111.0 110.0 111.0 111.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:123.50 stddev:15.48 (12.5%) stddev-sans-first:15.08 10:06:52 INFO - PROCESS | 27748 | Values: 145.0 117.0 116.0 157.0 117.0 120.0 116.0 116.0 145.0 127.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.00 stddev:2.56 (1.6%) stddev-sans-first:2.69 10:06:52 INFO - PROCESS | 27748 | Values: 161.0 161.0 161.0 162.0 169.0 161.0 161.0 161.0 162.0 160.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.29 (14.9%) stddev-sans-first:11.77 10:06:52 INFO - PROCESS | 27748 | Values: 75.0 76.0 76.0 106.0 75.0 76.0 75.0 76.0 98.0 76.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:81.50 stddev:15.35 (18.8%) stddev-sans-first:15.88 10:06:52 INFO - PROCESS | 27748 | Values: 81.0 82.0 120.0 82.0 82.0 81.0 100.0 82.0 81.0 115.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:06:52 INFO - PROCESS | 27748 | Values: 116.0 117.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 117.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 10:06:52 INFO - PROCESS | 27748 | Values: 147.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 146.0 145.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:06:52 INFO - PROCESS | 27748 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:49.00 stddev:3.81 (7.8%) stddev-sans-first:4.00 10:06:52 INFO - PROCESS | 27748 | Values: 49.0 59.0 48.0 49.0 56.0 49.0 49.0 50.0 48.0 48.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:06:52 INFO - PROCESS | 27748 | Values: 58.0 58.0 58.0 57.0 59.0 58.0 58.0 58.0 58.0 58.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.83 (2.5%) stddev-sans-first:1.79 10:06:52 INFO - PROCESS | 27748 | Values: 72.0 73.0 74.0 73.0 74.0 74.0 72.0 74.0 76.0 78.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.00 stddev:13.32 (10.1%) stddev-sans-first:13.58 10:06:52 INFO - PROCESS | 27748 | Values: 122.0 130.0 133.0 123.0 131.0 126.0 137.0 121.0 167.0 134.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.50 Median:153.50 stddev:1.96 (1.3%) stddev-sans-first:1.62 10:06:52 INFO - PROCESS | 27748 | Values: 157.0 153.0 151.0 152.0 155.0 152.0 156.0 154.0 153.0 152.0 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - PROCESS | 27748 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:2.10 (3.4%) stddev-sans-first:2.22 10:06:52 INFO - PROCESS | 27748 | Values: 62.0 61.0 66.0 61.0 62.0 66.0 61.0 62.0 61.0 60.0 10:06:52 INFO - PROCESS | 27748 | -------- Summary: end -------- 10:06:52 INFO - PROCESS | 27748 | 10:06:52 INFO - TEST-INFO | 27748: exit 0 10:06:52 INFO - TEST-OK | kraken | took 59322ms 10:06:52 INFO - SUITE-END | took 1172s 10:06:53 INFO - Completed test suite (00:19:32) 10:06:53 INFO - javascript benchmark 10:06:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.703438173374, 3160.4785210440273, 3170.461021626323, 3190.505471651892, 3205.27881226724, 5566.721663916803, 5643.379228284885, 5667.886642267152, 5678.744456499458, 5704.315482142144, 5644.74598643061, 5711.514521265697, 5714.799982000631, 5723.112917497794, 5724.742386592603, 5141.280220769096, 5175.611829112831, 5191.5846732261325, 5198.870028249286, 5246.0, 5048.949510504903, 5061.215511595708, 5255.369355677324, 5260.974110048542, 5261.552768014723, 5022.924656130161, 5073.0, 5109.2591574221715, 5120.155174396239, 5148.845534633967, 5098.643094983353, 5107.897842043157, 5163.741812909339, 5171.948280517222, 5196.194589838581, 4929.088118698017, 5054.1660625996665, 5073.416557095944, 5108.66793658411, 5128.512791284859, 5473.8357849264585, 5485.725713714299, 5491.121420572729, 5511.614187006911, 5542.334919809648, 5893.882122357529, 5901.940980590182, 5982.192404025488, 5986.700664966777, 5989.251343582052, 5906.173135760954, 6032.758689652409, 6048.516118710492, 6054.091886217103, 6058.1215723719815, 5550.361708403505, 5572.331320241557, 5619.0, 5621.01632214365, 5624.29696287964, 6199.659018753921, 6209.316975132731, 6209.9068513972325, 6213.1922850029205, 6214.502839772807, 5759.366469688414, 5954.85112872173, 5966.134910438049, 5969.880602388015, 5970.880582388415, 5890.528757699374, 5964.7315870785915, 6034.637921724623, 6035.245594300713, 6068.726907289182, 6020.337762846083, 6037.426444487766, 6042.546808989343, 6046.486048685823, 6047.0, 6015.759369625253, 6069.575129740964, 6073.362296958844, 6076.3316035236085, 6093.908591371133, 4424.093060922568, 4498.212812757754, 4536.432945881765, 4568.634509239253, 4594.310853372021, 4087.0395457067566, 4089.479203075824, 4090.4682391288943, 4099.631033206966, 4110.506739191316, 5724.055530837365, 5736.368999410061, 5736.770529178786, 5739.0, 5739.741711622987, 5895.970520147372, 5972.940270597325, 5975.282966044103, 6022.066579680157, 6102.145699602059, 5737.942620573825, 5758.74085666146, 5761.683107429131, 5770.682612456355, 5796.101604251347, 5229.50319719626, 5239.73801309933, 5241.397239317451, 5243.842684719464, 5246.0, 6087.4521293083835, 6117.522930757244, 6136.3046386708, 6188.44304012641, 6232.065190221412, 5996.400359963969, 6087.086936959491, 6095.512359011357, 6130.049842274455, 6133.202683651097, 6161.383861613803, 6251.374862513894, 6254.28075771274, 6258.155149055002, 6260.311365749672, 5591.608587398843, 5629.4652008059165, 5963.674167074931, 5984.700764961647, 6015.39846015395, 5904.763809447574, 5965.0, 5997.070454079625, 6049.879002420015, 6082.574219804571, 5828.358880523224, 5869.941300586939, 5885.47030767233, 5886.470217680258, 5912.911306330322, 5577.051901176728, 5886.41135886425, 5890.52875769946, 5893.557983151195, 5913.05391137416, 5660.122680984454, 5781.248437703071, 5849.034909240098, 5864.472197502245, 5954.047352423591, 5959.0, 5967.343592204941, 5985.132155837467, 5989.431004054608, 5993.880122397615, 5681.488666020078, 5737.196792449144, 5829.854253643693, 5840.1531777892815, 5841.532677385884], "value": 5544.647132576624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5189992306383, 600.9789657361991, 623.694389749023, 650.8437974886026, 666.9333066693329, 35625.46561801572, 36280.09299767507, 38934.22131557374, 38945.221095578105, 38946.61053389472, 39321.80339098308, 47996.52003479964, 49139.75430122853, 49258.261126083045, 53451.73274133634, 9398.577064032117, 9542.761430964247, 9544.093311135432, 9549.665761698341, 9550.0, 8799.560021998874, 9058.864117038249, 9448.149666530011, 9536.332456728032, 9549.761255968588, 11205.159613029015, 11467.483963221675, 11473.082153427706, 11787.646370608896, 11792.823107653392, 11373.0, 11465.140114491447, 11466.369349685763, 11466.827997580001, 11467.426628668616, 11201.71995700114, 11269.43652817364, 11274.210805243636, 11289.209755317132, 11289.322640641587, 46868.531314686756, 47419.28871066937, 47423.051538969376, 47443.0, 47468.28797568005, 3828.119532507511, 3857.614238576148, 4035.5762644922156, 4182.163567286555, 4616.838410655611, 35005.29989400223, 36879.0, 37635.811820940995, 37660.62339376626, 38283.61716382856, 4785.736784476852, 4868.294097355863, 4919.950800492021, 4924.064427758714, 5006.3241462402475, 383108.0, 385413.0, 390096.0, 392830.0, 393920.03039984906, 40601.593984060375, 41807.70057646859, 71194.0, 72149.0, 72172.63913680398, 43039.56960430418, 43497.78251108788, 43648.56351436509, 43665.126697466505, 43679.344809827875, 16392.016479011298, 16476.176191190392, 16485.17574121289, 16494.83505164933, 16512.25694843735, 13503.86496135026, 13604.523841665494, 13642.52251171224, 13662.180269183682, 13693.0, 9212.769680758034, 9429.764255893657, 9617.759556011015, 9710.611575537041, 9915.0, 3746.250749850041, 3779.508663873734, 3794.3739283017994, 3797.1963317424, 3808.3906574947873, 1055.621607907709, 1071.2822408985999, 1075.4031512510476, 1178.9410529473491, 1217.245307909102, 35530.0, 35750.45333386224, 36042.27915441676, 37050.07374815597, 38649.80675096607, 1091.9945400272948, 1092.3445932440472, 1122.3826895207767, 1186.3119390753343, 1211.3337664284609, 18583.72124418135, 18656.440306790817, 18845.717314240297, 18867.0, 18952.620947581247, 579678.6096417115, 585217.0, 587220.0, 587906.0, 588674.0, 66889.66555167291, 67388.0, 67396.0, 67422.66288668526, 67429.0, 1280.750253700538, 1311.2329287366997, 1340.3231368159018, 1357.6198664373992, 1441.4234306277574, 33070.5039424404, 34580.0, 34893.0, 35301.0, 35420.46869296911, 60132.39867601268, 61087.69456152691, 61186.69406652938, 61198.08202877049, 61250.69374653098, 524188.0, 524861.0, 526233.0, 526806.0, 529223.0, 32108.67891321057, 33200.1699957503, 33211.33577328488, 33217.667823321455, 33234.0, 53849.038302893714, 53960.0, 54324.0, 54786.17820732772, 56326.155107672595, 45520.317195241434, 47145.34991275426, 47803.76098119487, 47967.520324797704, 48661.0, 45287.978969171134, 47064.7646761764, 47470.52529474661, 47502.76248618735, 48499.0, 45073.32390014218, 46139.538604613525, 46400.767996159804, 46597.3010404851, 46846.0, 38763.80618096892, 40528.59471405248, 40870.59129408668, 41066.38400424056, 41157.794211028755, 30338.393232135677, 30443.54334685026, 30463.390732185675, 30595.0, 30786.0], "value": 21150.291185921622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6921432068666, 411.63775877228056, 427.63009996353156, 430.2212994479992, 442.9645628349732, 14679.48621798236, 16314.755278670815, 20190.89904550479, 20517.33010897208, 21778.237761678345, 20244.39266821994, 20265.898670506627, 20583.0, 20781.48046298843, 20842.791572084276, 5833.329167145769, 5849.64902105875, 6007.729652165663, 6037.879242415149, 6041.697915104227, 4423.734575925455, 5905.379935106795, 5941.792037278696, 5974.6713930733795, 5976.701164941757, 4563.06457176278, 4570.200214962385, 6672.799816005503, 6682.6658667066695, 6727.4618030557685, 6470.0618410330235, 6635.004749287597, 6717.395434410902, 6722.731090756389, 6731.427828634572, 5917.644941303535, 5919.437653422918, 5924.822255332347, 5928.614640048383, 5931.6441013539325, 23693.88153059241, 24187.153449629353, 24224.636630450557, 24316.878415607986, 24364.634530482057, 2598.0, 2631.6447279617196, 2696.0968075694664, 2793.3714914144357, 2940.7059294070636, 15423.305951232222, 15482.30329635169, 15523.844761552353, 15884.84115158845, 16327.83672163275, 2026.3515674984012, 2048.262625454835, 2050.4156315450027, 2069.461939895623, 2143.906607630104, 87590.56204718935, 88064.0, 88888.5555572231, 89952.0, 90299.54850225706, 10590.364578125183, 10614.416207108528, 10641.73395665099, 11050.0, 11489.597864074718, 16111.597210069842, 16118.113503757406, 16150.75773863393, 16161.515154545383, 16173.676526469404, 8443.240108390275, 8731.738047858575, 8842.425242359355, 8947.373683842068, 9027.322950778718, 8559.058503564604, 8681.696140635047, 8702.0, 8834.514101724339, 8897.377183597215, 6795.18457785059, 6855.6572171391235, 6894.448444124458, 6923.584584924921, 6925.0, 2005.7292265543965, 2016.183445704492, 2025.7771645119026, 2042.2239548971593, 2054.496648321171, 966.1739212972948, 1039.095986491757, 1041.5885725138528, 1069.8127827630133, 1125.307935619588, 20386.69419958702, 20799.480012999797, 20953.580928381347, 21060.0, 21064.89467552683, 1036.9481525923673, 1039.9064084232455, 1040.266612038511, 1043.1967385113421, 1046.7540128069897, 11550.711232219093, 11861.584844530573, 11950.0, 11971.940140299243, 12036.45835937385, 490455.0, 502218.0, 505670.0, 517178.0, 518460.0, 86482.0, 87396.56301718578, 87672.56163719269, 88140.0, 88743.55628221818, 1092.3009274064445, 1104.216006635282, 1129.9661010169707, 1133.3596517967487, 1150.6375491720082, 17969.82030179734, 18088.72866906971, 18176.636467270844, 18305.084745762924, 18314.71796974199, 44135.0, 44355.33466998062, 44381.556184437744, 44626.77686611546, 44788.32817507675, 56505.71747141238, 58512.707436462544, 59908.0, 59960.400395997225, 60887.39112608817, 8201.0, 8423.873641895254, 8509.191626795444, 8651.0, 8738.956305218433, 10316.48417579103, 13686.384112715152, 13924.930375348058, 13934.442622294995, 14411.279436028366, 11842.822357664814, 12101.026092930708, 12143.817842732542, 12271.75456490883, 12563.811542827048, 12118.394080296126, 12167.634970950885, 12236.938815306223, 12383.0, 12676.492940282655, 11339.433028348385, 11825.0, 11951.163418560966, 11982.700432489257, 12367.319797410868, 8622.26710729595, 8651.264642505457, 8666.133386661284, 8679.86980195285, 8701.608427620899, 10092.495375231356, 11544.480498377761, 11651.184417090722, 11779.882201178221, 11903.821442678194], "value": 9849.078366221831, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.219985108116, 1504.3832028868167, 1508.3212554350541, 1668.3743596151444, 1842.8433583145431, 8183.304419124374, 9307.255419566436, 9709.174720148796, 9712.368696034753, 9949.900500995005, 9687.0797274259, 9837.65568205113, 9843.606255749779, 9852.113309802135, 9854.113129818315, 2569.6402503649506, 2591.468748906479, 2592.8055395845295, 2593.922182334533, 2596.480703859226, 2492.102842976527, 2550.3369124027795, 2550.6429099926027, 2551.400420901087, 2554.0422341621893, 2472.09768434521, 2498.537770512452, 2535.290118766748, 2536.759007894247, 2539.9746002539923, 2463.4210960424284, 2483.1681386735463, 2487.8507289562594, 2491.0533997080993, 2497.5254701606727, 2447.0, 2473.060237109905, 2478.2689106713383, 2482.640017197496, 2484.0560586977012, 9112.681056163068, 9593.760155996086, 9724.805503889882, 9796.65711700087, 9924.404535727806, 5823.0, 5976.342602313742, 5989.161517387569, 5993.041113421831, 6007.849803754941, 3654.908627284339, 3834.118152824866, 3844.9807750961345, 3900.3759398496386, 3922.5489068756888, 1333.3599872061466, 1336.1849271944204, 1338.886194673454, 1370.0820450298324, 1381.7443772902045, 14106.012579119466, 14209.147451152963, 14210.14739115646, 14263.643408914757, 14288.428462861577, 5048.646594738407, 5075.416327122428, 5115.565176959925, 5181.5077567631015, 5208.218767184952, 10902.563897444172, 10953.616623418142, 10969.506372213269, 10975.780484390427, 10981.121510279318, 5951.464368206795, 5957.076653118774, 5962.284525856839, 5966.85082872923, 5971.253593300838, 4742.383490146328, 4890.364252647133, 5023.49765023502, 5537.473939975695, 5554.222408862763, 3998.8600398985895, 4102.323116685773, 4147.52303485103, 4191.769452680071, 4206.053637931441, 1218.865924748277, 1219.9329036903055, 1222.773786849418, 1229.6495498782983, 1252.0984890878735, 887.8890138732659, 1022.4325499347784, 1033.1270076785104, 1036.2435422141878, 1039.8856125826153, 6381.936180638134, 6594.10979517759, 6690.762208991352, 6756.729730810713, 6805.0, 476.780680886789, 482.95653391194963, 485.83481616250646, 532.3824363738123, 536.3028063517412, 4496.19068567661, 4501.504834468205, 4558.270676691714, 4568.451785785727, 4734.242521196592, 11562.595309164139, 12039.939800300943, 12066.939665301617, 12074.27554346742, 12081.335526546125, 11808.704782380337, 11886.405679716152, 12013.159078864395, 12142.150049496628, 12162.695932601579, 8904.243139333099, 9016.323775716848, 9027.909720902708, 9096.499692516843, 9104.726858194264, 6353.205849268841, 6396.10454536356, 6406.0, 6522.15212022434, 6545.901811472927, 10840.186985975926, 11026.779464410827, 11030.338179709242, 11054.11567074616, 11189.552417903193, 11004.614838480615, 11177.66467005991, 11285.548578056785, 11321.207515474167, 11332.886671133183, 8669.6965606206, 8787.736367908972, 8877.20105190536, 8894.866577001221, 8928.687495937871, 9447.291453140904, 9611.471369074769, 9723.756906077122, 9734.075262850018, 9734.318597698093, 8514.91485085166, 8546.359023073419, 8599.95700021496, 8710.085441028854, 8791.5164665944, 8144.30773384269, 8353.624086915981, 8385.916140838513, 8416.789580260542, 8524.531150786766, 7506.924930750841, 7693.115291741521, 7750.728724494616, 7752.992111025531, 7767.0, 5588.748506317144, 5609.214709940693, 5649.71751412436, 5689.118186681071, 5758.395368486249, 5866.472017518444, 5936.228290322403, 5943.435373639497, 5965.254343207099, 6019.277686677627], "value": 4994.178610495465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3431066749844, 351.5500159795461, 359.08970759125623, 360.44311538672747, 363.5746176972941, 5583.6928968906695, 5600.467955544222, 5610.579206559504, 5640.4359564043625, 5651.830445086649, 5489.505944465007, 5559.277293951791, 5564.33228012638, 5577.326801959416, 5589.524890384322, 3829.215010922768, 4133.586641335865, 4293.270144075499, 4356.106998065389, 4370.584794444522, 4366.279563871974, 4366.694331396803, 4380.58384453478, 4382.838547784823, 4391.516933137353, 4365.4106695596165, 4389.604935555815, 4407.118576284756, 4409.581089796464, 4442.62237709795, 4138.8344466221315, 4320.82716691332, 4357.760323182224, 4419.4033805436175, 4439.7558134302435, 3787.9393769744515, 3797.544294684628, 3802.0, 3807.200487897545, 3816.8473261069526, 5379.623426360156, 5410.6202918255985, 5418.701971391612, 5435.701036442994, 5492.258545096441, 4799.984006717187, 4918.778654960535, 4927.384076990376, 4928.408590969071, 4947.437844751809, 5750.338711048241, 5758.48173664368, 5767.769289228426, 5768.394318596529, 5823.5341172706085, 4134.883581433026, 4217.283061879488, 4231.344141658048, 4236.152769446092, 4237.533871274158, 5666.801661941812, 5798.797042103548, 5959.851003724898, 6053.485453736438, 6065.332813390523, 4170.77060761655, 4249.660027197817, 4293.763842988666, 4304.978475107667, 4330.826766929351, 4358.869233922987, 4360.607545320873, 4380.69335146543, 4384.934225986613, 4387.692861499664, 4869.269609558594, 4893.877653058702, 4989.151844186425, 5000.549950504472, 5013.3983921928875, 5738.368779434259, 5775.826725198251, 5794.0439827428845, 5797.913031304533, 5824.301083869963, 1474.1818290848469, 1476.7964109250927, 1494.6338147154017, 1504.8946573739734, 1509.9094054356774, 927.6057675487891, 946.2099147212155, 950.7718147644515, 954.3319676226669, 979.5298256836616, 4969.229769385751, 4971.850844474671, 4987.177115775857, 4996.375453068366, 5022.271770593244, 5217.34783152106, 5221.451747566451, 5229.9341760005345, 5229.9603154769675, 5237.764300606482, 4677.298405239241, 4971.831619569398, 4982.526659967298, 4982.725950072709, 5011.69462047455, 2776.8333899966065, 2804.8036637435594, 2810.4800611886867, 2823.110720123155, 2838.0, 5307.867303317448, 5380.677159370451, 5431.429699881455, 5444.7822087116865, 5464.617476776588, 5043.411325432477, 5192.948070519246, 5265.894682106336, 5294.92057619136, 5299.205119232069, 5325.467453254643, 5340.30576025122, 5343.702208050498, 5380.24676545284, 5406.378266499324, 5178.223266510054, 5178.948210517847, 5179.766910489112, 5182.663126896739, 5208.322918020633, 4993.950060499348, 5122.6937131031345, 5151.0, 5167.457416971164, 5220.216967454912, 5356.143017117242, 5863.648181109147, 5979.40205979416, 5994.880102398015, 6084.543659225487, 4262.0, 4269.146170765921, 4292.849750258726, 4300.61294483498, 4329.350597410414, 5855.443732845373, 6079.392060793885, 6104.908426373697, 6111.816645500642, 6114.449699527064, 5807.680577568105, 5829.358770535153, 5835.766569337179, 5867.32525759526, 5885.0, 5793.362730099601, 5796.333421656564, 5847.561432892465, 5861.736221869941, 5861.824145275648, 5715.714214289352, 5751.798687045934, 5802.0, 5822.195119512964, 5849.3858144894175, 5876.382979787061, 5881.2942446906645, 5886.911696324473, 5889.852753681193, 5947.9702601486715, 5492.588055895744, 5575.804846830341, 5675.262215911905, 5718.0, 5794.333651629948], "value": 4298.318466275018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.7280924485674, 844.4595458906301, 866.8743032260327, 892.2549671024694, 894.0165817600638, 15965.84034159658, 16612.169391530406, 16718.749218761714, 16782.580435489104, 16808.411705590308, 15476.0, 15716.371345146208, 15725.449609263678, 15871.84128158718, 16513.33946642133, 729.8503806719636, 747.8504299140167, 848.6987119572556, 850.6469815026757, 877.0308808766317, 877.214892671059, 877.4472082587961, 878.1876763993313, 881.3389957531851, 882.4176043811054, 915.2037727177365, 917.7476194046624, 917.9541022948825, 918.6187732091174, 919.7746552094746, 913.3743385780762, 914.2822884036033, 915.1351972386097, 915.7893684452613, 916.3081873185736, 673.2157037051828, 673.2795908378038, 674.4604316546743, 677.2178134254943, 677.4918810891832, 15646.9217653911, 15651.295691693902, 15671.529854104396, 15672.843271567366, 15683.215839208107, 16331.18344082803, 16670.33318667252, 16683.249253783608, 16827.91586042074, 17849.0, 12937.935310323388, 13032.348382580833, 13106.60680179596, 13195.538156164585, 13539.187648741008, 4174.269502836992, 4258.063226090286, 4271.1671224111315, 4272.4445822042935, 4336.544662810423, 87140.12859871384, 87786.12213877907, 87807.0, 89769.0, 90020.0, 13326.0, 13473.730525389634, 13535.45858165682, 13537.390817413043, 13605.659858503617, 24920.5015899681, 25216.747832521807, 25220.369490762878, 25334.23997280048, 25340.74659253384, 9026.323025773094, 9244.953775231215, 9277.953610231905, 9292.117248861347, 9382.812343753087, 4881.707097574157, 4974.477679843637, 5181.274621552986, 5271.841844744664, 5383.300170977748, 3664.6335366463672, 3958.0, 3960.940585891214, 3965.147493288957, 3973.7417067890497, 632.8639342541376, 634.0552576660834, 636.4780879678619, 648.9448396886318, 654.8101050695341, 592.5022980696236, 619.6870580356981, 643.3074154354067, 703.085988215318, 750.3696894608446, 9013.684521041732, 9903.306768526278, 10197.643082492077, 10353.171746260281, 10401.68794936138, 697.7034760226883, 710.3429327871698, 716.8852983522611, 748.745426554974, 752.8230865746546, 4482.394876691605, 4836.564709176191, 4881.011649905393, 4944.332515110486, 4980.228064649985, 78042.21957780463, 79386.20613793904, 116207.0, 116380.41809790897, 140946.0, 113898.0, 116361.41819290849, 118354.40822795831, 119641.40179299221, 120359.0, 55608.0, 86530.56734716285, 95578.52210739041, 97271.0, 99533.50233248933, 9157.221636161, 9482.241420686467, 9487.857682134636, 9507.904920950701, 9529.428234305964, 50313.0, 58843.0, 62709.372906272176, 62719.0, 62732.37267627448, 52896.471035289156, 55175.44824551864, 68750.0, 80749.0, 80961.59519202367, 14480.710385792436, 14559.781603275747, 14751.409943602135, 15115.54653360357, 15288.617784555476, 17242.568935776704, 17520.649587008444, 17589.824101759332, 17645.647087058445, 18717.06414679288, 15410.768838467207, 15588.22058897028, 16178.433754818525, 16915.407960721317, 16934.15329233558, 14607.488737894122, 14848.62878428048, 15683.843161568238, 15790.0, 15885.126318052618, 14108.082974606617, 14868.256587170814, 15640.921795391405, 16451.91774041122, 16954.237059332114, 12123.272603643809, 12500.0, 12560.12079154487, 12910.80633790475, 13185.934070329587, 11599.88400115988, 13116.737665246832, 13149.408276627384, 13212.471501139848, 13417.530386436429], "value": 8197.142226345633, "unit": "score"}], "name": "dromaeo_css", "value": 7667.889522081044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 116.0, 157.0, 117.0, 120.0, 116.0, 116.0, 145.0, 127.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 169.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 75.0, 76.0, 75.0, 76.0, 98.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 120.0, 82.0, 82.0, 81.0, 100.0, 82.0, 81.0, 115.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 59.0, 48.0, 49.0, 56.0, 49.0, 49.0, 50.0, 48.0, 48.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 72.0, 74.0, 76.0, 78.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 133.0, 123.0, 131.0, 126.0, 137.0, 121.0, 167.0, 134.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 153.0, 151.0, 152.0, 155.0, 152.0, 156.0, 154.0, 153.0, 152.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 66.0, 61.0, 62.0, 66.0, 61.0, 62.0, 61.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1459.2, "alertThreshold": 2.0}]} 10:06:53 INFO - Return code: 0 10:06:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:53 INFO - # TBPL SUCCESS # 10:06:53 INFO - Running post-action listener: _resource_record_post_action 10:06:53 INFO - [mozharness: 2016-11-21 18:06:53.328479Z] Finished run-tests step (success) 10:06:53 INFO - Running post-run listener: _resource_record_post_run 10:06:53 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 316301312; Read time: 64; Write time: 206400 10:06:53 INFO - TinderboxPrint: CPU usage
13.0% 10:06:53 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 64 10:06:53 INFO - TinderboxPrint: I/O write bytes / time
316,301,312 / 206,400 10:06:53 INFO - TinderboxPrint: CPU idle
8,245.4 (87.0%) 10:06:53 INFO - TinderboxPrint: CPU user
1,188.2 (12.5%) 10:06:53 INFO - TinderboxPrint: Swap in / out
0 / 0 10:06:53 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100564992; Read time: 0; Write time: 83188 10:06:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 215736320; Read time: 0; Write time: 123212 10:06:53 INFO - Running post-run listener: _upload_blobber_files 10:06:53 INFO - Blob upload gear active. 10:06:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:53 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 10:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:06:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:55 INFO - (blobuploader) - INFO - Done attempting. 10:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:56 INFO - (blobuploader) - INFO - Done attempting. 10:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:07:00 INFO - (blobuploader) - INFO - Done attempting. 10:07:00 INFO - (blobuploader) - INFO - Iteration through files over. 10:07:00 INFO - Return code: 0 10:07:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:07:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:07:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/569e08ed9d8e6d48c089570e223a23f08875152d23181775ff24ad13f0e9711e4edc15016754fbffdb07fe8dd27a7b3d84f3d355caf20f2ca2e73b003cea81b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b410cbb83b7354b83a9a7515591c9ec01a79b3c826e8aa12e94d5033dd7feffb55b8016f335e30f616a343d7a23275dd8dff58080808121ac09d07a455db7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98f7d0a3f6ae0ff019511a94dc7b4399d3b1f991e39bb7c18e8ab77ecc3f2228b2ce64d04e56b2fe161dc2d1df6532132c93c6cde1e12ef793ad000f3a1bf31"} 10:07:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:07:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:07:00 INFO - Contents: 10:07:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/569e08ed9d8e6d48c089570e223a23f08875152d23181775ff24ad13f0e9711e4edc15016754fbffdb07fe8dd27a7b3d84f3d355caf20f2ca2e73b003cea81b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b410cbb83b7354b83a9a7515591c9ec01a79b3c826e8aa12e94d5033dd7feffb55b8016f335e30f616a343d7a23275dd8dff58080808121ac09d07a455db7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98f7d0a3f6ae0ff019511a94dc7b4399d3b1f991e39bb7c18e8ab77ecc3f2228b2ce64d04e56b2fe161dc2d1df6532132c93c6cde1e12ef793ad000f3a1bf31"} 10:07:00 INFO - Running post-run listener: copy_logs_to_upload_dir 10:07:00 INFO - Copying logs to upload dir... 10:07:00 INFO - mkdir: /builds/slave/test/build/upload/logs 10:07:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.307081 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-11-21 10:07:00.333652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 10:07:00.338527) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 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-Beta/sha512/569e08ed9d8e6d48c089570e223a23f08875152d23181775ff24ad13f0e9711e4edc15016754fbffdb07fe8dd27a7b3d84f3d355caf20f2ca2e73b003cea81b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b410cbb83b7354b83a9a7515591c9ec01a79b3c826e8aa12e94d5033dd7feffb55b8016f335e30f616a343d7a23275dd8dff58080808121ac09d07a455db7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98f7d0a3f6ae0ff019511a94dc7b4399d3b1f991e39bb7c18e8ab77ecc3f2228b2ce64d04e56b2fe161dc2d1df6532132c93c6cde1e12ef793ad000f3a1bf31"} build_url:https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/Pxmx54RwSM-Jh-WKFSAA3w/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/569e08ed9d8e6d48c089570e223a23f08875152d23181775ff24ad13f0e9711e4edc15016754fbffdb07fe8dd27a7b3d84f3d355caf20f2ca2e73b003cea81b8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56b410cbb83b7354b83a9a7515591c9ec01a79b3c826e8aa12e94d5033dd7feffb55b8016f335e30f616a343d7a23275dd8dff58080808121ac09d07a455db7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98f7d0a3f6ae0ff019511a94dc7b4399d3b1f991e39bb7c18e8ab77ecc3f2228b2ce64d04e56b2fe161dc2d1df6532132c93c6cde1e12ef793ad000f3a1bf31"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 10:07:00.366235) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:07:00.366626) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1479750387.831492-1554317723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:07:00.419248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 10:07:00.419634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 10:07:00.419984) ========= ========= Total master_lag: 0.19 =========