builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1475115041.74 results: success (0) buildid: 20160928171520 builduid: 494e4e01e38848c58425f5ee904efab7 revision: 84ef54451749188462d6b97c6b668508893ece47 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.735845) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.736264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.736568) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.815623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.816131) ========= 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=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 19:10:41-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-09-28 19:10:41 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141855 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.991640) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:41.995004) ========= 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=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014996 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.049763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.050163) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 84ef54451749188462d6b97c6b668508893ece47 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 84ef54451749188462d6b97c6b668508893ece47 --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=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 19:10:42,119 truncating revision to first 12 chars 2016-09-28 19:10:42,119 Setting DEBUG logging. 2016-09-28 19:10:42,119 attempt 1/10 2016-09-28 19:10:42,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/84ef54451749?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 19:10:42,483 unpacking tar archive at: mozilla-aurora-84ef54451749/testing/mozharness/ program finished with exit code 0 elapsedTime=0.729474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.796578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.796927) ========= script_repo_revision: 84ef54451749188462d6b97c6b668508893ece47 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.797386) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.797761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 19:10:42.806705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-28 19:10:42.807021) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:43 INFO - MultiFileLogger online at 20160928 19:10:43 in /builds/slave/test 19:10:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:10:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:43 INFO - {'append_to_log': False, 19:10:43 INFO - 'base_work_dir': '/builds/slave/test', 19:10:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:10:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:43 INFO - 'branch': 'Mozilla-Aurora', 19:10:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:43 INFO - 'config_files': ('talos/linux_config.py',), 19:10:43 INFO - 'default_actions': ('clobber', 19:10:43 INFO - 'read-buildbot-config', 19:10:43 INFO - 'download-and-extract', 19:10:43 INFO - 'populate-webroot', 19:10:43 INFO - 'create-virtualenv', 19:10:43 INFO - 'install', 19:10:43 INFO - 'run-tests'), 19:10:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:43 INFO - 'download_minidump_stackwalk': True, 19:10:43 INFO - 'download_symbols': 'ondemand', 19:10:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:43 INFO - 'installer_path': 'installer.exe', 19:10:43 INFO - 'log_level': 'info', 19:10:43 INFO - 'log_name': 'talos', 19:10:43 INFO - 'log_to_console': True, 19:10:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:43 INFO - 'opt_config_files': (), 19:10:43 INFO - 'pip_index': False, 19:10:43 INFO - 'sps_profile': False, 19:10:43 INFO - 'sps_profile_interval': 0, 19:10:43 INFO - 'suite': 'dromaeojs', 19:10:43 INFO - 'system_bits': '32', 19:10:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:43 INFO - 'title': 'talos-linux64-ix-031', 19:10:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:43 INFO - 'use_talos_json': True, 19:10:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:43 INFO - 'work_dir': 'build'} 19:10:43 INFO - [mozharness: 2016-09-29 02:10:43.071837Z] Running clobber step. 19:10:43 INFO - Running pre-action listener: _resource_record_pre_action 19:10:43 INFO - Running main action method: clobber 19:10:43 INFO - rmtree: /builds/slave/test/build 19:10:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:43 INFO - Running post-action listener: _resource_record_post_action 19:10:43 INFO - [mozharness: 2016-09-29 02:10:43.486683Z] Finished clobber step (success) 19:10:43 INFO - [mozharness: 2016-09-29 02:10:43.486782Z] Running read-buildbot-config step. 19:10:43 INFO - Running pre-action listener: _resource_record_pre_action 19:10:43 INFO - Running main action method: read_buildbot_config 19:10:43 INFO - Using buildbot properties: 19:10:43 INFO - { 19:10:43 INFO - "project": "", 19:10:43 INFO - "product": "firefox", 19:10:43 INFO - "script_repo_revision": "production", 19:10:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:10:43 INFO - "repository": "", 19:10:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:10:43 INFO - "buildid": "20160928171520", 19:10:43 INFO - "pgo_build": "True", 19:10:43 INFO - "basedir": "/builds/slave/test", 19:10:43 INFO - "buildnumber": 537, 19:10:43 INFO - "slavename": "talos-linux64-ix-031", 19:10:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:10:43 INFO - "platform": "ubuntu64_hw", 19:10:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:10:43 INFO - "branch": "mozilla-aurora", 19:10:43 INFO - "repo_path": "releases/mozilla-aurora", 19:10:43 INFO - "revision": "84ef54451749188462d6b97c6b668508893ece47", 19:10:43 INFO - "stage_platform": "linux64-pgo", 19:10:43 INFO - "builduid": "494e4e01e38848c58425f5ee904efab7", 19:10:43 INFO - "slavebuilddir": "test" 19:10:43 INFO - } 19:10:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 19:10:43 INFO - Running post-action listener: _resource_record_post_action 19:10:43 INFO - [mozharness: 2016-09-29 02:10:43.489424Z] Finished read-buildbot-config step (success) 19:10:43 INFO - [mozharness: 2016-09-29 02:10:43.489514Z] Running download-and-extract step. 19:10:43 INFO - Running pre-action listener: _resource_record_pre_action 19:10:43 INFO - Running main action method: download_and_extract 19:10:43 INFO - mkdir: /builds/slave/test/build/tests 19:10:43 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')]} 19:10:43 INFO - trying https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:10:44 INFO - Downloaded 1361 bytes. 19:10:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:10:44 INFO - Using the following test package requirements: 19:10:44 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:10:44 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:44 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:10:44 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'jsshell-linux-x86_64.zip'], 19:10:44 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:44 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:10:44 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:10:44 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:10:44 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:44 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:10:44 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:10:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:10:44 INFO - Expected file size: 21899965 19:10:48 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:10:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:10:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:10:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:10:49 INFO - Expected file size: 21899965 19:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 19:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 19:10:54 INFO - Expected file size: 14414059 19:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:55 INFO - trying https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:10:55 INFO - Downloading https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:10:57 INFO - Downloaded 63975617 bytes. 19:10:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:10:57 INFO - mkdir: /builds/slave/test/properties 19:10:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:57 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:57 INFO - Contents: 19:10:57 INFO - build_url:https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:10:58 INFO - Running post-action listener: _resource_record_post_action 19:10:58 INFO - Running post-action listener: set_extra_try_arguments 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.322190Z] Finished download-and-extract step (success) 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.322420Z] Running populate-webroot step. 19:10:58 INFO - Running pre-action listener: _resource_record_pre_action 19:10:58 INFO - Running main action method: populate_webroot 19:10:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:58 INFO - '--tppagecycles', 19:10:58 INFO - '7'], 19:10:58 INFO - 'tests': ['tsvgm']}}, 19:10:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['damp', 'tps']}, 19:10:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'tests': ['damp', 'tps']}, 19:10:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['dromaeo_dom']}, 19:10:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['basic_compositor_video']}, 19:10:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:10:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['a11yr', 19:10:58 INFO - 'ts_paint', 19:10:58 INFO - 'tpaint', 19:10:58 INFO - 'sessionrestore', 19:10:58 INFO - 'sessionrestore_no_auto_restore', 19:10:58 INFO - 'tabpaint']}, 19:10:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['tsvgx', 19:10:58 INFO - 'tsvgr_opacity', 19:10:58 INFO - 'tart', 19:10:58 INFO - 'tscrollx', 19:10:58 INFO - 'cart']}, 19:10:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:58 INFO - 'tsvgr_opacity', 19:10:58 INFO - 'tart', 19:10:58 INFO - 'tscrollx', 19:10:58 INFO - 'cart']}, 19:10:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'talos_options': ['--disable-e10s'], 19:10:58 INFO - 'tests': ['tp5o']}, 19:10:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'tests': ['tp5o']}, 19:10:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'talos_options': ['--disable-e10s', 19:10:58 INFO - '--xperf_path', 19:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:58 INFO - 'tests': ['tp5n']}, 19:10:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:58 INFO - 'talos_options': ['--xperf_path', 19:10:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:58 INFO - 'tests': ['tp5n']}}, 19:10:58 INFO - 'talos.zip': {'path': '', 19:10:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:58 INFO - Running post-action listener: _resource_record_post_action 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.341982Z] Finished populate-webroot step (success) 19:10:58 INFO - [mozharness: 2016-09-29 02:10:58.342071Z] Running create-virtualenv step. 19:10:58 INFO - Running pre-action listener: _resource_record_pre_action 19:10:58 INFO - Running main action method: create_virtualenv 19:10:58 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:58 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 19:10:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:58 INFO - Using real prefix '/usr' 19:10:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:59 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:01 INFO - Installing pip.................done. 19:11:01 INFO - Return code: 0 19:11:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:11:01 INFO - Using env: {'DISPLAY': ':0', 19:11:01 INFO - 'HOME': '/home/cltbld', 19:11:01 INFO - 'LANG': 'en_US.UTF-8', 19:11:01 INFO - 'LANGUAGE': 'en_US:en', 19:11:01 INFO - 'LOGNAME': 'cltbld', 19:11:01 INFO - 'MAIL': '/var/mail/cltbld', 19:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:01 INFO - 'MOZ_NO_REMOTE': '1', 19:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:01 INFO - 'NO_EM_RESTART': '1', 19:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:01 INFO - 'PWD': '/builds/slave/test', 19:11:01 INFO - 'SHELL': '/bin/bash', 19:11:01 INFO - 'SHLVL': '1', 19:11:01 INFO - 'TERM': 'linux', 19:11:01 INFO - 'TMOUT': '86400', 19:11:01 INFO - 'USER': 'cltbld', 19:11:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:01 INFO - '_': '/tools/buildbot/bin/python'} 19:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:11:01 INFO - Cleaning up... 19:11:01 INFO - Return code: 0 19:11:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:11:01 INFO - Using env: {'DISPLAY': ':0', 19:11:01 INFO - 'HOME': '/home/cltbld', 19:11:01 INFO - 'LANG': 'en_US.UTF-8', 19:11:01 INFO - 'LANGUAGE': 'en_US:en', 19:11:01 INFO - 'LOGNAME': 'cltbld', 19:11:01 INFO - 'MAIL': '/var/mail/cltbld', 19:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:01 INFO - 'MOZ_NO_REMOTE': '1', 19:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:01 INFO - 'NO_EM_RESTART': '1', 19:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:01 INFO - 'PWD': '/builds/slave/test', 19:11:01 INFO - 'SHELL': '/bin/bash', 19:11:01 INFO - 'SHLVL': '1', 19:11:01 INFO - 'TERM': 'linux', 19:11:01 INFO - 'TMOUT': '86400', 19:11:01 INFO - 'USER': 'cltbld', 19:11:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:01 INFO - '_': '/tools/buildbot/bin/python'} 19:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:01 INFO - Downloading/unpacking psutil>=3.1.1 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:03 INFO - Installing collected packages: psutil 19:11:03 INFO - Running setup.py install for psutil 19:11:03 INFO - building 'psutil._psutil_linux' extension 19:11:03 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 19:11:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:11:04 INFO - building 'psutil._psutil_posix' extension 19:11:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:11:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:11:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:05 INFO - Successfully installed psutil 19:11:05 INFO - Cleaning up... 19:11:05 INFO - Return code: 0 19:11:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:11: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 mozsystemmonitor==0.3 19:11:05 INFO - Using env: {'DISPLAY': ':0', 19:11:05 INFO - 'HOME': '/home/cltbld', 19:11:05 INFO - 'LANG': 'en_US.UTF-8', 19:11:05 INFO - 'LANGUAGE': 'en_US:en', 19:11:05 INFO - 'LOGNAME': 'cltbld', 19:11:05 INFO - 'MAIL': '/var/mail/cltbld', 19:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:05 INFO - 'MOZ_NO_REMOTE': '1', 19:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:05 INFO - 'NO_EM_RESTART': '1', 19:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:05 INFO - 'PWD': '/builds/slave/test', 19:11:05 INFO - 'SHELL': '/bin/bash', 19:11:05 INFO - 'SHLVL': '1', 19:11:05 INFO - 'TERM': 'linux', 19:11:05 INFO - 'TMOUT': '86400', 19:11:05 INFO - 'USER': 'cltbld', 19:11:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:05 INFO - '_': '/tools/buildbot/bin/python'} 19:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:05 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 19:11:05 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 19:11:05 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 19:11:05 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 19:11:05 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 19:11:05 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 19:11:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:07 INFO - Installing collected packages: mozsystemmonitor 19:11:07 INFO - Running setup.py install for mozsystemmonitor 19:11:07 INFO - Successfully installed mozsystemmonitor 19:11:07 INFO - Cleaning up... 19:11:07 INFO - Return code: 0 19:11:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:11:07 INFO - Using env: {'DISPLAY': ':0', 19:11:07 INFO - 'HOME': '/home/cltbld', 19:11:07 INFO - 'LANG': 'en_US.UTF-8', 19:11:07 INFO - 'LANGUAGE': 'en_US:en', 19:11:07 INFO - 'LOGNAME': 'cltbld', 19:11:07 INFO - 'MAIL': '/var/mail/cltbld', 19:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:07 INFO - 'MOZ_NO_REMOTE': '1', 19:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:07 INFO - 'NO_EM_RESTART': '1', 19:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:07 INFO - 'PWD': '/builds/slave/test', 19:11:07 INFO - 'SHELL': '/bin/bash', 19:11:07 INFO - 'SHLVL': '1', 19:11:07 INFO - 'TERM': 'linux', 19:11:07 INFO - 'TMOUT': '86400', 19:11:07 INFO - 'USER': 'cltbld', 19:11:07 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:07 INFO - '_': '/tools/buildbot/bin/python'} 19:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:07 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:09 INFO - warning: no files found matching '*.txt' 19:11:09 INFO - no previously-included directories found matching 'build' 19:11:09 INFO - no previously-included directories found matching 'dist' 19:11:09 INFO - no previously-included directories found matching '.git*' 19:11:09 INFO - Installing collected packages: jsonschema, functools32 19:11:09 INFO - Running setup.py install for functools32 19:11:09 INFO - warning: no files found matching '*.txt' 19:11:09 INFO - no previously-included directories found matching 'build' 19:11:09 INFO - no previously-included directories found matching 'dist' 19:11:09 INFO - no previously-included directories found matching '.git*' 19:11:09 INFO - Successfully installed jsonschema functools32 19:11:09 INFO - Cleaning up... 19:11:10 INFO - Return code: 0 19:11:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:11:10 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')]} 19:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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')]} 19:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:10 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 19:11:10 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 19:11:10 INFO - Using env: {'DISPLAY': ':0', 19:11:10 INFO - 'HOME': '/home/cltbld', 19:11:10 INFO - 'LANG': 'en_US.UTF-8', 19:11:10 INFO - 'LANGUAGE': 'en_US:en', 19:11:10 INFO - 'LOGNAME': 'cltbld', 19:11:10 INFO - 'MAIL': '/var/mail/cltbld', 19:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:10 INFO - 'MOZ_NO_REMOTE': '1', 19:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:10 INFO - 'NO_EM_RESTART': '1', 19:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:10 INFO - 'PWD': '/builds/slave/test', 19:11:10 INFO - 'SHELL': '/bin/bash', 19:11:10 INFO - 'SHLVL': '1', 19:11:10 INFO - 'TERM': 'linux', 19:11:10 INFO - 'TMOUT': '86400', 19:11:10 INFO - 'USER': 'cltbld', 19:11:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:10 INFO - '_': '/tools/buildbot/bin/python'} 19:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:11:10 INFO - Cleaning up... 19:11:10 INFO - Return code: 0 19:11:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:10 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')]} 19:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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')]} 19:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:10 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 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:10 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 19:11:10 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 19:11:10 INFO - Using env: {'DISPLAY': ':0', 19:11:10 INFO - 'HOME': '/home/cltbld', 19:11:10 INFO - 'LANG': 'en_US.UTF-8', 19:11:10 INFO - 'LANGUAGE': 'en_US:en', 19:11:10 INFO - 'LOGNAME': 'cltbld', 19:11:10 INFO - 'MAIL': '/var/mail/cltbld', 19:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:10 INFO - 'MOZ_NO_REMOTE': '1', 19:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:10 INFO - 'NO_EM_RESTART': '1', 19:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:10 INFO - 'PWD': '/builds/slave/test', 19:11:10 INFO - 'SHELL': '/bin/bash', 19:11:10 INFO - 'SHLVL': '1', 19:11:10 INFO - 'TERM': 'linux', 19:11:10 INFO - 'TMOUT': '86400', 19:11:10 INFO - 'USER': 'cltbld', 19:11:10 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:10 INFO - '_': '/tools/buildbot/bin/python'} 19:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:10 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 INFO - Downloading docopt-0.6.1.tar.gz 19:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:13 INFO - Running setup.py install for blobuploader 19:11:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:13 INFO - Running setup.py install for requests 19:11:13 INFO - Running setup.py install for docopt 19:11:13 INFO - Successfully installed blobuploader requests docopt 19:11:13 INFO - Cleaning up... 19:11:13 INFO - Return code: 0 19:11:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:13 INFO - Using env: {'DISPLAY': ':0', 19:11:13 INFO - 'HOME': '/home/cltbld', 19:11:13 INFO - 'LANG': 'en_US.UTF-8', 19:11:13 INFO - 'LANGUAGE': 'en_US:en', 19:11:13 INFO - 'LOGNAME': 'cltbld', 19:11:13 INFO - 'MAIL': '/var/mail/cltbld', 19:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:13 INFO - 'MOZ_NO_REMOTE': '1', 19:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:13 INFO - 'NO_EM_RESTART': '1', 19:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:13 INFO - 'PWD': '/builds/slave/test', 19:11:13 INFO - 'SHELL': '/bin/bash', 19:11:13 INFO - 'SHLVL': '1', 19:11:13 INFO - 'TERM': 'linux', 19:11:13 INFO - 'TMOUT': '86400', 19:11:13 INFO - 'USER': 'cltbld', 19:11:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:13 INFO - '_': '/tools/buildbot/bin/python'} 19:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:14 INFO - Running setup.py (path:/tmp/pip-_oyOIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:14 INFO - Running setup.py (path:/tmp/pip-MFbzYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:14 INFO - Running setup.py (path:/tmp/pip-NDMgXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:14 INFO - Running setup.py (path:/tmp/pip-Oadm6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:14 INFO - Running setup.py (path:/tmp/pip-Bq4Pn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:14 INFO - Running setup.py (path:/tmp/pip-6KCO2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:14 INFO - Running setup.py (path:/tmp/pip-cNTChU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:14 INFO - Running setup.py (path:/tmp/pip-KSaROL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:14 INFO - Running setup.py (path:/tmp/pip-zTuMf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:14 INFO - Running setup.py (path:/tmp/pip-C8hShO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:14 INFO - Running setup.py (path:/tmp/pip-r_H5lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:14 INFO - Running setup.py (path:/tmp/pip-PAapsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:14 INFO - Running setup.py (path:/tmp/pip-vCecww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:15 INFO - Running setup.py (path:/tmp/pip-rj_iDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:15 INFO - Running setup.py (path:/tmp/pip-1R7FNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:15 INFO - Running setup.py (path:/tmp/pip-Nj3q16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:15 INFO - Running setup.py (path:/tmp/pip-VYUzEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:15 INFO - Running setup.py install for manifestparser 19:11:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:15 INFO - Running setup.py install for mozcrash 19:11:15 INFO - Running setup.py install for mozdebug 19:11:15 INFO - Running setup.py install for mozdevice 19:11:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:15 INFO - Running setup.py install for mozfile 19:11:15 INFO - Running setup.py install for mozhttpd 19:11:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:15 INFO - Running setup.py install for mozinfo 19:11:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozInstall 19:11:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozleak 19:11:16 INFO - Running setup.py install for mozlog 19:11:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for moznetwork 19:11:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozprocess 19:11:16 INFO - Running setup.py install for mozprofile 19:11:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozrunner 19:11:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:16 INFO - Running setup.py install for mozscreenshot 19:11:16 INFO - Running setup.py install for moztest 19:11:17 INFO - Running setup.py install for mozversion 19:11:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:17 INFO - Cleaning up... 19:11:17 INFO - Return code: 0 19:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:17 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')]} 19:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:17 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')]} 19:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:17 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 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:17 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 19:11:17 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 19:11:17 INFO - Using env: {'DISPLAY': ':0', 19:11:17 INFO - 'HOME': '/home/cltbld', 19:11:17 INFO - 'LANG': 'en_US.UTF-8', 19:11:17 INFO - 'LANGUAGE': 'en_US:en', 19:11:17 INFO - 'LOGNAME': 'cltbld', 19:11:17 INFO - 'MAIL': '/var/mail/cltbld', 19:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:17 INFO - 'MOZ_NO_REMOTE': '1', 19:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:17 INFO - 'NO_EM_RESTART': '1', 19:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:17 INFO - 'PWD': '/builds/slave/test', 19:11:17 INFO - 'SHELL': '/bin/bash', 19:11:17 INFO - 'SHLVL': '1', 19:11:17 INFO - 'TERM': 'linux', 19:11:17 INFO - 'TMOUT': '86400', 19:11:17 INFO - 'USER': 'cltbld', 19:11:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:17 INFO - '_': '/tools/buildbot/bin/python'} 19:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:17 INFO - Running setup.py (path:/tmp/pip-vr_k1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:17 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)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:17 INFO - Running setup.py (path:/tmp/pip-jHGju1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:17 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)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:17 INFO - Running setup.py (path:/tmp/pip-KDjK1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:17 INFO - Running setup.py (path:/tmp/pip-wePbkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:17 INFO - Running setup.py (path:/tmp/pip-2kP95g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:17 INFO - Running setup.py (path:/tmp/pip-7Nx2mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:17 INFO - Running setup.py (path:/tmp/pip-nmEF8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:17 INFO - Running setup.py (path:/tmp/pip-KukX7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:17 INFO - Running setup.py (path:/tmp/pip-3cSqtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:17 INFO - Running setup.py (path:/tmp/pip-JeUv3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:18 INFO - Running setup.py (path:/tmp/pip-DVs7lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:18 INFO - Running setup.py (path:/tmp/pip-V2h2l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:18 INFO - Running setup.py (path:/tmp/pip-09uWk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:18 INFO - Running setup.py (path:/tmp/pip-dnvcKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:18 INFO - Running setup.py (path:/tmp/pip-By_On5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:18 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)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:18 INFO - Running setup.py (path:/tmp/pip-20SeyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:18 INFO - Running setup.py (path:/tmp/pip-jmHuhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:20 INFO - Downloading blessings-1.6.tar.gz 19:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:20 INFO - Installing collected packages: blessings 19:11:20 INFO - Running setup.py install for blessings 19:11:20 INFO - Successfully installed blessings 19:11:20 INFO - Cleaning up... 19:11:20 INFO - Return code: 0 19:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:20 INFO - Reading from file tmpfile_stdout 19:11:20 INFO - Current package versions: 19:11:20 INFO - argparse == 1.2.1 19:11:20 INFO - blessings == 1.6 19:11:20 INFO - blobuploader == 1.2.4 19:11:20 INFO - docopt == 0.6.1 19:11:20 INFO - functools32 == 3.2.3-2 19:11:20 INFO - jsonschema == 2.5.1 19:11:20 INFO - manifestparser == 1.1 19:11:20 INFO - mozInstall == 1.12 19:11:20 INFO - mozcrash == 0.17 19:11:20 INFO - mozdebug == 0.1 19:11:20 INFO - mozdevice == 0.48 19:11:20 INFO - mozfile == 1.2 19:11:20 INFO - mozhttpd == 0.7 19:11:20 INFO - mozinfo == 0.9 19:11:20 INFO - mozleak == 0.1 19:11:20 INFO - mozlog == 3.4 19:11:20 INFO - moznetwork == 0.27 19:11:20 INFO - mozprocess == 0.23 19:11:20 INFO - mozprofile == 0.28 19:11:20 INFO - mozrunner == 6.12 19:11:20 INFO - mozscreenshot == 0.1 19:11:20 INFO - mozsystemmonitor == 0.3 19:11:20 INFO - moztest == 0.7 19:11:20 INFO - mozversion == 1.4 19:11:20 INFO - psutil == 3.1.1 19:11:20 INFO - requests == 1.2.3 19:11:20 INFO - wsgiref == 0.1.2 19:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:20 INFO - Using env: {'DISPLAY': ':0', 19:11:20 INFO - 'HOME': '/home/cltbld', 19:11:20 INFO - 'LANG': 'en_US.UTF-8', 19:11:20 INFO - 'LANGUAGE': 'en_US:en', 19:11:20 INFO - 'LOGNAME': 'cltbld', 19:11:20 INFO - 'MAIL': '/var/mail/cltbld', 19:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:20 INFO - 'MOZ_NO_REMOTE': '1', 19:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:20 INFO - 'NO_EM_RESTART': '1', 19:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:20 INFO - 'PWD': '/builds/slave/test', 19:11:20 INFO - 'SHELL': '/bin/bash', 19:11:20 INFO - 'SHLVL': '1', 19:11:20 INFO - 'TERM': 'linux', 19:11:20 INFO - 'TMOUT': '86400', 19:11:20 INFO - 'USER': 'cltbld', 19:11:20 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:20 INFO - '_': '/tools/buildbot/bin/python'} 19:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 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)) 19:11:21 INFO - Cleaning up... 19:11:21 INFO - Return code: 0 19:11:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:21 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')]} 19:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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')]} 19:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:21 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 0x7fe980492f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, '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': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', '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 19:11:21 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 19:11:21 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 19:11:21 INFO - Using env: {'DISPLAY': ':0', 19:11:21 INFO - 'HOME': '/home/cltbld', 19:11:21 INFO - 'LANG': 'en_US.UTF-8', 19:11:21 INFO - 'LANGUAGE': 'en_US:en', 19:11:21 INFO - 'LOGNAME': 'cltbld', 19:11:21 INFO - 'MAIL': '/var/mail/cltbld', 19:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:21 INFO - 'MOZ_NO_REMOTE': '1', 19:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:21 INFO - 'NO_EM_RESTART': '1', 19:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:21 INFO - 'PWD': '/builds/slave/test', 19:11:21 INFO - 'SHELL': '/bin/bash', 19:11:21 INFO - 'SHLVL': '1', 19:11:21 INFO - 'TERM': 'linux', 19:11:21 INFO - 'TMOUT': '86400', 19:11:21 INFO - 'USER': 'cltbld', 19:11:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:21 INFO - '_': '/tools/buildbot/bin/python'} 19:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:21 INFO - Cleaning up... 19:11:21 INFO - Return code: 0 19:11:21 INFO - Running post-action listener: _resource_record_post_action 19:11:21 INFO - Running post-action listener: _start_resource_monitoring 19:11:21 INFO - Starting resource monitoring. 19:11:21 INFO - [mozharness: 2016-09-29 02:11:21.463097Z] Finished create-virtualenv step (success) 19:11:21 INFO - [mozharness: 2016-09-29 02:11:21.464076Z] Running install step. 19:11:21 INFO - Running pre-action listener: _resource_record_pre_action 19:11:21 INFO - Running main action method: install 19:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:21 INFO - Reading from file tmpfile_stdout 19:11:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:21 INFO - Reading from file tmpfile_stdout 19:11:21 INFO - Output received: 19:11:21 INFO - Usage: mozinstall [options] installer 19:11:21 INFO - Options: 19:11:21 INFO - -h, --help show this help message and exit 19:11:21 INFO - -d DEST, --destination=DEST 19:11:21 INFO - Directory to install application into. [default: 19:11:21 INFO - "/builds/slave/test"] 19:11:21 INFO - --app=APP Application being installed. [default: firefox] 19:11:21 INFO - mkdir: /builds/slave/test/build/application 19:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:11:37 INFO - Reading from file tmpfile_stdout 19:11:37 INFO - Output received: 19:11:37 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:37 INFO - Running post-action listener: _resource_record_post_action 19:11:37 INFO - [mozharness: 2016-09-29 02:11:37.720721Z] Finished install step (success) 19:11:37 INFO - [mozharness: 2016-09-29 02:11:37.720966Z] Running run-tests step. 19:11:37 INFO - Running pre-action listener: _resource_record_pre_action 19:11:37 INFO - Running main action method: run_tests 19:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:37 INFO - Python 2.7.3 19:11:37 INFO - Return code: 0 19:11:37 INFO - grabbing minidump binary from tooltool 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9ef60>, '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 0xf9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:11:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:11:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:11:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:38 INFO - Return code: 0 19:11:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:11:38 INFO - Using env: {'DISPLAY': ':0', 19:11:38 INFO - 'HOME': '/home/cltbld', 19:11:38 INFO - 'LANG': 'en_US.UTF-8', 19:11:38 INFO - 'LANGUAGE': 'en_US:en', 19:11:38 INFO - 'LOGNAME': 'cltbld', 19:11:38 INFO - 'MAIL': '/var/mail/cltbld', 19:11:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:38 INFO - 'MOZ_NO_REMOTE': '1', 19:11:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:38 INFO - 'NO_EM_RESTART': '1', 19:11:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:38 INFO - 'PWD': '/builds/slave/test', 19:11:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:38 INFO - 'SHELL': '/bin/bash', 19:11:38 INFO - 'SHLVL': '1', 19:11:38 INFO - 'TERM': 'linux', 19:11:38 INFO - 'TMOUT': '86400', 19:11:38 INFO - 'USER': 'cltbld', 19:11:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007', 19:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:38 INFO - '_': '/tools/buildbot/bin/python'} 19:11:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:11:38 INFO - mozversion application_buildid: 20160928171520 19:11:38 INFO - mozversion application_changeset: 84ef54451749188462d6b97c6b668508893ece47 19:11:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:11:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:38 INFO - mozversion application_name: Firefox 19:11:38 INFO - mozversion application_remotingname: firefox-dev 19:11:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:11:38 INFO - mozversion application_vendor: Mozilla 19:11:38 INFO - mozversion application_version: 51.0a2 19:11:38 INFO - mozversion platform_buildid: 20160928171520 19:11:38 INFO - mozversion platform_changeset: 84ef54451749188462d6b97c6b668508893ece47 19:11:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:11:38 INFO - mozversion platform_version: 51.0a2 19:11:38 INFO - using testdate: 1475115098 19:11:38 INFO - actual date: 1475115098 19:11:38 INFO - starting webserver on 'localhost:38612' 19:11:38 INFO - SUITE-START | Running 2 tests 19:11:38 INFO - TEST-START | dromaeo_css 19:11:38 INFO - operating with platform_type : linux_ 19:11:38 INFO - Initialising browser for dromaeo_css test... 19:11:38 INFO - TEST-INFO | started process 3325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDgPjf/profile http://localhost:38612/getInfo.html) 19:11:43 INFO - PROCESS | 3325 | __metrics Screen width/height:1600/1200 19:11:43 INFO - PROCESS | 3325 | colorDepth:24 19:11:43 INFO - PROCESS | 3325 | Browser inner width/height: 1024/697 19:11:43 INFO - PROCESS | 3325 | __metrics 19:11:44 INFO - PROCESS | 3325 | 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" 19:11:44 INFO - PROCESS | 3325 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:44 INFO - PROCESS | 3325 | console.error: PushService: 19:11:44 INFO - PROCESS | 3325 | stateChangeProcessEnqueue: Error transitioning state 19:11:44 INFO - PROCESS | 3325 | UnknownError 19:11:45 INFO - TEST-INFO | 3325: exit 0 19:11:45 INFO - Browser initialized. 19:11:45 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:45 INFO - TEST-INFO | started process 3418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsDgPjf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:56 INFO - PROCESS | 3418 | RSS: Main: 143917056 19:11:56 INFO - PROCESS | 3418 | 19:12:48 INFO - PROCESS | 3418 | 1475115168136 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] 19:14:57 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38612/tests/dromaeo/cssquery-ext.html) 19:14:58 INFO - PROCESS | 3418 | RSS: Main: 238886912 19:14:58 INFO - PROCESS | 3418 | 19:18:00 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-ext.html (next: http://localhost:38612/tests/dromaeo/cssquery-jquery.html) 19:18:01 INFO - PROCESS | 3418 | RSS: Main: 235778048 19:18:01 INFO - PROCESS | 3418 | 19:21:03 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38612/tests/dromaeo/cssquery-mootools.html) 19:21:03 INFO - PROCESS | 3418 | RSS: Main: 174526464 19:21:03 INFO - PROCESS | 3418 | 19:24:05 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38612/tests/dromaeo/cssquery-prototype.html) 19:24:06 INFO - PROCESS | 3418 | RSS: Main: 173395968 19:24:06 INFO - PROCESS | 3418 | 19:27:08 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38612/tests/dromaeo/cssquery-yui.html) 19:27:09 INFO - PROCESS | 3418 | RSS: Main: 176128000 19:27:09 INFO - PROCESS | 3418 | 19:30:11 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-yui.html (next: http://localhost:38612/tests/dromaeo/cssquery-dojo.html) 19:30:12 INFO - PROCESS | 3418 | RSS: Main: 263528448 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | __start_tp_report 19:30:12 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 19:30:12 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 19:30:12 INFO - PROCESS | 3418 | |i|pagename|runs| 19:30:12 INFO - PROCESS | 3418 | |0;dojo.html;3091.7062879026494;3129.499280115182;3148.1814728170684;3161.320316132034;3179.4912813949772;5590.440955904408;5669.376368599456;5678.914816277759;5702.8289151325425;5716.11400232964;5686;5755.510781583571;5759.963206622806;5771.989901767184;5794.188813566104;5184.53339199472;5206.3231779868565;5218.13900706383;5253.028189784883;5288.418273989858;5044.596432285427;5294.708791016493;5308.044551980642;5311.548518375943;5339.305890234265;5020.6234532410035;5041.8487445376695;5137.5633071188995;5169.457206993268;5190.273361729361;5072.4673909239555;5077.466865979056;5089.872753181163;5172.508611681884;5196.1166601677805;5027.899442011176;5071.087204303224;5128.512791284822;5134;5138;5371.435999220103;5407.945920540823;5522.861928451781;5537.667739935617;5569.220309156722;5959.582829201958;5970.791022314242;6039.849003774897;6063.333033366371;6063.575549711522;6085.269767627913;6089.817305480843;6090.33006369299;6101.572889897709;6104.725287362079;5495.890082198333;5530.723463826793;5557.972210138963;5589;5632.5775566831835;6193.411625895533;6228.532860035515;6229.626222426669;6230.7819226326865;6236;5969.134475501028;5970.731317090655;5980.282366116094;5981.282246130492;5983.551233657493;5880.470757631833;5911.231539899872;5927.762889484372;5963.7912673056235;5965.522758179335;5995.160677505153;6002.609830361012;6006.069059295816;6014.248218972629;6021.066734656135;5964.7315870785915;6001.369856165127;6021.608595441282;6027.969860150759;6040.456358927718;4495.235809912323;4535.9546404536195;4550.112728018004;4605.815767369335;4614.723116612947;4078.6125318094732;4100.507939047334;4117.547069822317;4118.670506359544;4147.4815648044;5752.712364381764;5755.65466072037;5759.913601295984;5759.94240057594;5764.510016648548;5907;5933.58464907461;6008.489278411296;6094.146819445281;6105.389461053859;5636.436356364331;5698.857528561736;5730.541556675539;5733.885322293614;5751.223584815996;5184.403793563713;5187.766550505236;5191.844244672666;5195.090859099642;5196.8960620787375;5963.970180149072;6184.072389141665;6219.098230756515;6236.656983865931;6244.812655620339;5892.852678683067;5978.491828194478;6044.365341639064;6047.365026672136;6111.834843226386;6269.216347956505;6285.057241413824;6287.308396076336;6292.18201633803;6292.842678933063;5964.343922168471;5984.521238300838;5986.311574169026;5989.191459153133;6001.279846418283;5837.883242335045;5964.985952388018;5968.4926781224085;6009.579329446897;6033.758649653964;5906.291245050621;5950.434708702666;5957.195778569838;5957.314908785545;5983.730732116978;5917.378675239038;5950.9702451487465;5951.91072133927;5953;5959.73181206838;5692.601517893873;5812.157237200667;5817.476427121579;5824.446677565625;5931.021381472009;5971.552133590085;5983;5983.34183239852;6007;6019.337872833898;5825.2135961644635;5825.70871456434;5829.854253643523;5831.329397119385;5831.416858314305 19:30:12 INFO - PROCESS | 3418 | |1;ext.html;581.5115303145357;619.2476141488092;632.7627139822564;636.3890664961638;639.3510586754448;34766.65233347666;37754.62245377549;45346.09307813846;46311.30533042007;46361.30458043132;47802.28296575554;48571;48580;48622.51377486233;48658.756706216416;8407.831843363128;9253.76865578361;9392.953035234848;9398.718038458823;9400;8528.189821966904;10962.506687199095;11138.27601205923;11159.218854680175;11500.884991150066;11288.435578221057;11339.659810205707;11372.37451940143;11375.601853935113;11376.829347559793;11207.383593902332;11249.268797528217;11268.774624507463;11271.549138034468;11304.604338848101;11017.889821101766;11044.668659940215;11104.888951110546;11117.166212534092;11125.165612579009;44465;44794.32808507875;44849.551504484865;44856.775716121214;44876.55123448789;3619.6199399062984;3648.1791596890753;3779.433085037239;4008.5590585035625;4340.956590434118;33764.49353259703;34079.488807667905;34085;34169.316613667834;34712.30575388478;4641.419822522184;4649.953500464986;4677.6257899367965;4789.401324834395;4843.515648435128;339355;342050;342276;343155;343504;62312.37687623066;62387.37612623906;62594;62603.6869815648;62646.68676656587;40522.79738601347;40652.79673601613;41039.589604103574;66448;66743;19007.42977710671;19124.521886952938;19128;19141.521461963282;19144.61710765777;13453.327333633279;13673.384697688627;13719.931400342934;13721;13723.656908577166;19803.10886010133;20380.592388152152;20494.282700105425;21187.894060529597;21233.15067397287;7509.62451877404;7544.283293087148;7569.318761311509;7658.195889431641;7775.961120194476;966.4781018250067;978.6281213138961;999.3753903810118;1019.2152042926905;1054.5939813171983;34325.485117723256;35301.82349088238;36005.45991810125;36844.07889802723;37499.81250093732;1091;1180.9173357865038;1192.6899006258436;1195.5098409652;1229.6495498782804;17671.469855904343;17957.910210449125;17978.730319045226;18003.18985645649;18092.54768630795;657127;658830;659731;659975;664919;62027.6898615504;62308;62343.37656623466;62378;62470;1300.1873828856965;1371.6776557508977;1420.34664054534;1442.0626592714818;1474.366022610288;30681;34332.48501272533;34617.48073778845;35017.824910875286;35037.649623503436;52928.20607690965;53774;53835.19247211217;53867.46132538625;53894.19158712701;465880;466840;467992;469569;520896;44192;46932.7653361731;47227.52772472231;47694.761526192146;48490.757546212044;51805.481945180065;51841.7407912958;52436.73781631068;52521;53292.73353633207;41848.581514184465;43223.783881080395;43225.7838710817;43742.34386484269;45261.54738452574;44285.00717467786;44413;44607.33089003732;44956.550434495235;45872.54127458816;43816;44332;44701;44806.77596612126;44903;37686.81156594199;38338.2332353357;39123.413148802225;39710.20579588334;39758.80120599378;29880;30019.574320473574;30076;30324.241893951945;30500.237494062825 19:30:12 INFO - PROCESS | 3418 | |2;jquery.html;394.1938735286339;413.26851472893;420.8127383314425;424.89590050437636;432.5242233543103;14284.571462856105;16001;20010.09954552045;20108.195672173133;20735.481612959684;19009.619807603875;19168;19517.609647807036;19682.901585492087;19683.015849207553;5665.405132461105;5682.318121825387;5874.970625146868;5883.17635531026;5941.197938278342;4345.69580129391;5838.591298609099;5874.060150375941;5883.794067207648;5885.382034886318;4482.5069242383315;6156.507479401659;6419.839504012413;6420.101185833987;6528.6409247491365;6447.226332840042;6541;6561.409473147416;6685.8662826743675;6742.49431292655;6027.336992930774;6029.728662210211;6030.909536356959;6033.637981721111;6037.516998640098;21976.780232197634;23685.407864803346;23779.286621401214;23910;24007.519849603086;2564.9871750641314;2654.734526547349;2661.2149415922154;2726.073135134064;2914.344272538683;14319.78520322196;14893.180875051868;14994.47519336829;15066.472673456487;15522.5343239703;1944.5527528668486;1961.6174845905055;1984.662607356753;2027.2499175305084;2029.645611091142;79449.60275198644;80618.19381806166;80695;81389;81604;11169.497372618089;11231.550737970552;11269.54921803135;11537.192396532162;11623.941880290544;16120.596985075232;16134.273957671932;16135.757963630555;16160.919195404183;16163.111028893523;8892.64429422816;8983.910160898438;9060.093990600888;9080.500572468578;9196.862047069299;8742.213200811957;8924.464532128093;8985.775355616162;9092.636294548276;9107.22588579965;6829.282925292872;6898.758543451056;6908.205556360982;6933.965330173317;6988.196357418962;1974.3682021752902;2012.7685316188827;2019.1721394228296;2023.8279746221735;2026.8277196438173;892.7544925145637;926.8887733472027;937.9776044111951;1005.7737009172878;1015.3907655406697;18720.251189952523;19998.50003749889;19999.60004799404;20183.192672293237;20785.480362991046;998.3810037776625;1032.3547782635853;1052.0899421999916;1097.665212110298;1106.590561492237;11215.158863085302;11276.406426521946;11516.712082198012;11590.594329198437;11635.127365447624;515804;517291;517689;519267;537504;85805;86166;86882.13117868867;86924.13075869287;89009;1012.2762225009154;1030.253066526762;1033.0805583030958;1043.087298613713;1043.8121138195197;17406.825931741027;17655;17897;17952.461426157235;18080.276788928295;40628.18743625052;42740.35889461599;42951.57048429476;42954.57045429631;43740.781296093315;55027.724861375435;55734;56218;56905.71547142238;58573.70713146407;6768.323167683192;6799.694013769294;7920.128785833669;8880.28957683371;9346.626134954799;9492.382995105296;12984.480620775063;13605.591832245049;13701.314934253049;13761;10732.892671073188;11137.164712646745;11574.6527604172;11730.178887477794;11834.171607987359;11216.270942388719;11314.15143864197;11493.827592586285;11563;11799.705007374885;6397.680115994275;9539.523023848918;11113.999740023437;12071.456784444897;12296.877031229573;8257.21556452136;8400.537970411686;8430.873536897074;8464.619092140745;8565.828683426422;11487.368194749035;11743.882561174622;11753.941230293794;11775.823362649739;12018.75962480728 19:30:12 INFO - PROCESS | 3418 | |3;mootools.html;1506.9547913562594;1545.8917875748698;1667.6831402033613;1782.4474412931984;1795.416489640867;9112.179903808665;9816.312858099936;9820.803583928317;9821.116099551038;9825.164860986815;8131.59342032899;8484.44851084679;8972.102789721024;9199.17207451331;9263.980962094165;2379.666846641467;2407.7953373963232;2407.9398015049587;2409.987950060256;2413.1312727418117;2087.8434117441175;2374.3351861478814;2375.192434572245;2436.232586735173;2438.2928950604305;2144.7855214478504;2308.8730119843403;2401.495685905953;2403.0748161957686;2404.615261558151;2367.846090004144;2391.0555330644384;2395.3053614451787;2433.707955045388;2474.6411770293385;2387.9522409551887;2415.1788391946648;2440.2679196241056;2440.7437219091917;2443.706755189371;9391.34260601758;9466.384684995523;9491.240700743923;9504.42973421597;9510.667126650535;5434.266374039494;5533.418991005927;5538.944610553883;5552.416996215379;5561.721913904329;3340.916477088068;3514.3147086318177;3561;3586.264815712773;3588.74878758487;1183.8638556566018;1214.089432925306;1214.690253985228;1231.7043909461754;1250.0936820804934;13429.731405371838;13456.5290214842;13575.660608484866;13714.108582942077;13723.245221512812;4746.715197088186;4756.831751851889;4806.303086052572;4898.853034408973;4932.580730637936;11342.262752921033;11357.432128393548;11370.54517819278;11392;11406.42967851604;5469.07025805614;5483.122700367922;5503.697296648723;5522.392536820947;5529.723513824292;4869.513048695102;4931.3835770528685;5049.040682270357;5079.212722028092;5090;4193.7693426861815;4194.853180138681;4218.8523401680795;4259.2759230930815;4260.488741351058;1268.0869773762877;1278.6419802455327;1302;1309.941052652614;1313.947442102305;891.5453118909273;932.0912110692157;954.0936110694868;960.5917485068818;960.9711708648751;5712.542996560265;5870.236869206976;5881.470667639847;6035.275766907999;6058.27300723916;514.5258833442161;516.1483552139001;524.2607922828793;525.1676093392016;690.3579670906106;4065.776382299002;4108.712390132662;4125.525564560054;4134.462519872457;4135.152293779768;11339;11712.180147389772;11731.941340293244;11742.412879355998;11782.116341274439;11661.6501504955;11717.472713727902;11720.120990925714;11720.296782193096;11743.295402275891;8233.711820086268;8490.915090849012;8521.36089793268;8750.168733970135;8754.343424243207;6079.392060793885;6155.1382806406245;6161.537884658758;6284.874302513833;6474.320196379501;10786.352818830896;10891.455427228766;11073.11415086775;11238.438078096226;11287.20989530725;11428.428578571204;11482;11488;11514.19400641947;11638.476268568103;7702.460827742004;7909.446338756232;7992.200779921961;8204.958975205325;8212.301954333949;8878.778030549289;9103.453792772454;9163.77090572741;9182.586783594621;9187.586558605013;8429.747107586536;8458.577071146296;8484.19400156984;8510.48937063778;8608.569571521524;7810.726624568113;7911.802204944923;7980.561069141253;8138.633761480866;8235.711750088718;7694.192109828387;7721.498102623312;7729.884051739116;7733.072031356273;7733.845323093394;5224.477552244897;5343.4389389113585;5388.730563471732;5439.782408703608;5585.720713964367;5216.686998780086;5363.624546281723;5413.431589683027;5420.214068960057;5441.727913604224 19:30:12 INFO - PROCESS | 3418 | |4;prototype.html;337.39100922834285;348.08974531599864;356.30698291822415;363.8235455803936;368.9409694448889;5543.861403464915;5553.86115347116;5592.5805564582615;5593.692346920918;5606;5463.699496527689;5488.231647569333;5507.439040846006;5512.91730624041;5535.778568857241;3848.4419759134908;4129.876103716886;4209.789510524477;4273.230818452677;4386.363977223301;4352.695311328208;4356.847510337139;4361.476622805268;4371.672124590653;4381.233284175272;4348.652107831382;4349.173657005174;4351.673624478161;4353.608175264226;4374.256376416017;4108.465899433055;4158.189153115144;4312.611864932172;4381.123775244948;4443.178012067761;3855.9614403855885;3857.1514266861527;3864.903377415559;3867.9806600967095;3914.099757055893;5409.9459005409835;5426.186072089179;5437.510624043855;5442.156465747816;5453.727313634303;4832.323474713543;4927.137750893579;4983.800647974077;5027.99440111979;5031.974840125813;5678.716064196774;5691.203231547586;5711.514521265656;5720.342160651537;5729.828105156852;4201.537830838605;4216.746995180269;4229.175310814392;4256.5105012923605;4276.743395396255;5868.706564671749;5960.493358064569;6000.739844632632;6012.368701286389;6104.511639068864;4337.175936572041;4338.958649923996;4347.500037495665;4350.608445239944;4375.7374557526655;4431.446069241345;4451.50874457054;4453.242948698729;4458.7547684877645;4461.196984542748;4836.46798852126;4941.110600092018;4965.7695998250065;4993.525615066563;5043.193089105725;5756.913646295309;5762.423757624204;5764.250647415893;5768.077107662753;5781.71091445426;1524.1921781455624;1543.8070241219848;1553.495114087926;1555.6810853774948;1558.9766153507705;984.9261305402124;1003.533356988989;1015.2081376526321;1033.338663255517;1057.6562617149457;5622.297212848394;5642.915356269659;5649.745761440745;5655.943440565624;5669.744861481161;5917.437843404869;5938.673372964528;5964.254468191476;5965.28416590012;5970.522358211333;5434.722840132566;5672.631278966854;5697.9772180876025;5745.2243947067445;5752.884942301131;3165.1454107391337;3169.8415079245947;3172.952405713916;3184.3153721949893;3193.2495863472063;5842.824715258464;6146.323904370515;6159.659329454868;6161.490434843492;6193.29684336811;5801.593888427854;6085.726142323606;6106.358832322631;6122.755089796358;6126.938730612636;6019.819405417845;6020.548458865603;6104.603200792023;6174.783882564178;6174.912543728136;5916.290045194432;5983.34183239852;5986.850328741816;5989.490893274121;6007.008843540942;5634.183043458757;5871.236739223874;5883.2057672213705;5884.882302354014;5900.344844819762;6124.601900876429;6127.234095738033;6148.385161483816;6162.476189523941;6181.96909015452;4094.2016306819883;4324.2648749712;4334.696571239983;4349.282368409177;4360.28055370873;5915.822525324247;5946.910796337972;5950;5955.225820643289;5961.791337303173;5806.535477161901;5815.324950522638;5817.7963771267805;5862.179294898632;5887.61730487517;5654.575906806924;5768.423157684198;5794.797182098607;5800.390958949419;5801.6519008859605;5757.775645638456;5760.798372056958;5781.306243250669;5788.392218816964;5814.680192589279;5623.915641265303;5777.768889244383;5837.562182836389;5844.211031510692;5849.736761845812;5627.7467513961155;5655.688937108499;5686.77252909879;5688.232088668143;5736 19:30:12 INFO - PROCESS | 3418 | |5;yui.html;655.9639219842907;748.7341993592274;750.0137319424953;784.6939693519528;855.085058986884;16108.838911610881;17019.829801701995;17188;17222.39721609744;17328;15888.126153061607;16057.277422515986;16209.594760131002;16222.269997850095;16229.594260143502;682.8463595690979;698.1517456290605;785.4187900953282;801.639262331953;802.8434455281223;820.9096999330098;823.3536673711138;823.6417158536026;823.7240524424325;823.9011318641772;866.6013633728493;869.1959937058227;869.2307308032405;870.0125357718971;870.3124531620012;704.6617623540678;725.3290706096892;728.9744858929965;830.8006078541167;868.6221493650282;630.0737915264554;634.5494698763883;634.552640388525;634.9523785716044;635.9682015899186;16095.919520402324;16121.91939040309;16225.51323460298;16284.918575407166;16289;14951;14979.325930333162;14991.134221903443;15166.469173578982;15170.924145379202;13991.440342386293;14228.92885535576;14285.85714142866;14425.567232983027;14551.854481455155;4493.910121797546;4573.954260457386;4628.629709623222;4648.883777905579;4730.195866702668;87091.56454217689;87103.56448217781;88946.11053889443;88964;89064;11780.293182409083;11804.586839460577;11933.284002959677;11991.528591005357;12067.336296503601;20953.79046209549;21021.474463138544;21027.579448410946;21554.676679849814;21808;8827.69103081389;8829.60266787996;8926.553672316359;9267.536623168815;9710.902890971141;5047.071259484974;5055.241713742968;5072.315237442972;5073.822416215415;5081.28861959326;3515.771474854126;3633.7638053526434;3642.4718415829557;3644.6355364463343;3649.7627654202392;548.2707998362248;615.0865964043392;622.2222222222222;622.7384498510636;623.4856243599049;631.7536160897254;676.9811433792112;715.3776214693146;724.5290561135199;753.6344872736719;9726.805463890823;9771.902280977241;9824.263180261509;9854.802903941882;10256.282060255711;670.3531092495765;671.9025741267488;683.4566519616917;729.9744508942161;769.792156117845;4895.755212239374;4976.377952755905;5000.574951129195;5025.824096156617;5079.847604571869;133031;135431;136558.3172084153;138090;139574.1149059778;65704.34295657078;107905.92094079115;115694;116260.41869790597;118647;98179;101340.49329753304;101424.49287753661;101892.98107018984;103288;9295.07049295065;9551.570179341807;9586.808263834824;9599.514200670972;9818.509074546388;41345.586544135374;50664.74667626638;51124.23313650224;51581.74209128931;55333;52958;75701.62149189219;82008.58995704983;82157;84704;13689.31553422305;13738.793918091036;13853.79219311691;13853.79219311691;14044.648883777987;15316.540503784905;15345.462908798585;15371.538853834403;15735.606609834387;16458.177091145157;11763.882361176278;14456.638584035483;14703.19132447683;14779.408823646934;15786.763198551802;13899.6447646504;14064.859351406354;14127.505537306144;14495.130292182503;14616;13427.19436833793;13476.46094156262;13999.300034998412;14025.649358765704;14619;11917.22538035025;12145.210561313486;12236.571719989757;12421.316827574208;12813.423395947391;12469.688257793629;12552.987283052184;12565.434555444845;12681.30252836103;12932.353382331034 19:30:12 INFO - PROCESS | 3418 | __end_tp_report 19:30:12 INFO - PROCESS | 3418 | __start_cc_report 19:30:12 INFO - PROCESS | 3418 | _x_x_mozilla_cycle_collect,892 19:30:12 INFO - PROCESS | 3418 | __end_cc_report 19:30:12 INFO - PROCESS | 3418 | __startTimestamp1475116212107__endTimestamp 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | ------- Summary: start ------- 19:30:12 INFO - PROCESS | 3418 | Number of tests: 6 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#0] dojo.html Cycles:165 Average:5605.82 Median:5831.33 stddev:651.83 (11.2%) stddev-sans-first:623.28 19:30:12 INFO - PROCESS | 3418 | Values: 3091.7 3129.5 3148.2 3161.3 3179.5 5590.4 5669.4 5678.9 5702.8 5716.1 5686.0 5755.5 5760.0 5772.0 5794.2 5184.5 5206.3 5218.1 5253.0 5288.4 5044.6 5294.7 5308.0 5311.5 5339.3 5020.6 5041.8 5137.6 5169.5 5190.3 5072.5 5077.5 5089.9 5172.5 5196.1 5027.9 5071.1 5128.5 5134.0 5138.0 5371.4 5407.9 5522.9 5537.7 5569.2 5959.6 5970.8 6039.8 6063.3 6063.6 6085.3 6089.8 6090.3 6101.6 6104.7 5495.9 5530.7 5558.0 5589.0 5632.6 6193.4 6228.5 6229.6 6230.8 6236.0 5969.1 5970.7 5980.3 5981.3 5983.6 5880.5 5911.2 5927.8 5963.8 5965.5 5995.2 6002.6 6006.1 6014.2 6021.1 5964.7 6001.4 6021.6 6028.0 6040.5 4495.2 4536.0 4550.1 4605.8 4614.7 4078.6 4100.5 4117.5 4118.7 4147.5 5752.7 5755.7 5759.9 5759.9 5764.5 5907.0 5933.6 6008.5 6094.1 6105.4 5636.4 5698.9 5730.5 5733.9 5751.2 5184.4 5187.8 5191.8 5195.1 5196.9 5964.0 6184.1 6219.1 6236.7 6244.8 5892.9 5978.5 6044.4 6047.4 6111.8 6269.2 6285.1 6287.3 6292.2 6292.8 5964.3 5984.5 5986.3 5989.2 6001.3 5837.9 5965.0 5968.5 6009.6 6033.8 5906.3 5950.4 5957.2 5957.3 5983.7 5917.4 5951.0 5951.9 5953.0 5959.7 5692.6 5812.2 5817.5 5824.4 5931.0 5971.6 5983.0 5983.3 6007.0 6019.3 5825.2 5825.7 5829.9 5831.3 5831.4 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#1] ext.html Cycles:180 Average:66550.79 Median:42536.18 stddev:135873.90 (319.4%) stddev-sans-first:136164.79 19:30:12 INFO - PROCESS | 3418 | Values: 581.5 619.2 632.8 636.4 639.4 34766.7 37754.6 45346.1 46311.3 46361.3 47802.3 48571.0 48580.0 48622.5 48658.8 8407.8 9253.8 9393.0 9398.7 9400.0 8528.2 10962.5 11138.3 11159.2 11500.9 11288.4 11339.7 11372.4 11375.6 11376.8 11207.4 11249.3 11268.8 11271.5 11304.6 11017.9 11044.7 11104.9 11117.2 11125.2 44465.0 44794.3 44849.6 44856.8 44876.6 3619.6 3648.2 3779.4 4008.6 4341.0 33764.5 34079.5 34085.0 34169.3 34712.3 4641.4 4650.0 4677.6 4789.4 4843.5 339355.0 342050.0 342276.0 343155.0 343504.0 62312.4 62387.4 62594.0 62603.7 62646.7 40522.8 40652.8 41039.6 66448.0 66743.0 19007.4 19124.5 19128.0 19141.5 19144.6 13453.3 13673.4 13719.9 13721.0 13723.7 19803.1 20380.6 20494.3 21187.9 21233.2 7509.6 7544.3 7569.3 7658.2 7776.0 966.5 978.6 999.4 1019.2 1054.6 34325.5 35301.8 36005.5 36844.1 37499.8 1091.0 1180.9 1192.7 1195.5 1229.6 17671.5 17957.9 17978.7 18003.2 18092.5 657127.0 658830.0 659731.0 659975.0 664919.0 62027.7 62308.0 62343.4 62378.0 62470.0 1300.2 1371.7 1420.3 1442.1 1474.4 30681.0 34332.5 34617.5 35017.8 35037.6 52928.2 53774.0 53835.2 53867.5 53894.2 465880.0 466840.0 467992.0 469569.0 520896.0 44192.0 46932.8 47227.5 47694.8 48490.8 51805.5 51841.7 52436.7 52521.0 53292.7 41848.6 43223.8 43225.8 43742.3 45261.5 44285.0 44413.0 44607.3 44956.6 45872.5 43816.0 44332.0 44701.0 44806.8 44903.0 37686.8 38338.2 39123.4 39710.2 39758.8 29880.0 30019.6 30076.0 30324.2 30500.2 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#2] jquery.html Cycles:180 Average:30004.69 Median:2693.64 stddev:85657.01 (3180.0%) stddev-sans-first:85868.44 19:30:12 INFO - PROCESS | 3418 | Values: 394.2 413.3 420.8 424.9 432.5 14284.6 16001.0 20010.1 20108.2 20735.5 19009.6 19168.0 19517.6 19682.9 19683.0 5665.4 5682.3 5875.0 5883.2 5941.2 4345.7 5838.6 5874.1 5883.8 5885.4 4482.5 6156.5 6419.8 6420.1 6528.6 6447.2 6541.0 6561.4 6685.9 6742.5 6027.3 6029.7 6030.9 6033.6 6037.5 21976.8 23685.4 23779.3 23910.0 24007.5 2565.0 2654.7 2661.2 2726.1 2914.3 14319.8 14893.2 14994.5 15066.5 15522.5 1944.6 1961.6 1984.7 2027.2 2029.6 79449.6 80618.2 80695.0 81389.0 81604.0 11169.5 11231.6 11269.5 11537.2 11623.9 16120.6 16134.3 16135.8 16160.9 16163.1 8892.6 8983.9 9060.1 9080.5 9196.9 8742.2 8924.5 8985.8 9092.6 9107.2 6829.3 6898.8 6908.2 6934.0 6988.2 1974.4 2012.8 2019.2 2023.8 2026.8 892.8 926.9 938.0 1005.8 1015.4 18720.3 19998.5 19999.6 20183.2 20785.5 998.4 1032.4 1052.1 1097.7 1106.6 11215.2 11276.4 11516.7 11590.6 11635.1 515804.0 517291.0 517689.0 519267.0 537504.0 85805.0 86166.0 86882.1 86924.1 89009.0 1012.3 1030.3 1033.1 1043.1 1043.8 17406.8 17655.0 17897.0 17952.5 18080.3 40628.2 42740.4 42951.6 42954.6 43740.8 55027.7 55734.0 56218.0 56905.7 58573.7 6768.3 6799.7 7920.1 8880.3 9346.6 9492.4 12984.5 13605.6 13701.3 13761.0 10732.9 11137.2 11574.7 11730.2 11834.2 11216.3 11314.2 11493.8 11563.0 11799.7 6397.7 9539.5 11114.0 12071.5 12296.9 8257.2 8400.5 8430.9 8464.6 8565.8 11487.4 11743.9 11753.9 11775.8 12018.8 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#3] mootools.html Cycles:180 Average:6165.52 Median:4931.98 stddev:3640.65 (73.8%) stddev-sans-first:3634.03 19:30:12 INFO - PROCESS | 3418 | Values: 1507.0 1545.9 1667.7 1782.4 1795.4 9112.2 9816.3 9820.8 9821.1 9825.2 8131.6 8484.4 8972.1 9199.2 9264.0 2379.7 2407.8 2407.9 2410.0 2413.1 2087.8 2374.3 2375.2 2436.2 2438.3 2144.8 2308.9 2401.5 2403.1 2404.6 2367.8 2391.1 2395.3 2433.7 2474.6 2388.0 2415.2 2440.3 2440.7 2443.7 9391.3 9466.4 9491.2 9504.4 9510.7 5434.3 5533.4 5538.9 5552.4 5561.7 3340.9 3514.3 3561.0 3586.3 3588.7 1183.9 1214.1 1214.7 1231.7 1250.1 13429.7 13456.5 13575.7 13714.1 13723.2 4746.7 4756.8 4806.3 4898.9 4932.6 11342.3 11357.4 11370.5 11392.0 11406.4 5469.1 5483.1 5503.7 5522.4 5529.7 4869.5 4931.4 5049.0 5079.2 5090.0 4193.8 4194.9 4218.9 4259.3 4260.5 1268.1 1278.6 1302.0 1309.9 1313.9 891.5 932.1 954.1 960.6 961.0 5712.5 5870.2 5881.5 6035.3 6058.3 514.5 516.1 524.3 525.2 690.4 4065.8 4108.7 4125.5 4134.5 4135.2 11339.0 11712.2 11731.9 11742.4 11782.1 11661.7 11717.5 11720.1 11720.3 11743.3 8233.7 8490.9 8521.4 8750.2 8754.3 6079.4 6155.1 6161.5 6284.9 6474.3 10786.4 10891.5 11073.1 11238.4 11287.2 11428.4 11482.0 11488.0 11514.2 11638.5 7702.5 7909.4 7992.2 8205.0 8212.3 8878.8 9103.5 9163.8 9182.6 9187.6 8429.7 8458.6 8484.2 8510.5 8608.6 7810.7 7911.8 7980.6 8138.6 8235.7 7694.2 7721.5 7729.9 7733.1 7733.8 5224.5 5343.4 5388.7 5439.8 5585.7 5216.7 5363.6 5413.4 5420.2 5441.7 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#4] prototype.html Cycles:180 Average:4906.27 Median:5623.11 stddev:1423.86 (25.3%) stddev-sans-first:1385.94 19:30:12 INFO - PROCESS | 3418 | Values: 337.4 348.1 356.3 363.8 368.9 5543.9 5553.9 5592.6 5593.7 5606.0 5463.7 5488.2 5507.4 5512.9 5535.8 3848.4 4129.9 4209.8 4273.2 4386.4 4352.7 4356.8 4361.5 4371.7 4381.2 4348.7 4349.2 4351.7 4353.6 4374.3 4108.5 4158.2 4312.6 4381.1 4443.2 3856.0 3857.2 3864.9 3868.0 3914.1 5409.9 5426.2 5437.5 5442.2 5453.7 4832.3 4927.1 4983.8 5028.0 5032.0 5678.7 5691.2 5711.5 5720.3 5729.8 4201.5 4216.7 4229.2 4256.5 4276.7 5868.7 5960.5 6000.7 6012.4 6104.5 4337.2 4339.0 4347.5 4350.6 4375.7 4431.4 4451.5 4453.2 4458.8 4461.2 4836.5 4941.1 4965.8 4993.5 5043.2 5756.9 5762.4 5764.3 5768.1 5781.7 1524.2 1543.8 1553.5 1555.7 1559.0 984.9 1003.5 1015.2 1033.3 1057.7 5622.3 5642.9 5649.7 5655.9 5669.7 5917.4 5938.7 5964.3 5965.3 5970.5 5434.7 5672.6 5698.0 5745.2 5752.9 3165.1 3169.8 3173.0 3184.3 3193.2 5842.8 6146.3 6159.7 6161.5 6193.3 5801.6 6085.7 6106.4 6122.8 6126.9 6019.8 6020.5 6104.6 6174.8 6174.9 5916.3 5983.3 5986.9 5989.5 6007.0 5634.2 5871.2 5883.2 5884.9 5900.3 6124.6 6127.2 6148.4 6162.5 6182.0 4094.2 4324.3 4334.7 4349.3 4360.3 5915.8 5946.9 5950.0 5955.2 5961.8 5806.5 5815.3 5817.8 5862.2 5887.6 5654.6 5768.4 5794.8 5800.4 5801.7 5757.8 5760.8 5781.3 5788.4 5814.7 5623.9 5777.8 5837.6 5844.2 5849.7 5627.7 5655.7 5686.8 5688.2 5736.0 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - PROCESS | 3418 | [#5] yui.html Cycles:180 Average:22737.56 Median:4533.93 stddev:33993.00 (749.7%) stddev-sans-first:34047.93 19:30:12 INFO - PROCESS | 3418 | Values: 656.0 748.7 750.0 784.7 855.1 16108.8 17019.8 17188.0 17222.4 17328.0 15888.1 16057.3 16209.6 16222.3 16229.6 682.8 698.2 785.4 801.6 802.8 820.9 823.4 823.6 823.7 823.9 866.6 869.2 869.2 870.0 870.3 704.7 725.3 729.0 830.8 868.6 630.1 634.5 634.6 635.0 636.0 16095.9 16121.9 16225.5 16284.9 16289.0 14951.0 14979.3 14991.1 15166.5 15170.9 13991.4 14228.9 14285.9 14425.6 14551.9 4493.9 4574.0 4628.6 4648.9 4730.2 87091.6 87103.6 88946.1 88964.0 89064.0 11780.3 11804.6 11933.3 11991.5 12067.3 20953.8 21021.5 21027.6 21554.7 21808.0 8827.7 8829.6 8926.6 9267.5 9710.9 5047.1 5055.2 5072.3 5073.8 5081.3 3515.8 3633.8 3642.5 3644.6 3649.8 548.3 615.1 622.2 622.7 623.5 631.8 677.0 715.4 724.5 753.6 9726.8 9771.9 9824.3 9854.8 10256.3 670.4 671.9 683.5 730.0 769.8 4895.8 4976.4 5000.6 5025.8 5079.8 133031.0 135431.0 136558.3 138090.0 139574.1 65704.3 107905.9 115694.0 116260.4 118647.0 98179.0 101340.5 101424.5 101893.0 103288.0 9295.1 9551.6 9586.8 9599.5 9818.5 41345.6 50664.7 51124.2 51581.7 55333.0 52958.0 75701.6 82008.6 82157.0 84704.0 13689.3 13738.8 13853.8 13853.8 14044.6 15316.5 15345.5 15371.5 15735.6 16458.2 11763.9 14456.6 14703.2 14779.4 15786.8 13899.6 14064.9 14127.5 14495.1 14616.0 13427.2 13476.5 13999.3 14025.6 14619.0 11917.2 12145.2 12236.6 12421.3 12813.4 12469.7 12553.0 12565.4 12681.3 12932.4 19:30:12 INFO - PROCESS | 3418 | -------- Summary: end -------- 19:30:12 INFO - PROCESS | 3418 | 19:30:12 INFO - TEST-INFO | 3418: exit 0 19:30:12 INFO - TEST-OK | dromaeo_css | took 1114517ms 19:30:12 INFO - TEST-START | kraken 19:30:12 INFO - operating with platform_type : linux_ 19:30:12 INFO - Initialising browser for kraken test... 19:30:12 INFO - TEST-INFO | started process 3736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUQNEzF/profile http://localhost:38612/getInfo.html) 19:30:16 INFO - PROCESS | 3736 | __metrics Screen width/height:1600/1200 19:30:16 INFO - PROCESS | 3736 | colorDepth:24 19:30:16 INFO - PROCESS | 3736 | Browser inner width/height: 1024/697 19:30:16 INFO - PROCESS | 3736 | __metrics 19:30:17 INFO - PROCESS | 3736 | 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" 19:30:17 INFO - PROCESS | 3736 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:30:17 INFO - PROCESS | 3736 | console.error: PushService: 19:30:17 INFO - PROCESS | 3736 | stateChangeProcessEnqueue: Error transitioning state 19:30:17 INFO - PROCESS | 3736 | UnknownError 19:30:18 INFO - TEST-INFO | 3736: exit 0 19:30:18 INFO - Browser initialized. 19:30:18 INFO - Running cycle 1/1 for kraken test... 19:30:18 INFO - TEST-INFO | started process 3827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUQNEzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:29 INFO - PROCESS | 3827 | RSS: Main: 144302080 19:30:29 INFO - PROCESS | 3827 | 19:30:32 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:33 INFO - PROCESS | 3827 | RSS: Main: 186044416 19:30:33 INFO - PROCESS | 3827 | 19:30:35 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-dft) 19:30:36 INFO - PROCESS | 3827 | RSS: Main: 175419392 19:30:36 INFO - PROCESS | 3827 | 19:30:39 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-fft) 19:30:39 INFO - PROCESS | 3827 | RSS: Main: 265945088 19:30:39 INFO - PROCESS | 3827 | 19:30:41 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-oscillator) 19:30:42 INFO - PROCESS | 3827 | RSS: Main: 173555712 19:30:42 INFO - PROCESS | 3827 | 19:30:44 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:45 INFO - PROCESS | 3827 | RSS: Main: 174944256 19:30:45 INFO - PROCESS | 3827 | 19:30:48 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:48 INFO - PROCESS | 3827 | RSS: Main: 211177472 19:30:48 INFO - PROCESS | 3827 | 19:30:51 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:52 INFO - PROCESS | 3827 | RSS: Main: 209444864 19:30:52 INFO - PROCESS | 3827 | 19:30:55 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38612/tests/kraken/driver.html?testName=json-parse-financial) 19:30:55 INFO - PROCESS | 3827 | RSS: Main: 209334272 19:30:55 INFO - PROCESS | 3827 | 19:30:57 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:57 INFO - PROCESS | 3827 | RSS: Main: 172015616 19:30:57 INFO - PROCESS | 3827 | 19:30:59 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:00 INFO - PROCESS | 3827 | RSS: Main: 179363840 19:31:00 INFO - PROCESS | 3827 | 19:31:02 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:02 INFO - PROCESS | 3827 | RSS: Main: 184307712 19:31:02 INFO - PROCESS | 3827 | 19:31:05 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:06 INFO - PROCESS | 3827 | RSS: Main: 184881152 19:31:06 INFO - PROCESS | 3827 | 19:31:08 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:09 INFO - PROCESS | 3827 | RSS: Main: 182665216 19:31:09 INFO - PROCESS | 3827 | 19:31:10 INFO - PROCESS | 3827 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38612/tests/kraken/driver.html?testName=ai-astar) 19:31:11 INFO - PROCESS | 3827 | RSS: Main: 233877504 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | __start_tp_report 19:31:11 INFO - PROCESS | 3827 | _x_x_mozilla_page_load 19:31:11 INFO - PROCESS | 3827 | _x_x_mozilla_page_load_details 19:31:11 INFO - PROCESS | 3827 | |i|pagename|runs| 19:31:11 INFO - PROCESS | 3827 | |0;ai-astar;107;109;111;110;111;110;110;109;109;112 19:31:11 INFO - PROCESS | 3827 | |1;audio-beat-detection;145;115;115;157;121;117;120;120;150;120 19:31:11 INFO - PROCESS | 3827 | |2;audio-dft;160;160;159;160;161;160;159;160;162;162 19:31:11 INFO - PROCESS | 3827 | |3;audio-fft;75;75;75;112;77;76;76;75;105;75 19:31:11 INFO - PROCESS | 3827 | |4;audio-oscillator;81;80;122;80;82;82;107;81;81;115 19:31:11 INFO - PROCESS | 3827 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;116;116;117 19:31:11 INFO - PROCESS | 3827 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;146;146 19:31:11 INFO - PROCESS | 3827 | |7;imaging-desaturate;96;95;95;95;94;95;95;95;96;96 19:31:11 INFO - PROCESS | 3827 | |8;json-parse-financial;50;49;50;49;51;50;48;49;50;52 19:31:11 INFO - PROCESS | 3827 | |9;json-stringify-tinderbox;58;59;58;60;58;58;59;59;60;58 19:31:11 INFO - PROCESS | 3827 | |10;stanford-crypto-aes;74;72;72;72;73;72;75;73;74;77 19:31:11 INFO - PROCESS | 3827 | |11;stanford-crypto-ccm;123;120;132;127;121;127;118;115;163;127 19:31:11 INFO - PROCESS | 3827 | |12;stanford-crypto-pbkdf2;156;158;157;151;153;154;153;153;158;155 19:31:11 INFO - PROCESS | 3827 | |13;stanford-crypto-sha256-iterative;64;61;62;61;61;61;61;61;67;60 19:31:11 INFO - PROCESS | 3827 | __end_tp_report 19:31:11 INFO - PROCESS | 3827 | __start_cc_report 19:31:11 INFO - PROCESS | 3827 | _x_x_mozilla_cycle_collect,1610 19:31:11 INFO - PROCESS | 3827 | __end_cc_report 19:31:11 INFO - PROCESS | 3827 | __startTimestamp1475116271136__endTimestamp 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | ------- Summary: start ------- 19:31:11 INFO - PROCESS | 3827 | Number of tests: 14 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.40 (1.3%) stddev-sans-first:1.05 19:31:11 INFO - PROCESS | 3827 | Values: 107.0 109.0 111.0 110.0 111.0 110.0 110.0 109.0 109.0 112.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:120.50 stddev:16.03 (13.3%) stddev-sans-first:15.78 19:31:11 INFO - PROCESS | 3827 | Values: 145.0 115.0 115.0 157.0 121.0 117.0 120.0 120.0 150.0 120.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 19:31:11 INFO - PROCESS | 3827 | Values: 160.0 160.0 159.0 160.0 161.0 160.0 159.0 160.0 162.0 162.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.03 (18.7%) stddev-sans-first:14.64 19:31:11 INFO - PROCESS | 3827 | Values: 75.0 75.0 75.0 112.0 77.0 76.0 76.0 75.0 105.0 75.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.00 stddev:16.66 (20.6%) stddev-sans-first:17.26 19:31:11 INFO - PROCESS | 3827 | Values: 81.0 80.0 122.0 80.0 82.0 82.0 107.0 81.0 81.0 115.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:31:11 INFO - PROCESS | 3827 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 19:31:11 INFO - PROCESS | 3827 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:31:11 INFO - PROCESS | 3827 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:1.14 (2.3%) stddev-sans-first:1.20 19:31:11 INFO - PROCESS | 3827 | Values: 50.0 49.0 50.0 49.0 51.0 50.0 48.0 49.0 50.0 52.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 19:31:11 INFO - PROCESS | 3827 | Values: 58.0 59.0 58.0 60.0 58.0 58.0 59.0 59.0 60.0 58.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.50 stddev:1.65 (2.2%) stddev-sans-first:1.73 19:31:11 INFO - PROCESS | 3827 | Values: 74.0 72.0 72.0 72.0 73.0 72.0 75.0 73.0 74.0 77.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:127.00 stddev:13.52 (10.6%) stddev-sans-first:14.25 19:31:11 INFO - PROCESS | 3827 | Values: 123.0 120.0 132.0 127.0 121.0 127.0 118.0 115.0 163.0 127.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.50 stddev:2.39 (1.5%) stddev-sans-first:2.50 19:31:11 INFO - PROCESS | 3827 | Values: 156.0 158.0 157.0 151.0 153.0 154.0 153.0 153.0 158.0 155.0 19:31:11 INFO - PROCESS | 3827 | 19:31:11 INFO - PROCESS | 3827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.00 stddev:2.08 (3.4%) stddev-sans-first:2.06 19:31:11 INFO - PROCESS | 3827 | Values: 64.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 67.0 60.0 19:31:11 INFO - PROCESS | 3827 | -------- Summary: end -------- 19:31:11 INFO - PROCESS | 3827 | 19:31:12 INFO - TEST-INFO | 3827: exit 0 19:31:12 INFO - TEST-OK | kraken | took 59335ms 19:31:12 INFO - SUITE-END | took 1173s 19:31:12 INFO - Completed test suite (00:19:33) 19:31:12 INFO - javascript benchmark 19:31:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.7062879026494, 3129.499280115182, 3148.1814728170684, 3161.320316132034, 3179.4912813949772, 5590.440955904408, 5669.376368599456, 5678.914816277759, 5702.8289151325425, 5716.11400232964, 5686.0, 5755.510781583571, 5759.963206622806, 5771.989901767184, 5794.188813566104, 5184.53339199472, 5206.3231779868565, 5218.13900706383, 5253.028189784883, 5288.418273989858, 5044.596432285427, 5294.708791016493, 5308.044551980642, 5311.548518375943, 5339.305890234265, 5020.6234532410035, 5041.8487445376695, 5137.5633071188995, 5169.457206993268, 5190.273361729361, 5072.4673909239555, 5077.466865979056, 5089.872753181163, 5172.508611681884, 5196.1166601677805, 5027.899442011176, 5071.087204303224, 5128.512791284822, 5134.0, 5138.0, 5371.435999220103, 5407.945920540823, 5522.861928451781, 5537.667739935617, 5569.220309156722, 5959.582829201958, 5970.791022314242, 6039.849003774897, 6063.333033366371, 6063.575549711522, 6085.269767627913, 6089.817305480843, 6090.33006369299, 6101.572889897709, 6104.725287362079, 5495.890082198333, 5530.723463826793, 5557.972210138963, 5589.0, 5632.5775566831835, 6193.411625895533, 6228.532860035515, 6229.626222426669, 6230.7819226326865, 6236.0, 5969.134475501028, 5970.731317090655, 5980.282366116094, 5981.282246130492, 5983.551233657493, 5880.470757631833, 5911.231539899872, 5927.762889484372, 5963.7912673056235, 5965.522758179335, 5995.160677505153, 6002.609830361012, 6006.069059295816, 6014.248218972629, 6021.066734656135, 5964.7315870785915, 6001.369856165127, 6021.608595441282, 6027.969860150759, 6040.456358927718, 4495.235809912323, 4535.9546404536195, 4550.112728018004, 4605.815767369335, 4614.723116612947, 4078.6125318094732, 4100.507939047334, 4117.547069822317, 4118.670506359544, 4147.4815648044, 5752.712364381764, 5755.65466072037, 5759.913601295984, 5759.94240057594, 5764.510016648548, 5907.0, 5933.58464907461, 6008.489278411296, 6094.146819445281, 6105.389461053859, 5636.436356364331, 5698.857528561736, 5730.541556675539, 5733.885322293614, 5751.223584815996, 5184.403793563713, 5187.766550505236, 5191.844244672666, 5195.090859099642, 5196.8960620787375, 5963.970180149072, 6184.072389141665, 6219.098230756515, 6236.656983865931, 6244.812655620339, 5892.852678683067, 5978.491828194478, 6044.365341639064, 6047.365026672136, 6111.834843226386, 6269.216347956505, 6285.057241413824, 6287.308396076336, 6292.18201633803, 6292.842678933063, 5964.343922168471, 5984.521238300838, 5986.311574169026, 5989.191459153133, 6001.279846418283, 5837.883242335045, 5964.985952388018, 5968.4926781224085, 6009.579329446897, 6033.758649653964, 5906.291245050621, 5950.434708702666, 5957.195778569838, 5957.314908785545, 5983.730732116978, 5917.378675239038, 5950.9702451487465, 5951.91072133927, 5953.0, 5959.73181206838, 5692.601517893873, 5812.157237200667, 5817.476427121579, 5824.446677565625, 5931.021381472009, 5971.552133590085, 5983.0, 5983.34183239852, 6007.0, 6019.337872833898, 5825.2135961644635, 5825.70871456434, 5829.854253643523, 5831.329397119385, 5831.416858314305], "value": 5559.7946479246375, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.5115303145357, 619.2476141488092, 632.7627139822564, 636.3890664961638, 639.3510586754448, 34766.65233347666, 37754.62245377549, 45346.09307813846, 46311.30533042007, 46361.30458043132, 47802.28296575554, 48571.0, 48580.0, 48622.51377486233, 48658.756706216416, 8407.831843363128, 9253.76865578361, 9392.953035234848, 9398.718038458823, 9400.0, 8528.189821966904, 10962.506687199095, 11138.27601205923, 11159.218854680175, 11500.884991150066, 11288.435578221057, 11339.659810205707, 11372.37451940143, 11375.601853935113, 11376.829347559793, 11207.383593902332, 11249.268797528217, 11268.774624507463, 11271.549138034468, 11304.604338848101, 11017.889821101766, 11044.668659940215, 11104.888951110546, 11117.166212534092, 11125.165612579009, 44465.0, 44794.32808507875, 44849.551504484865, 44856.775716121214, 44876.55123448789, 3619.6199399062984, 3648.1791596890753, 3779.433085037239, 4008.5590585035625, 4340.956590434118, 33764.49353259703, 34079.488807667905, 34085.0, 34169.316613667834, 34712.30575388478, 4641.419822522184, 4649.953500464986, 4677.6257899367965, 4789.401324834395, 4843.515648435128, 339355.0, 342050.0, 342276.0, 343155.0, 343504.0, 62312.37687623066, 62387.37612623906, 62594.0, 62603.6869815648, 62646.68676656587, 40522.79738601347, 40652.79673601613, 41039.589604103574, 66448.0, 66743.0, 19007.42977710671, 19124.521886952938, 19128.0, 19141.521461963282, 19144.61710765777, 13453.327333633279, 13673.384697688627, 13719.931400342934, 13721.0, 13723.656908577166, 19803.10886010133, 20380.592388152152, 20494.282700105425, 21187.894060529597, 21233.15067397287, 7509.62451877404, 7544.283293087148, 7569.318761311509, 7658.195889431641, 7775.961120194476, 966.4781018250067, 978.6281213138961, 999.3753903810118, 1019.2152042926905, 1054.5939813171983, 34325.485117723256, 35301.82349088238, 36005.45991810125, 36844.07889802723, 37499.81250093732, 1091.0, 1180.9173357865038, 1192.6899006258436, 1195.5098409652, 1229.6495498782804, 17671.469855904343, 17957.910210449125, 17978.730319045226, 18003.18985645649, 18092.54768630795, 657127.0, 658830.0, 659731.0, 659975.0, 664919.0, 62027.6898615504, 62308.0, 62343.37656623466, 62378.0, 62470.0, 1300.1873828856965, 1371.6776557508977, 1420.34664054534, 1442.0626592714818, 1474.366022610288, 30681.0, 34332.48501272533, 34617.48073778845, 35017.824910875286, 35037.649623503436, 52928.20607690965, 53774.0, 53835.19247211217, 53867.46132538625, 53894.19158712701, 465880.0, 466840.0, 467992.0, 469569.0, 520896.0, 44192.0, 46932.7653361731, 47227.52772472231, 47694.761526192146, 48490.757546212044, 51805.481945180065, 51841.7407912958, 52436.73781631068, 52521.0, 53292.73353633207, 41848.581514184465, 43223.783881080395, 43225.7838710817, 43742.34386484269, 45261.54738452574, 44285.00717467786, 44413.0, 44607.33089003732, 44956.550434495235, 45872.54127458816, 43816.0, 44332.0, 44701.0, 44806.77596612126, 44903.0, 37686.81156594199, 38338.2332353357, 39123.413148802225, 39710.20579588334, 39758.80120599378, 29880.0, 30019.574320473574, 30076.0, 30324.241893951945, 30500.237494062825], "value": 21998.43015989691, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.1938735286339, 413.26851472893, 420.8127383314425, 424.89590050437636, 432.5242233543103, 14284.571462856105, 16001.0, 20010.09954552045, 20108.195672173133, 20735.481612959684, 19009.619807603875, 19168.0, 19517.609647807036, 19682.901585492087, 19683.015849207553, 5665.405132461105, 5682.318121825387, 5874.970625146868, 5883.17635531026, 5941.197938278342, 4345.69580129391, 5838.591298609099, 5874.060150375941, 5883.794067207648, 5885.382034886318, 4482.5069242383315, 6156.507479401659, 6419.839504012413, 6420.101185833987, 6528.6409247491365, 6447.226332840042, 6541.0, 6561.409473147416, 6685.8662826743675, 6742.49431292655, 6027.336992930774, 6029.728662210211, 6030.909536356959, 6033.637981721111, 6037.516998640098, 21976.780232197634, 23685.407864803346, 23779.286621401214, 23910.0, 24007.519849603086, 2564.9871750641314, 2654.734526547349, 2661.2149415922154, 2726.073135134064, 2914.344272538683, 14319.78520322196, 14893.180875051868, 14994.47519336829, 15066.472673456487, 15522.5343239703, 1944.5527528668486, 1961.6174845905055, 1984.662607356753, 2027.2499175305084, 2029.645611091142, 79449.60275198644, 80618.19381806166, 80695.0, 81389.0, 81604.0, 11169.497372618089, 11231.550737970552, 11269.54921803135, 11537.192396532162, 11623.941880290544, 16120.596985075232, 16134.273957671932, 16135.757963630555, 16160.919195404183, 16163.111028893523, 8892.64429422816, 8983.910160898438, 9060.093990600888, 9080.500572468578, 9196.862047069299, 8742.213200811957, 8924.464532128093, 8985.775355616162, 9092.636294548276, 9107.22588579965, 6829.282925292872, 6898.758543451056, 6908.205556360982, 6933.965330173317, 6988.196357418962, 1974.3682021752902, 2012.7685316188827, 2019.1721394228296, 2023.8279746221735, 2026.8277196438173, 892.7544925145637, 926.8887733472027, 937.9776044111951, 1005.7737009172878, 1015.3907655406697, 18720.251189952523, 19998.50003749889, 19999.60004799404, 20183.192672293237, 20785.480362991046, 998.3810037776625, 1032.3547782635853, 1052.0899421999916, 1097.665212110298, 1106.590561492237, 11215.158863085302, 11276.406426521946, 11516.712082198012, 11590.594329198437, 11635.127365447624, 515804.0, 517291.0, 517689.0, 519267.0, 537504.0, 85805.0, 86166.0, 86882.13117868867, 86924.13075869287, 89009.0, 1012.2762225009154, 1030.253066526762, 1033.0805583030958, 1043.087298613713, 1043.8121138195197, 17406.825931741027, 17655.0, 17897.0, 17952.461426157235, 18080.276788928295, 40628.18743625052, 42740.35889461599, 42951.57048429476, 42954.57045429631, 43740.781296093315, 55027.724861375435, 55734.0, 56218.0, 56905.71547142238, 58573.70713146407, 6768.323167683192, 6799.694013769294, 7920.128785833669, 8880.28957683371, 9346.626134954799, 9492.382995105296, 12984.480620775063, 13605.591832245049, 13701.314934253049, 13761.0, 10732.892671073188, 11137.164712646745, 11574.6527604172, 11730.178887477794, 11834.171607987359, 11216.270942388719, 11314.15143864197, 11493.827592586285, 11563.0, 11799.705007374885, 6397.680115994275, 9539.523023848918, 11113.999740023437, 12071.456784444897, 12296.877031229573, 8257.21556452136, 8400.537970411686, 8430.873536897074, 8464.619092140745, 8565.828683426422, 11487.368194749035, 11743.882561174622, 11753.941230293794, 11775.823362649739, 12018.75962480728], "value": 9594.2114089173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.9547913562594, 1545.8917875748698, 1667.6831402033613, 1782.4474412931984, 1795.416489640867, 9112.179903808665, 9816.312858099936, 9820.803583928317, 9821.116099551038, 9825.164860986815, 8131.59342032899, 8484.44851084679, 8972.102789721024, 9199.17207451331, 9263.980962094165, 2379.666846641467, 2407.7953373963232, 2407.9398015049587, 2409.987950060256, 2413.1312727418117, 2087.8434117441175, 2374.3351861478814, 2375.192434572245, 2436.232586735173, 2438.2928950604305, 2144.7855214478504, 2308.8730119843403, 2401.495685905953, 2403.0748161957686, 2404.615261558151, 2367.846090004144, 2391.0555330644384, 2395.3053614451787, 2433.707955045388, 2474.6411770293385, 2387.9522409551887, 2415.1788391946648, 2440.2679196241056, 2440.7437219091917, 2443.706755189371, 9391.34260601758, 9466.384684995523, 9491.240700743923, 9504.42973421597, 9510.667126650535, 5434.266374039494, 5533.418991005927, 5538.944610553883, 5552.416996215379, 5561.721913904329, 3340.916477088068, 3514.3147086318177, 3561.0, 3586.264815712773, 3588.74878758487, 1183.8638556566018, 1214.089432925306, 1214.690253985228, 1231.7043909461754, 1250.0936820804934, 13429.731405371838, 13456.5290214842, 13575.660608484866, 13714.108582942077, 13723.245221512812, 4746.715197088186, 4756.831751851889, 4806.303086052572, 4898.853034408973, 4932.580730637936, 11342.262752921033, 11357.432128393548, 11370.54517819278, 11392.0, 11406.42967851604, 5469.07025805614, 5483.122700367922, 5503.697296648723, 5522.392536820947, 5529.723513824292, 4869.513048695102, 4931.3835770528685, 5049.040682270357, 5079.212722028092, 5090.0, 4193.7693426861815, 4194.853180138681, 4218.8523401680795, 4259.2759230930815, 4260.488741351058, 1268.0869773762877, 1278.6419802455327, 1302.0, 1309.941052652614, 1313.947442102305, 891.5453118909273, 932.0912110692157, 954.0936110694868, 960.5917485068818, 960.9711708648751, 5712.542996560265, 5870.236869206976, 5881.470667639847, 6035.275766907999, 6058.27300723916, 514.5258833442161, 516.1483552139001, 524.2607922828793, 525.1676093392016, 690.3579670906106, 4065.776382299002, 4108.712390132662, 4125.525564560054, 4134.462519872457, 4135.152293779768, 11339.0, 11712.180147389772, 11731.941340293244, 11742.412879355998, 11782.116341274439, 11661.6501504955, 11717.472713727902, 11720.120990925714, 11720.296782193096, 11743.295402275891, 8233.711820086268, 8490.915090849012, 8521.36089793268, 8750.168733970135, 8754.343424243207, 6079.392060793885, 6155.1382806406245, 6161.537884658758, 6284.874302513833, 6474.320196379501, 10786.352818830896, 10891.455427228766, 11073.11415086775, 11238.438078096226, 11287.20989530725, 11428.428578571204, 11482.0, 11488.0, 11514.19400641947, 11638.476268568103, 7702.460827742004, 7909.446338756232, 7992.200779921961, 8204.958975205325, 8212.301954333949, 8878.778030549289, 9103.453792772454, 9163.77090572741, 9182.586783594621, 9187.586558605013, 8429.747107586536, 8458.577071146296, 8484.19400156984, 8510.48937063778, 8608.569571521524, 7810.726624568113, 7911.802204944923, 7980.561069141253, 8138.633761480866, 8235.711750088718, 7694.192109828387, 7721.498102623312, 7729.884051739116, 7733.072031356273, 7733.845323093394, 5224.477552244897, 5343.4389389113585, 5388.730563471732, 5439.782408703608, 5585.720713964367, 5216.686998780086, 5363.624546281723, 5413.431589683027, 5420.214068960057, 5441.727913604224], "value": 4809.105865521725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.39100922834285, 348.08974531599864, 356.30698291822415, 363.8235455803936, 368.9409694448889, 5543.861403464915, 5553.86115347116, 5592.5805564582615, 5593.692346920918, 5606.0, 5463.699496527689, 5488.231647569333, 5507.439040846006, 5512.91730624041, 5535.778568857241, 3848.4419759134908, 4129.876103716886, 4209.789510524477, 4273.230818452677, 4386.363977223301, 4352.695311328208, 4356.847510337139, 4361.476622805268, 4371.672124590653, 4381.233284175272, 4348.652107831382, 4349.173657005174, 4351.673624478161, 4353.608175264226, 4374.256376416017, 4108.465899433055, 4158.189153115144, 4312.611864932172, 4381.123775244948, 4443.178012067761, 3855.9614403855885, 3857.1514266861527, 3864.903377415559, 3867.9806600967095, 3914.099757055893, 5409.9459005409835, 5426.186072089179, 5437.510624043855, 5442.156465747816, 5453.727313634303, 4832.323474713543, 4927.137750893579, 4983.800647974077, 5027.99440111979, 5031.974840125813, 5678.716064196774, 5691.203231547586, 5711.514521265656, 5720.342160651537, 5729.828105156852, 4201.537830838605, 4216.746995180269, 4229.175310814392, 4256.5105012923605, 4276.743395396255, 5868.706564671749, 5960.493358064569, 6000.739844632632, 6012.368701286389, 6104.511639068864, 4337.175936572041, 4338.958649923996, 4347.500037495665, 4350.608445239944, 4375.7374557526655, 4431.446069241345, 4451.50874457054, 4453.242948698729, 4458.7547684877645, 4461.196984542748, 4836.46798852126, 4941.110600092018, 4965.7695998250065, 4993.525615066563, 5043.193089105725, 5756.913646295309, 5762.423757624204, 5764.250647415893, 5768.077107662753, 5781.71091445426, 1524.1921781455624, 1543.8070241219848, 1553.495114087926, 1555.6810853774948, 1558.9766153507705, 984.9261305402124, 1003.533356988989, 1015.2081376526321, 1033.338663255517, 1057.6562617149457, 5622.297212848394, 5642.915356269659, 5649.745761440745, 5655.943440565624, 5669.744861481161, 5917.437843404869, 5938.673372964528, 5964.254468191476, 5965.28416590012, 5970.522358211333, 5434.722840132566, 5672.631278966854, 5697.9772180876025, 5745.2243947067445, 5752.884942301131, 3165.1454107391337, 3169.8415079245947, 3172.952405713916, 3184.3153721949893, 3193.2495863472063, 5842.824715258464, 6146.323904370515, 6159.659329454868, 6161.490434843492, 6193.29684336811, 5801.593888427854, 6085.726142323606, 6106.358832322631, 6122.755089796358, 6126.938730612636, 6019.819405417845, 6020.548458865603, 6104.603200792023, 6174.783882564178, 6174.912543728136, 5916.290045194432, 5983.34183239852, 5986.850328741816, 5989.490893274121, 6007.008843540942, 5634.183043458757, 5871.236739223874, 5883.2057672213705, 5884.882302354014, 5900.344844819762, 6124.601900876429, 6127.234095738033, 6148.385161483816, 6162.476189523941, 6181.96909015452, 4094.2016306819883, 4324.2648749712, 4334.696571239983, 4349.282368409177, 4360.28055370873, 5915.822525324247, 5946.910796337972, 5950.0, 5955.225820643289, 5961.791337303173, 5806.535477161901, 5815.324950522638, 5817.7963771267805, 5862.179294898632, 5887.61730487517, 5654.575906806924, 5768.423157684198, 5794.797182098607, 5800.390958949419, 5801.6519008859605, 5757.775645638456, 5760.798372056958, 5781.306243250669, 5788.392218816964, 5814.680192589279, 5623.915641265303, 5777.768889244383, 5837.562182836389, 5844.211031510692, 5849.736761845812, 5627.7467513961155, 5655.688937108499, 5686.77252909879, 5688.232088668143, 5736.0], "value": 4457.2728950063965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.9639219842907, 748.7341993592274, 750.0137319424953, 784.6939693519528, 855.085058986884, 16108.838911610881, 17019.829801701995, 17188.0, 17222.39721609744, 17328.0, 15888.126153061607, 16057.277422515986, 16209.594760131002, 16222.269997850095, 16229.594260143502, 682.8463595690979, 698.1517456290605, 785.4187900953282, 801.639262331953, 802.8434455281223, 820.9096999330098, 823.3536673711138, 823.6417158536026, 823.7240524424325, 823.9011318641772, 866.6013633728493, 869.1959937058227, 869.2307308032405, 870.0125357718971, 870.3124531620012, 704.6617623540678, 725.3290706096892, 728.9744858929965, 830.8006078541167, 868.6221493650282, 630.0737915264554, 634.5494698763883, 634.552640388525, 634.9523785716044, 635.9682015899186, 16095.919520402324, 16121.91939040309, 16225.51323460298, 16284.918575407166, 16289.0, 14951.0, 14979.325930333162, 14991.134221903443, 15166.469173578982, 15170.924145379202, 13991.440342386293, 14228.92885535576, 14285.85714142866, 14425.567232983027, 14551.854481455155, 4493.910121797546, 4573.954260457386, 4628.629709623222, 4648.883777905579, 4730.195866702668, 87091.56454217689, 87103.56448217781, 88946.11053889443, 88964.0, 89064.0, 11780.293182409083, 11804.586839460577, 11933.284002959677, 11991.528591005357, 12067.336296503601, 20953.79046209549, 21021.474463138544, 21027.579448410946, 21554.676679849814, 21808.0, 8827.69103081389, 8829.60266787996, 8926.553672316359, 9267.536623168815, 9710.902890971141, 5047.071259484974, 5055.241713742968, 5072.315237442972, 5073.822416215415, 5081.28861959326, 3515.771474854126, 3633.7638053526434, 3642.4718415829557, 3644.6355364463343, 3649.7627654202392, 548.2707998362248, 615.0865964043392, 622.2222222222222, 622.7384498510636, 623.4856243599049, 631.7536160897254, 676.9811433792112, 715.3776214693146, 724.5290561135199, 753.6344872736719, 9726.805463890823, 9771.902280977241, 9824.263180261509, 9854.802903941882, 10256.282060255711, 670.3531092495765, 671.9025741267488, 683.4566519616917, 729.9744508942161, 769.792156117845, 4895.755212239374, 4976.377952755905, 5000.574951129195, 5025.824096156617, 5079.847604571869, 133031.0, 135431.0, 136558.3172084153, 138090.0, 139574.1149059778, 65704.34295657078, 107905.92094079115, 115694.0, 116260.41869790597, 118647.0, 98179.0, 101340.49329753304, 101424.49287753661, 101892.98107018984, 103288.0, 9295.07049295065, 9551.570179341807, 9586.808263834824, 9599.514200670972, 9818.509074546388, 41345.586544135374, 50664.74667626638, 51124.23313650224, 51581.74209128931, 55333.0, 52958.0, 75701.62149189219, 82008.58995704983, 82157.0, 84704.0, 13689.31553422305, 13738.793918091036, 13853.79219311691, 13853.79219311691, 14044.648883777987, 15316.540503784905, 15345.462908798585, 15371.538853834403, 15735.606609834387, 16458.177091145157, 11763.882361176278, 14456.638584035483, 14703.19132447683, 14779.408823646934, 15786.763198551802, 13899.6447646504, 14064.859351406354, 14127.505537306144, 14495.130292182503, 14616.0, 13427.19436833793, 13476.46094156262, 13999.300034998412, 14025.649358765704, 14619.0, 11917.22538035025, 12145.210561313486, 12236.571719989757, 12421.316827574208, 12813.423395947391, 12469.688257793629, 12552.987283052184, 12565.434555444845, 12681.30252836103, 12932.353382331034], "value": 7938.500803618716, "unit": "score"}], "name": "dromaeo_css", "value": 7645.327339468341, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 111.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 112.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 115.0, 157.0, 121.0, 117.0, 120.0, 120.0, 150.0, 120.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 160.0, 161.0, 160.0, 159.0, 160.0, 162.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 112.0, 77.0, 76.0, 76.0, 75.0, 105.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 122.0, 80.0, 82.0, 82.0, 107.0, 81.0, 81.0, 115.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 49.0, 51.0, 50.0, 48.0, 49.0, 50.0, 52.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 60.0, 58.0, 58.0, 59.0, 59.0, 60.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 72.0, 73.0, 72.0, 75.0, 73.0, 74.0, 77.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 132.0, 127.0, 121.0, 127.0, 118.0, 115.0, 163.0, 127.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 157.0, 151.0, 153.0, 154.0, 153.0, 153.0, 158.0, 155.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 67.0, 60.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1455.2000000000003, "alertThreshold": 2.0}]} 19:31:12 INFO - Return code: 0 19:31:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:12 INFO - # TBPL SUCCESS # 19:31:12 INFO - Running post-action listener: _resource_record_post_action 19:31:12 INFO - [mozharness: 2016-09-29 02:31:12.452523Z] Finished run-tests step (success) 19:31:12 INFO - Running post-run listener: _resource_record_post_run 19:31:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8003584; Write bytes: 377651200; Read time: 1596; Write time: 341636 19:31:12 INFO - TinderboxPrint: CPU usage
12.9% 19:31:12 INFO - TinderboxPrint: I/O read bytes / time
8,003,584 / 1,596 19:31:12 INFO - TinderboxPrint: I/O write bytes / time
377,651,200 / 341,636 19:31:12 INFO - TinderboxPrint: CPU idle
8,271.6 (87.1%) 19:31:12 INFO - TinderboxPrint: CPU user
1,181.8 (12.4%) 19:31:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 536576; Read time: 0; Write time: 52 19:31:12 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5754880; Write bytes: 311226368; Read time: 1128; Write time: 278060 19:31:13 INFO - Running post-run listener: _upload_blobber_files 19:31:13 INFO - Blob upload gear active. 19:31:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:13 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 19:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:17 INFO - (blobuploader) - INFO - Done attempting. 19:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:18 INFO - (blobuploader) - INFO - Done attempting. 19:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:19 INFO - (blobuploader) - INFO - Done attempting. 19:31:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:19 INFO - Return code: 0 19:31:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42b8d39977850e6b507a3e7280e6b63e4f48c3dd896f1b4bda587848d29c9dd21c7acebbf80c2eb3810b689b696f9a93ff0ca5e577b7a9a573dc9603bb68c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f5b5f3878d58577afbba75482e69c8410321d9afd0e8231949b95537e523f8fa636bfc06c7e78781e5343cdef1622ee8c28dcf29883c94e8f0e5e6178384b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4181cfe4d4092c0a28a1c37e26dd8a95a445c3a1b28eeaefad072a8fce24b4e2d645fa916748ed5a8b27cf44df1873b3f9d6033e81fc354becbbd5baa9a253a6"} 19:31:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:19 INFO - Contents: 19:31:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42b8d39977850e6b507a3e7280e6b63e4f48c3dd896f1b4bda587848d29c9dd21c7acebbf80c2eb3810b689b696f9a93ff0ca5e577b7a9a573dc9603bb68c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f5b5f3878d58577afbba75482e69c8410321d9afd0e8231949b95537e523f8fa636bfc06c7e78781e5343cdef1622ee8c28dcf29883c94e8f0e5e6178384b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4181cfe4d4092c0a28a1c37e26dd8a95a445c3a1b28eeaefad072a8fce24b4e2d645fa916748ed5a8b27cf44df1873b3f9d6033e81fc354becbbd5baa9a253a6"} 19:31:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:19 INFO - Copying logs to upload dir... 19:31:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.466434 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-28 19:31:19.294972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:31:19.298169) ========= 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=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42b8d39977850e6b507a3e7280e6b63e4f48c3dd896f1b4bda587848d29c9dd21c7acebbf80c2eb3810b689b696f9a93ff0ca5e577b7a9a573dc9603bb68c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f5b5f3878d58577afbba75482e69c8410321d9afd0e8231949b95537e523f8fa636bfc06c7e78781e5343cdef1622ee8c28dcf29883c94e8f0e5e6178384b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4181cfe4d4092c0a28a1c37e26dd8a95a445c3a1b28eeaefad072a8fce24b4e2d645fa916748ed5a8b27cf44df1873b3f9d6033e81fc354becbbd5baa9a253a6"} build_url:https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/VtoBmlNLTBOyEoSu4IN30Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a42b8d39977850e6b507a3e7280e6b63e4f48c3dd896f1b4bda587848d29c9dd21c7acebbf80c2eb3810b689b696f9a93ff0ca5e577b7a9a573dc9603bb68c19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68f5b5f3878d58577afbba75482e69c8410321d9afd0e8231949b95537e523f8fa636bfc06c7e78781e5343cdef1622ee8c28dcf29883c94e8f0e5e6178384b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4181cfe4d4092c0a28a1c37e26dd8a95a445c3a1b28eeaefad072a8fce24b4e2d645fa916748ed5a8b27cf44df1873b3f9d6033e81fc354becbbd5baa9a253a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 19:31:19.324421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:31:19.324806) ========= 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=db0483c52d987ecb441a263b000001ad-1475114042.77042-212637007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 19:31:19.406840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:31:19.407188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 19:31:19.407518) ========= ========= Total master_lag: 0.20 =========