builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1471669944.42 results: success (0) buildid: 20160819193009 builduid: 6aa7d1a0614b46b3a085e7649bb2f7b0 revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.421990) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.422463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.422777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.465332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.465662) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 22:12:24-- 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% 112M=0s 2016-08-19 22:12:25 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.396879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.873756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.874154) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020411 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.923759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:24.924324) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 22:12:25,287 truncating revision to first 12 chars 2016-08-19 22:12:25,287 Setting DEBUG logging. 2016-08-19 22:12:25,287 attempt 1/10 2016-08-19 22:12:25,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f97a056ae623?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 22:12:25,625 unpacking tar archive at: mozilla-central-f97a056ae623/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:25.605520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:25.605985) ========= script_repo_revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:25.606676) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:25.607174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 22:12:25.621511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-19 22:12:25.621829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:26 INFO - MultiFileLogger online at 20160819 22:12:26 in /builds/slave/test 22:12:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:12:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:26 INFO - {'append_to_log': False, 22:12:26 INFO - 'base_work_dir': '/builds/slave/test', 22:12:26 INFO - 'blob_upload_branch': 'Firefox', 22:12:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:26 INFO - 'branch': 'Firefox', 22:12:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:26 INFO - 'config_files': ('talos/linux_config.py',), 22:12:26 INFO - 'default_actions': ('clobber', 22:12:26 INFO - 'read-buildbot-config', 22:12:26 INFO - 'download-and-extract', 22:12:26 INFO - 'populate-webroot', 22:12:26 INFO - 'create-virtualenv', 22:12:26 INFO - 'install', 22:12:26 INFO - 'run-tests'), 22:12:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:26 INFO - 'download_minidump_stackwalk': True, 22:12:26 INFO - 'download_symbols': 'ondemand', 22:12:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:26 INFO - 'installer_path': 'installer.exe', 22:12:26 INFO - 'log_level': 'info', 22:12:26 INFO - 'log_name': 'talos', 22:12:26 INFO - 'log_to_console': True, 22:12:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:26 INFO - 'opt_config_files': (), 22:12:26 INFO - 'pip_index': False, 22:12:26 INFO - 'sps_profile': False, 22:12:26 INFO - 'sps_profile_interval': 0, 22:12:26 INFO - 'suite': 'dromaeojs-e10s', 22:12:26 INFO - 'system_bits': '32', 22:12:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:26 INFO - 'title': 'talos-linux64-ix-037', 22:12:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:26 INFO - 'use_talos_json': True, 22:12:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:26 INFO - 'work_dir': 'build'} 22:12:26 INFO - [mozharness: 2016-08-20 05:12:26.094326Z] Running clobber step. 22:12:26 INFO - Running pre-action listener: _resource_record_pre_action 22:12:26 INFO - Running main action method: clobber 22:12:26 INFO - rmtree: /builds/slave/test/build 22:12:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:26 INFO - Running post-action listener: _resource_record_post_action 22:12:26 INFO - [mozharness: 2016-08-20 05:12:26.549664Z] Finished clobber step (success) 22:12:26 INFO - [mozharness: 2016-08-20 05:12:26.549764Z] Running read-buildbot-config step. 22:12:26 INFO - Running pre-action listener: _resource_record_pre_action 22:12:26 INFO - Running main action method: read_buildbot_config 22:12:26 INFO - Using buildbot properties: 22:12:26 INFO - { 22:12:26 INFO - "project": "", 22:12:26 INFO - "product": "firefox", 22:12:26 INFO - "script_repo_revision": "production", 22:12:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:12:26 INFO - "repository": "", 22:12:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:12:26 INFO - "buildid": "20160819193009", 22:12:26 INFO - "pgo_build": "True", 22:12:26 INFO - "basedir": "/builds/slave/test", 22:12:26 INFO - "buildnumber": 324, 22:12:26 INFO - "slavename": "talos-linux64-ix-037", 22:12:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:12:26 INFO - "platform": "ubuntu64_hw", 22:12:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:12:26 INFO - "branch": "mozilla-central", 22:12:26 INFO - "repo_path": "mozilla-central", 22:12:26 INFO - "revision": "f97a056ae6235de7855fd8aaa04fb1c8d183bd06", 22:12:26 INFO - "stage_platform": "linux64-pgo", 22:12:26 INFO - "builduid": "6aa7d1a0614b46b3a085e7649bb2f7b0", 22:12:26 INFO - "slavebuilddir": "test" 22:12:26 INFO - } 22:12:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:12:26 INFO - Running post-action listener: _resource_record_post_action 22:12:26 INFO - [mozharness: 2016-08-20 05:12:26.552203Z] Finished read-buildbot-config step (success) 22:12:26 INFO - [mozharness: 2016-08-20 05:12:26.552290Z] Running download-and-extract step. 22:12:26 INFO - Running pre-action listener: _resource_record_pre_action 22:12:26 INFO - Running main action method: download_and_extract 22:12:26 INFO - mkdir: /builds/slave/test/build/tests 22:12:26 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')]} 22:12:26 INFO - trying https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:12:26 INFO - Downloading https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:12:27 INFO - Downloaded 1361 bytes. 22:12:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:12:27 INFO - Using the following test package requirements: 22:12:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:12:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:12:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'jsshell-linux-x86_64.zip'], 22:12:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:12:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:12:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:12:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:12:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:12:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:12:27 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')]} 22:12:27 INFO - trying https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:12:27 INFO - Downloading https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:28 INFO - Downloaded 21919305 bytes. 22:12:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:12:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:12:32 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')]} 22:12:32 INFO - trying https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:12:32 INFO - Downloading https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:33 INFO - Downloaded 21919305 bytes. 22:12:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:12: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')]} 22:12:37 INFO - trying https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:37 INFO - Downloading https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:12:38 INFO - Downloaded 14413981 bytes. 22:12:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 22:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:38 INFO - trying https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:12:38 INFO - Downloading https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:12:40 INFO - Downloaded 59688106 bytes. 22:12:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:12:40 INFO - mkdir: /builds/slave/test/properties 22:12:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:12:40 INFO - Writing to file /builds/slave/test/properties/build_url 22:12:40 INFO - Contents: 22:12:40 INFO - build_url:https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:12:41 INFO - Running post-action listener: _resource_record_post_action 22:12:41 INFO - Running post-action listener: set_extra_try_arguments 22:12:41 INFO - [mozharness: 2016-08-20 05:12:41.674774Z] Finished download-and-extract step (success) 22:12:41 INFO - [mozharness: 2016-08-20 05:12:41.674999Z] Running populate-webroot step. 22:12:41 INFO - Running pre-action listener: _resource_record_pre_action 22:12:41 INFO - Running main action method: populate_webroot 22:12:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:41 INFO - '--tppagecycles', 22:12:41 INFO - '7'], 22:12:41 INFO - 'tests': ['tsvgm']}}, 22:12:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:12:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:12:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['damp', 'tps']}, 22:12:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'tests': ['damp', 'tps']}, 22:12:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['dromaeo_dom']}, 22:12:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:12:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['basic_compositor_video']}, 22:12:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:12:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'other-e10s': {'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['a11yr', 22:12:41 INFO - 'ts_paint', 22:12:41 INFO - 'tpaint', 22:12:41 INFO - 'sessionrestore', 22:12:41 INFO - 'sessionrestore_no_auto_restore', 22:12:41 INFO - 'tabpaint']}, 22:12:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['tsvgx', 22:12:41 INFO - 'tsvgr_opacity', 22:12:41 INFO - 'tart', 22:12:41 INFO - 'tscrollx', 22:12:41 INFO - 'cart']}, 22:12:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:12:41 INFO - 'tsvgr_opacity', 22:12:41 INFO - 'tart', 22:12:41 INFO - 'tscrollx', 22:12:41 INFO - 'cart']}, 22:12:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'talos_options': ['--disable-e10s'], 22:12:41 INFO - 'tests': ['tp5o']}, 22:12:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'tests': ['tp5o']}, 22:12:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'talos_options': ['--disable-e10s', 22:12:41 INFO - '--xperf_path', 22:12:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:41 INFO - 'tests': ['tp5n']}, 22:12:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:41 INFO - 'talos_options': ['--xperf_path', 22:12:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:41 INFO - 'tests': ['tp5n']}}, 22:12:41 INFO - 'talos.zip': {'path': '', 22:12:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:41 INFO - Running post-action listener: _resource_record_post_action 22:12:41 INFO - [mozharness: 2016-08-20 05:12:41.692092Z] Finished populate-webroot step (success) 22:12:41 INFO - [mozharness: 2016-08-20 05:12:41.692181Z] Running create-virtualenv step. 22:12:41 INFO - Running pre-action listener: _resource_record_pre_action 22:12:41 INFO - Running main action method: create_virtualenv 22:12:41 INFO - Creating virtualenv /builds/slave/test/build/venv 22:12:41 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 22:12:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:12:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:41 INFO - Using real prefix '/usr' 22:12:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:12:42 INFO - Installing distribute.............................................................................................................................................................................................done. 22:12:44 INFO - Installing pip.................done. 22:12:44 INFO - Return code: 0 22:12:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:12:44 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')]} 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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')]} 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:44 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 22:12:44 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 22:12:44 INFO - Using env: {'DISPLAY': ':0', 22:12:44 INFO - 'HOME': '/home/cltbld', 22:12:44 INFO - 'LANG': 'en_US.UTF-8', 22:12:44 INFO - 'LANGUAGE': 'en_US:en', 22:12:44 INFO - 'LOGNAME': 'cltbld', 22:12:44 INFO - 'MAIL': '/var/mail/cltbld', 22:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:44 INFO - 'MOZ_NO_REMOTE': '1', 22:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:44 INFO - 'NO_EM_RESTART': '1', 22:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:44 INFO - 'PWD': '/builds/slave/test', 22:12:44 INFO - 'SHELL': '/bin/bash', 22:12:44 INFO - 'SHLVL': '1', 22:12:44 INFO - 'TERM': 'linux', 22:12:44 INFO - 'TMOUT': '86400', 22:12:44 INFO - 'USER': 'cltbld', 22:12:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:44 INFO - '_': '/tools/buildbot/bin/python'} 22:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:44 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 22:12:44 INFO - Cleaning up... 22:12:44 INFO - Return code: 0 22:12:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:12:44 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')]} 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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')]} 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:44 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:44 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 22:12:44 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 22:12:44 INFO - Using env: {'DISPLAY': ':0', 22:12:44 INFO - 'HOME': '/home/cltbld', 22:12:44 INFO - 'LANG': 'en_US.UTF-8', 22:12:44 INFO - 'LANGUAGE': 'en_US:en', 22:12:44 INFO - 'LOGNAME': 'cltbld', 22:12:44 INFO - 'MAIL': '/var/mail/cltbld', 22:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:44 INFO - 'MOZ_NO_REMOTE': '1', 22:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:44 INFO - 'NO_EM_RESTART': '1', 22:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:44 INFO - 'PWD': '/builds/slave/test', 22:12:44 INFO - 'SHELL': '/bin/bash', 22:12:44 INFO - 'SHLVL': '1', 22:12:44 INFO - 'TERM': 'linux', 22:12:44 INFO - 'TMOUT': '86400', 22:12:44 INFO - 'USER': 'cltbld', 22:12:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:44 INFO - '_': '/tools/buildbot/bin/python'} 22:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:44 INFO - Downloading/unpacking psutil>=3.1.1 22:12:44 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 22:12:44 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 22:12:44 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 22:12:44 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 22:12:44 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 22:12:44 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 22:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:46 INFO - Installing collected packages: psutil 22:12:46 INFO - Running setup.py install for psutil 22:12:46 INFO - building 'psutil._psutil_linux' extension 22:12:46 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 22:12:46 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 22:12:46 INFO - building 'psutil._psutil_posix' extension 22:12:46 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 22:12:47 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 22:12:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:47 INFO - Successfully installed psutil 22:12:47 INFO - Cleaning up... 22:12:47 INFO - Return code: 0 22:12:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:12:47 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')]} 22:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:47 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')]} 22:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:47 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:47 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 22:12:47 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 22:12:47 INFO - Using env: {'DISPLAY': ':0', 22:12:47 INFO - 'HOME': '/home/cltbld', 22:12:47 INFO - 'LANG': 'en_US.UTF-8', 22:12:47 INFO - 'LANGUAGE': 'en_US:en', 22:12:47 INFO - 'LOGNAME': 'cltbld', 22:12:47 INFO - 'MAIL': '/var/mail/cltbld', 22:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:47 INFO - 'MOZ_NO_REMOTE': '1', 22:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:47 INFO - 'NO_EM_RESTART': '1', 22:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:47 INFO - 'PWD': '/builds/slave/test', 22:12:47 INFO - 'SHELL': '/bin/bash', 22:12:47 INFO - 'SHLVL': '1', 22:12:47 INFO - 'TERM': 'linux', 22:12:47 INFO - 'TMOUT': '86400', 22:12:47 INFO - 'USER': 'cltbld', 22:12:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:47 INFO - '_': '/tools/buildbot/bin/python'} 22:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:47 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 22:12:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:12:49 INFO - Installing collected packages: mozsystemmonitor 22:12:49 INFO - Running setup.py install for mozsystemmonitor 22:12:49 INFO - Successfully installed mozsystemmonitor 22:12:49 INFO - Cleaning up... 22:12:49 INFO - Return code: 0 22:12:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:12:49 INFO - Using env: {'DISPLAY': ':0', 22:12:49 INFO - 'HOME': '/home/cltbld', 22:12:49 INFO - 'LANG': 'en_US.UTF-8', 22:12:49 INFO - 'LANGUAGE': 'en_US:en', 22:12:49 INFO - 'LOGNAME': 'cltbld', 22:12:49 INFO - 'MAIL': '/var/mail/cltbld', 22:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:49 INFO - 'MOZ_NO_REMOTE': '1', 22:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:49 INFO - 'NO_EM_RESTART': '1', 22:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:49 INFO - 'PWD': '/builds/slave/test', 22:12:49 INFO - 'SHELL': '/bin/bash', 22:12:49 INFO - 'SHLVL': '1', 22:12:49 INFO - 'TERM': 'linux', 22:12:49 INFO - 'TMOUT': '86400', 22:12:49 INFO - 'USER': 'cltbld', 22:12:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:49 INFO - '_': '/tools/buildbot/bin/python'} 22:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:49 INFO - Downloading/unpacking jsonschema==2.5.1 22:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:12:51 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 22:12:51 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 22:12:51 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 22:12:51 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 22:12:51 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 22:12:51 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 22:12:51 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:51 INFO - warning: no files found matching '*.txt' 22:12:51 INFO - no previously-included directories found matching 'build' 22:12:51 INFO - no previously-included directories found matching 'dist' 22:12:51 INFO - no previously-included directories found matching '.git*' 22:12:51 INFO - Installing collected packages: jsonschema, functools32 22:12:51 INFO - Running setup.py install for functools32 22:12:52 INFO - warning: no files found matching '*.txt' 22:12:52 INFO - no previously-included directories found matching 'build' 22:12:52 INFO - no previously-included directories found matching 'dist' 22:12:52 INFO - no previously-included directories found matching '.git*' 22:12:52 INFO - Successfully installed jsonschema functools32 22:12:52 INFO - Cleaning up... 22:12:52 INFO - Return code: 0 22:12:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:12:52 INFO - Using env: {'DISPLAY': ':0', 22:12:52 INFO - 'HOME': '/home/cltbld', 22:12:52 INFO - 'LANG': 'en_US.UTF-8', 22:12:52 INFO - 'LANGUAGE': 'en_US:en', 22:12:52 INFO - 'LOGNAME': 'cltbld', 22:12:52 INFO - 'MAIL': '/var/mail/cltbld', 22:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:52 INFO - 'MOZ_NO_REMOTE': '1', 22:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:52 INFO - 'NO_EM_RESTART': '1', 22:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:52 INFO - 'PWD': '/builds/slave/test', 22:12:52 INFO - 'SHELL': '/bin/bash', 22:12:52 INFO - 'SHLVL': '1', 22:12:52 INFO - 'TERM': 'linux', 22:12:52 INFO - 'TMOUT': '86400', 22:12:52 INFO - 'USER': 'cltbld', 22:12:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:52 INFO - '_': '/tools/buildbot/bin/python'} 22:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:12:52 INFO - Cleaning up... 22:12:52 INFO - Return code: 0 22:12:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:12:52 INFO - Using env: {'DISPLAY': ':0', 22:12:52 INFO - 'HOME': '/home/cltbld', 22:12:52 INFO - 'LANG': 'en_US.UTF-8', 22:12:52 INFO - 'LANGUAGE': 'en_US:en', 22:12:52 INFO - 'LOGNAME': 'cltbld', 22:12:52 INFO - 'MAIL': '/var/mail/cltbld', 22:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:52 INFO - 'MOZ_NO_REMOTE': '1', 22:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:52 INFO - 'NO_EM_RESTART': '1', 22:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:52 INFO - 'PWD': '/builds/slave/test', 22:12:52 INFO - 'SHELL': '/bin/bash', 22:12:52 INFO - 'SHLVL': '1', 22:12:52 INFO - 'TERM': 'linux', 22:12:52 INFO - 'TMOUT': '86400', 22:12:52 INFO - 'USER': 'cltbld', 22:12:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:52 INFO - '_': '/tools/buildbot/bin/python'} 22:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:12:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:55 INFO - Downloading docopt-0.6.1.tar.gz 22:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:55 INFO - Running setup.py install for blobuploader 22:12:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:12:55 INFO - Running setup.py install for requests 22:12:55 INFO - Running setup.py install for docopt 22:12:55 INFO - Successfully installed blobuploader requests docopt 22:12:55 INFO - Cleaning up... 22:12:55 INFO - Return code: 0 22:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12: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')]} 22:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12: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')]} 22:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:55 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:55 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 22:12:55 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 22:12:55 INFO - Using env: {'DISPLAY': ':0', 22:12:55 INFO - 'HOME': '/home/cltbld', 22:12:55 INFO - 'LANG': 'en_US.UTF-8', 22:12:55 INFO - 'LANGUAGE': 'en_US:en', 22:12:55 INFO - 'LOGNAME': 'cltbld', 22:12:55 INFO - 'MAIL': '/var/mail/cltbld', 22:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:55 INFO - 'MOZ_NO_REMOTE': '1', 22:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:55 INFO - 'NO_EM_RESTART': '1', 22:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:55 INFO - 'PWD': '/builds/slave/test', 22:12:55 INFO - 'SHELL': '/bin/bash', 22:12:55 INFO - 'SHLVL': '1', 22:12:55 INFO - 'TERM': 'linux', 22:12:55 INFO - 'TMOUT': '86400', 22:12:55 INFO - 'USER': 'cltbld', 22:12:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:55 INFO - '_': '/tools/buildbot/bin/python'} 22:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:56 INFO - Running setup.py (path:/tmp/pip-1sJdC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:56 INFO - Running setup.py (path:/tmp/pip-JdtlDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:56 INFO - Running setup.py (path:/tmp/pip-QRKLnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:56 INFO - Running setup.py (path:/tmp/pip-uu3AS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:56 INFO - Running setup.py (path:/tmp/pip-tCiRbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:56 INFO - Running setup.py (path:/tmp/pip-UNMwiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:56 INFO - Running setup.py (path:/tmp/pip-gag84h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:56 INFO - Running setup.py (path:/tmp/pip-1aNrBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:56 INFO - Running setup.py (path:/tmp/pip-cqnjtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:56 INFO - Running setup.py (path:/tmp/pip-EPn118-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:56 INFO - Running setup.py (path:/tmp/pip-Ue78_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:56 INFO - Running setup.py (path:/tmp/pip-B3LFlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:56 INFO - Running setup.py (path:/tmp/pip-RJ44Oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:56 INFO - Running setup.py (path:/tmp/pip-01fWh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:57 INFO - Running setup.py (path:/tmp/pip-vX6Jsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:57 INFO - Running setup.py (path:/tmp/pip-qEcPaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:57 INFO - Running setup.py (path:/tmp/pip-9EmXa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:12:57 INFO - Running setup.py install for manifestparser 22:12:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:12:57 INFO - Running setup.py install for mozcrash 22:12:57 INFO - Running setup.py install for mozdebug 22:12:57 INFO - Running setup.py install for mozdevice 22:12:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:12:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:12:57 INFO - Running setup.py install for mozfile 22:12:57 INFO - Running setup.py install for mozhttpd 22:12:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:12:57 INFO - Running setup.py install for mozinfo 22:12:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:12:57 INFO - Running setup.py install for mozInstall 22:12:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Running setup.py install for mozleak 22:12:58 INFO - Running setup.py install for mozlog 22:12:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Running setup.py install for moznetwork 22:12:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Running setup.py install for mozprocess 22:12:58 INFO - Running setup.py install for mozprofile 22:12:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Running setup.py install for mozrunner 22:12:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:12:58 INFO - Running setup.py install for mozscreenshot 22:12:58 INFO - Running setup.py install for moztest 22:12:58 INFO - Running setup.py install for mozversion 22:12:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:12:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:12:59 INFO - Cleaning up... 22:12:59 INFO - Return code: 0 22:12:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:59 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')]} 22:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:59 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')]} 22:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:59 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:12:59 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 22:12:59 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 22:12:59 INFO - Using env: {'DISPLAY': ':0', 22:12:59 INFO - 'HOME': '/home/cltbld', 22:12:59 INFO - 'LANG': 'en_US.UTF-8', 22:12:59 INFO - 'LANGUAGE': 'en_US:en', 22:12:59 INFO - 'LOGNAME': 'cltbld', 22:12:59 INFO - 'MAIL': '/var/mail/cltbld', 22:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:59 INFO - 'MOZ_NO_REMOTE': '1', 22:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:59 INFO - 'NO_EM_RESTART': '1', 22:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:59 INFO - 'PWD': '/builds/slave/test', 22:12:59 INFO - 'SHELL': '/bin/bash', 22:12:59 INFO - 'SHLVL': '1', 22:12:59 INFO - 'TERM': 'linux', 22:12:59 INFO - 'TMOUT': '86400', 22:12:59 INFO - 'USER': 'cltbld', 22:12:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:59 INFO - '_': '/tools/buildbot/bin/python'} 22:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:59 INFO - Running setup.py (path:/tmp/pip-mKk0hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:59 INFO - Running setup.py (path:/tmp/pip-b4QMxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:59 INFO - Running setup.py (path:/tmp/pip-7QVulY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:59 INFO - Running setup.py (path:/tmp/pip-hiQrrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:59 INFO - Running setup.py (path:/tmp/pip-0v4KBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:59 INFO - Running setup.py (path:/tmp/pip-BLULjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:59 INFO - Running setup.py (path:/tmp/pip-lMFEP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:59 INFO - Running setup.py (path:/tmp/pip-IIJaKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:59 INFO - Running setup.py (path:/tmp/pip-wbMFez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:59 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)) 22:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:59 INFO - Running setup.py (path:/tmp/pip-bD53pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:00 INFO - Running setup.py (path:/tmp/pip-64gJ9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:00 INFO - Running setup.py (path:/tmp/pip-9USZHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:00 INFO - Running setup.py (path:/tmp/pip-UBv3Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:00 INFO - Running setup.py (path:/tmp/pip-BRiO9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:00 INFO - Running setup.py (path:/tmp/pip-JJbhgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:00 INFO - Running setup.py (path:/tmp/pip-nR0KRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:00 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)) 22:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:00 INFO - Running setup.py (path:/tmp/pip-4TNbph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:00 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)) 22:13:00 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)) 22:13:00 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)) 22:13:00 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)) 22:13:00 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)) 22:13:00 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)) 22:13:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:02 INFO - Downloading blessings-1.6.tar.gz 22:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:02 INFO - Installing collected packages: blessings 22:13:02 INFO - Running setup.py install for blessings 22:13:02 INFO - Successfully installed blessings 22:13:02 INFO - Cleaning up... 22:13:02 INFO - Return code: 0 22:13:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:02 INFO - Reading from file tmpfile_stdout 22:13:02 INFO - Current package versions: 22:13:02 INFO - argparse == 1.2.1 22:13:02 INFO - blessings == 1.6 22:13:02 INFO - blobuploader == 1.2.4 22:13:02 INFO - docopt == 0.6.1 22:13:02 INFO - functools32 == 3.2.3-2 22:13:02 INFO - jsonschema == 2.5.1 22:13:02 INFO - manifestparser == 1.1 22:13:02 INFO - mozInstall == 1.12 22:13:02 INFO - mozcrash == 0.17 22:13:02 INFO - mozdebug == 0.1 22:13:02 INFO - mozdevice == 0.48 22:13:02 INFO - mozfile == 1.2 22:13:02 INFO - mozhttpd == 0.7 22:13:02 INFO - mozinfo == 0.9 22:13:02 INFO - mozleak == 0.1 22:13:02 INFO - mozlog == 3.3 22:13:02 INFO - moznetwork == 0.27 22:13:02 INFO - mozprocess == 0.23 22:13:02 INFO - mozprofile == 0.28 22:13:02 INFO - mozrunner == 6.12 22:13:02 INFO - mozscreenshot == 0.1 22:13:02 INFO - mozsystemmonitor == 0.3 22:13:02 INFO - moztest == 0.7 22:13:02 INFO - mozversion == 1.4 22:13:02 INFO - psutil == 3.1.1 22:13:02 INFO - requests == 1.2.3 22:13:02 INFO - wsgiref == 0.1.2 22:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:02 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')]} 22:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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')]} 22:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:02 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:13:02 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 22:13:02 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 22:13:02 INFO - Using env: {'DISPLAY': ':0', 22:13:02 INFO - 'HOME': '/home/cltbld', 22:13:02 INFO - 'LANG': 'en_US.UTF-8', 22:13:02 INFO - 'LANGUAGE': 'en_US:en', 22:13:02 INFO - 'LOGNAME': 'cltbld', 22:13:02 INFO - 'MAIL': '/var/mail/cltbld', 22:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:02 INFO - 'MOZ_NO_REMOTE': '1', 22:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:02 INFO - 'NO_EM_RESTART': '1', 22:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:02 INFO - 'PWD': '/builds/slave/test', 22:13:02 INFO - 'SHELL': '/bin/bash', 22:13:02 INFO - 'SHLVL': '1', 22:13:02 INFO - 'TERM': 'linux', 22:13:02 INFO - 'TMOUT': '86400', 22:13:02 INFO - 'USER': 'cltbld', 22:13:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:02 INFO - '_': '/tools/buildbot/bin/python'} 22:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 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)) 22:13:03 INFO - Cleaning up... 22:13:03 INFO - Return code: 0 22:13:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:03 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')]} 22:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:03 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')]} 22:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:03 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 0x7f55bad81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', '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 22:13:03 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 22:13:03 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 22:13:03 INFO - Using env: {'DISPLAY': ':0', 22:13:03 INFO - 'HOME': '/home/cltbld', 22:13:03 INFO - 'LANG': 'en_US.UTF-8', 22:13:03 INFO - 'LANGUAGE': 'en_US:en', 22:13:03 INFO - 'LOGNAME': 'cltbld', 22:13:03 INFO - 'MAIL': '/var/mail/cltbld', 22:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:03 INFO - 'MOZ_NO_REMOTE': '1', 22:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:03 INFO - 'NO_EM_RESTART': '1', 22:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:03 INFO - 'PWD': '/builds/slave/test', 22:13:03 INFO - 'SHELL': '/bin/bash', 22:13:03 INFO - 'SHLVL': '1', 22:13:03 INFO - 'TERM': 'linux', 22:13:03 INFO - 'TMOUT': '86400', 22:13:03 INFO - 'USER': 'cltbld', 22:13:03 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:03 INFO - '_': '/tools/buildbot/bin/python'} 22:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:03 INFO - Cleaning up... 22:13:03 INFO - Return code: 0 22:13:03 INFO - Running post-action listener: _resource_record_post_action 22:13:03 INFO - Running post-action listener: _start_resource_monitoring 22:13:03 INFO - Starting resource monitoring. 22:13:03 INFO - [mozharness: 2016-08-20 05:13:03.331846Z] Finished create-virtualenv step (success) 22:13:03 INFO - [mozharness: 2016-08-20 05:13:03.332315Z] Running install step. 22:13:03 INFO - Running pre-action listener: _resource_record_pre_action 22:13:03 INFO - Running main action method: install 22:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:03 INFO - Reading from file tmpfile_stdout 22:13:03 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:03 INFO - Reading from file tmpfile_stdout 22:13:03 INFO - Output received: 22:13:03 INFO - Usage: mozinstall [options] installer 22:13:03 INFO - Options: 22:13:03 INFO - -h, --help show this help message and exit 22:13:03 INFO - -d DEST, --destination=DEST 22:13:03 INFO - Directory to install application into. [default: 22:13:03 INFO - "/builds/slave/test"] 22:13:03 INFO - --app=APP Application being installed. [default: firefox] 22:13:03 INFO - mkdir: /builds/slave/test/build/application 22:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:13:20 INFO - Reading from file tmpfile_stdout 22:13:20 INFO - Output received: 22:13:20 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:20 INFO - Running post-action listener: _resource_record_post_action 22:13:20 INFO - [mozharness: 2016-08-20 05:13:20.604153Z] Finished install step (success) 22:13:20 INFO - [mozharness: 2016-08-20 05:13:20.604401Z] Running run-tests step. 22:13:20 INFO - Running pre-action listener: _resource_record_pre_action 22:13:20 INFO - Running main action method: run_tests 22:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:20 INFO - Python 2.7.3 22:13:20 INFO - Return code: 0 22:13:20 INFO - grabbing minidump binary from tooltool 22:13: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')]} 22:13:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b05370>, '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 0x1b088f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:13:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:13:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:13:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:20 INFO - Return code: 0 22:13:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:13:20 INFO - Using env: {'DISPLAY': ':0', 22:13:20 INFO - 'HOME': '/home/cltbld', 22:13:20 INFO - 'LANG': 'en_US.UTF-8', 22:13:20 INFO - 'LANGUAGE': 'en_US:en', 22:13:20 INFO - 'LOGNAME': 'cltbld', 22:13:20 INFO - 'MAIL': '/var/mail/cltbld', 22:13:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:20 INFO - 'MOZ_NO_REMOTE': '1', 22:13:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:20 INFO - 'NO_EM_RESTART': '1', 22:13:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:20 INFO - 'PWD': '/builds/slave/test', 22:13:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:20 INFO - 'SHELL': '/bin/bash', 22:13:20 INFO - 'SHLVL': '1', 22:13:20 INFO - 'TERM': 'linux', 22:13:20 INFO - 'TMOUT': '86400', 22:13:20 INFO - 'USER': 'cltbld', 22:13:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756', 22:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:20 INFO - '_': '/tools/buildbot/bin/python'} 22:13:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:13:20 INFO - mozversion application_buildid: 20160819193009 22:13:20 INFO - mozversion application_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 22:13:20 INFO - mozversion application_display_name: Nightly 22:13:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:20 INFO - mozversion application_name: Firefox 22:13:20 INFO - mozversion application_remotingname: firefox 22:13:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:13:20 INFO - mozversion application_vendor: Mozilla 22:13:20 INFO - mozversion application_version: 51.0a1 22:13:20 INFO - mozversion platform_buildid: 20160819193009 22:13:20 INFO - mozversion platform_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 22:13:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:13:20 INFO - mozversion platform_version: 51.0a1 22:13:20 INFO - using testdate: 1471670000 22:13:20 INFO - actual date: 1471670000 22:13:20 INFO - starting webserver on 'localhost:33628' 22:13:20 INFO - SUITE-START | Running 2 tests 22:13:20 INFO - TEST-START | dromaeo_css 22:13:20 INFO - operating with platform_type : linux_ 22:13:20 INFO - Initialising browser for dromaeo_css test... 22:13:20 INFO - TEST-INFO | started process 4769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJE9Byt/profile http://localhost:33628/getInfo.html) 22:13:25 INFO - PROCESS | 4769 | __metrics Screen width/height:1600/1200 22:13:25 INFO - PROCESS | 4769 | colorDepth:24 22:13:25 INFO - PROCESS | 4769 | Browser inner width/height: 1024/697 22:13:25 INFO - PROCESS | 4769 | __metrics 22:13:25 ERROR - PROCESS | 4769 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 22:13:26 INFO - TEST-INFO | 4769: exit 0 22:13:26 INFO - Browser initialized. 22:13:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:26 INFO - TEST-INFO | started process 4890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJE9Byt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:38 INFO - PROCESS | 4890 | RSS: Main: 186847232 22:13:38 INFO - PROCESS | 4890 | 22:14:28 INFO - PROCESS | 4890 | 1471670068435 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] 22:16:37 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33628/tests/dromaeo/cssquery-ext.html) 22:16:39 INFO - PROCESS | 4890 | RSS: Main: 199012352 22:16:39 INFO - PROCESS | 4890 | 22:19:41 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-ext.html (next: http://localhost:33628/tests/dromaeo/cssquery-jquery.html) 22:19:41 INFO - PROCESS | 4890 | RSS: Main: 198242304 22:19:41 INFO - PROCESS | 4890 | 22:22:43 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33628/tests/dromaeo/cssquery-mootools.html) 22:22:44 INFO - PROCESS | 4890 | RSS: Main: 199012352 22:22:44 INFO - PROCESS | 4890 | 22:25:46 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33628/tests/dromaeo/cssquery-prototype.html) 22:25:46 INFO - PROCESS | 4890 | RSS: Main: 196681728 22:25:46 INFO - PROCESS | 4890 | 22:28:49 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33628/tests/dromaeo/cssquery-yui.html) 22:28:50 INFO - PROCESS | 4890 | RSS: Main: 199016448 22:28:50 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | Cycle 1(1): loaded http://localhost:33628/tests/dromaeo/cssquery-yui.html (next: http://localhost:33628/tests/dromaeo/cssquery-dojo.html) 22:31:52 INFO - PROCESS | 4890 | RSS: Main: 199770112 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | __start_tp_report 22:31:52 INFO - PROCESS | 4890 | _x_x_mozilla_page_load 22:31:52 INFO - PROCESS | 4890 | _x_x_mozilla_page_load_details 22:31:52 INFO - PROCESS | 4890 | |i|pagename|runs| 22:31:52 INFO - PROCESS | 4890 | |0;dojo.html;3101.441740486713;3139.1210461070896;3148.386064717381;3156.037408590382;3156.41606302834;5309.230161626571;5495.615306928512;5544.584156188287;5544.9464601725695;5568.053430916743;5435.320584926884;5449.727513624312;5465.879494703586;5551.1673249012665;5553.278073850404;4763.666543341968;5012.097822391959;5059.139946209153;5139.768710408022;5145;5082.466341034194;5089.211172268304;5095.210242412413;5137.588992880579;5137.6403651744395;4751.738654374008;4872.853814385557;4888.657793954425;4928.137575924235;4971.651984361096;4935.111679897617;4939.456659767423;4944.53026962438;5004.774785134678;5011.173156429185;4946.40643122824;4980.477049909744;4980.526849949249;4984.028114517634;5001.774920128603;5407.324084489439;5411.729413529308;5493.258410114623;5549.389567147651;5573.08044172711;5882.794102206445;5922.940770592282;5929.140274660193;5951.523878089785;5957.940420595782;5678.5741069419955;5733.283339582552;5894.882102357972;5951.880962380771;5955.166276721263;5350.3312085989255;5356.062689029404;5374.355077390738;5381.946180538183;5387.946120538783;5894.764209431574;5907.8227653169615;5913.019138588535;5918.674472903946;5922.822315330547;5650.350209725934;5662.065759149777;5692.430756924357;5696.686682232517;5700.914486282709;5670.914936275959;5682.6306290091015;5900.940990590039;5921.822345329647;5926.259217597801;5756.884862302814;5832.504237139806;5833.79581714638;5838.2702162229725;5839;5615.831525054255;5839.9124013139835;5841;5842.240508733922;5848.444397782204;4409.801558929856;4422.557744225552;4448.977755111268;4497.662675299365;4499.550044995474;3957.5053118360206;3972.08642012333;3988.3818008208773;3989.800509974548;3990.7206495545033;5531.474509921551;5569.721513924287;5583.4137415571595;5584;5609.467100625434;5913.704314784243;5974.3428222895445;5990.131430942489;6005.909911351333;6009;5697.772089116472;5707.514861236758;5714.228579141846;5729.2265544151005;5737.88524229513;5000.974995125001;5034.917492739006;5130.076586214443;5145.125328694131;5157.458466860926;6088.330283668793;6200.503959683305;6201.720922558496;6208.565400421927;6210.875782484415;6003.549733770072;6010.278766548042;6018.849528761816;6020.157177994996;6023.45788879003;5903.852403689771;5937.465628093492;6170.994426811394;6193.349698281796;6202.844928876814;5657.43425657431;5744.42555744439;5766.3368712598585;5797.9420205797405;5800.419958004166;5799.652020878592;5838.912416313674;5854.619449735754;5865.9441300566305;5870.412958704266;5567.137093750475;5658.094704847204;5744.856378590569;5745.052066409163;5747.252857128714;5660.575456840671;5730.140478928194;5761.251037365116;5772.614572502485;5781.82654520365;5759.136129580429;5766;5788.27646544182;5788.768449262151;5791.9131213031;5608.270924779753;5638.661680299195;5814.127880817742;5841.591088623925;5853.678047707247;5561.416051314553;5643.604947653789;5661.235733175969;5678.261825962599;5678.602497825113 22:31:52 INFO - PROCESS | 4890 | |1;ext.html;553.3995614757987;555.244866980906;556.1574215064179;570.1846359705621;591.0985746736224;40703.185936281254;45249.54750452495;45402.54597454025;45454.31818522725;45464.77267613657;44817;45456.77271613637;45489.545104548946;45529;45610.7719461403;8833.337499687534;9001.099890010979;9001.144891235323;9003.774905627379;9007;8835.028146903835;8844.5577721114;8886.688965886195;8890.59992300348;8926.46441213526;8941.50821704806;8994.325425593073;8998.775030624254;9003.234725048378;9022.639094436214;8834.955825220897;8846;8874;8892.155245251723;8923.955380223122;8863.645454181826;8866.778330541789;8933.865992010125;8951.910480895172;8953.507557084358;41603;41818.37272440916;41822.163556728694;41825.581744182775;41883.79058104721;3532.4877892705413;3759.661630453245;3960.5049368828895;4023.7384570002855;4160.126373461577;30922.53616195759;33556.49665255023;33989.83005084959;34108.48837267443;35968.280634387425;4322.546132656089;4402.7578483183415;4529.728216307032;4624.976875115636;4653.139169253699;373690;379887;380891;382313;384162;65652;65956.67021664957;65960.34039659542;66105;66199;38224.42663360052;38470.42294365587;38477;41610.79194604007;41750.37374439386;17496.125193740263;17608.55978600545;17628.823711762718;17709.911450442665;17759.112044397727;12674.36628168588;12735.299558524184;12735.872641273654;12776.6805829855;12797.424115914806;19643.312484063274;19980.800191998183;20160.899195503927;20297.391078267676;20314.796852031584;7600.923990760132;7621.580813055224;7781;7808.297253247121;7883.251091146332;905.7463910105181;1004.492731170754;1010.757418219622;1047.3192424923861;1083.1172594335749;33019.70743803338;34004;34087;34130.48804267888;34160.65839341625;1063.787242551493;1093.5188517052472;1103.9668809935715;1115.9788793254081;1126.2060247525476;16396.426125085563;17387.913060434617;17518.21168047441;17583.91208043977;17811.73282400765;568963;575174;576768;578301;579754;59336.703316484;59479.107813382834;59693;59895.700521497114;59962.70018649879;1328.0902581731546;1345.6904911870129;1364.1405914273944;1365.8429280632656;1368.288489985222;27255;27380.315492112855;27592.862035689694;28356.29862208274;29245.561316580694;54610.45389546054;54739.178912315554;54792.72603636956;54812.177817331976;54827.451725482235;342315;343302;343824;344011.6796496109;344924;29490;29663.703362966095;29843.552346714383;30406.543901841047;30726;50590;50881;51034.489655102974;51191.488085118675;51425.7428712854;41045.179096417305;41065.79467102645;41634.375484367156;42126.36810447907;43180.352294716235;41136.1772764549;42128.57871421369;42633;43356.56643433651;44290.335644966;40541.18917621572;40808.3878741825;41910;42023;42105;35152.648473514935;38078.80960595179;39203.607963919996;39210.41184382179;39373;29354.706452935196;29407.85296073506;29627.555586665785;30068.248293791956;30164.69835301619 22:31:52 INFO - PROCESS | 4890 | |2;jquery.html;382.1058722589141;387.7150294533516;394.53050869465324;396.910695093604;416.3380225441549;13970.580882573513;18686.4394068178;19504;20192.495187620316;20359.38921832344;19218.711719324223;19325.32361367349;19641.705374419395;19684.606307873833;19820.90089549554;5572.5263352615075;5611.7755289788465;5692.345380281279;5713.371529131792;5838.503727183173;5622.212890195356;5677.460641239076;5688.345840228385;5691.08942569189;5691.800786972457;5423.240746295522;5622.269105016342;5680.460356266169;5689.60172787903;5689.630174038695;5661.66030038199;5679.119736440837;5698.914516282259;5745.88508229833;5752.5110365618975;4898.461169271377;5057.772400241998;5062.443131255596;5094.363204599425;5110.97444512775;23273.418164545852;23901.641475377884;24131.396715082086;24176.758232417804;24202.273931782074;2369.5142495788323;2613.033177724254;2630.040035387089;3055.960973269099;3079.5226739855134;14422.495212667507;14512.274386280644;14544.345504452325;14933.626659333495;15877.841221587752;1894.9336773212872;1938.6898096304524;1966.223341779989;2022.4337185588058;2024.979750202494;84343.5782821088;85532.57233713854;85691.57154214189;87365.56317218373;88114.55942720246;10127.696169114939;10223.233257505568;10611.522481488351;10627.787444251071;10780.113480140944;14530.782038269434;14558.344874480674;14574.271286435636;14574.344154513072;14621.561353159423;8033.317168040782;8366.121557236524;8399.41204115706;8611.095834937367;8654.091320411266;8296.253337199681;8349.624266908004;8427.494350338999;8607.483550986835;8640.654373824977;6372.490200783926;6415.871682566322;6433.225565779657;6484.837879052967;6525.575837570543;1900.9619807604047;1914.1003728247701;1944.578999146044;1964.4008577384036;1998.2206939293396;916.2807196350833;970.4468452981873;1014.3964341216964;1039.449091981251;1083.8428427877914;20378.47161462896;20398.69401958972;20500.38498845037;20556;20614.556981011185;977.9755506112405;999.3560592824763;1010.0505524806805;1012.2205901455837;1048.6172547020435;10758.515866786014;11584.131190160771;11688.18182727201;11734.530618775325;11874;477890;482121;499983;502465;507791;48993.75503122462;81602.18397816064;86877.56561217153;88801.55599222092;104255.4787226059;1003.9369096506603;1041.807265655856;1043.6138628707274;1054.0302921312411;1054.4200689620677;18061.277548898423;18226.63053802997;18273.3604323848;18283.908580457013;18295.634087318445;31441.371172575964;36767.448488273236;41900;43779.34330984974;44213;57296.14055789083;61438.07842882271;63627.6818615904;64194;64408.677956609914;8418.158184181533;8802.515861627671;9016.18854303116;11986.46060927243;12114.575989840314;13933.651658708208;14112.506062288181;14137.36381862798;14299.21354325522;15130.470433534774;12386.442610082748;12789.744205116032;12791.616251512469;13018.674533136747;13026.413811378321;12460.202821913448;12631.747365052464;12724.363781810687;12790.488380464678;12860.164089334163;12668.936655316664;12933.482660693468;13038.217706937614;13173.868261317264;13313.201207927556;12458.314792686127;12543.686407839512;12668.746625067632;12812.615621530997;12872.35638218104;12640.431180596712;12674.493020279086;12960.287184204959;13043;13213.933930330288 22:31:52 INFO - PROCESS | 4890 | |3;mootools.html;1471.5364660132057;1492.8731057860082;1636.451788650802;1716.6909956207894;1755.0785837435353;7750.496217745843;8330.958630171228;8497.830043399128;9139.314551408637;9160.312976526762;8366;8624.655013799456;8637.870431943526;8677.435966662162;8718.476891386505;2300.229423143249;2323.384303159664;2331.4404542909665;2332.790048895599;2350.25966820451;2323.6979192704925;2334.136369543263;2361.397843549901;2365.597848365782;2371.0752806405517;2314.3751187179537;2325.197806756666;2335.369450248432;2358.2099996501192;2365.314058922919;2295;2316.2240649382393;2327.3948773318975;2337.836351455399;2349.259983105316;2283.178055899875;2297.908083676651;2311.0755697721047;2315.386422597996;2318.629019356895;8887.377883548153;9040.231580315682;9100.953390360128;9104;9133.90866091344;5215.739213039333;5364.1149210380245;5376.220448035052;5385.892282154335;5390.78436862525;3374.223928496435;3470.8958731238104;3492.1793378556017;3530.75284730069;3541.043918142113;1114.777044591077;1151.4645689754304;1153.2273376837538;1167.8832116788337;1173.730042090324;12517.43671534783;12531.624051278477;12555.874441255562;12570.245785252822;12572.171261466188;4537.591616754508;4674.836380726658;4822.565969062801;4844.031193761261;4844.806207751651;10246.897531024744;10357.274990750726;10395.272330936914;10436.5825366986;10470.685879423629;5416.729163541807;5419.132938729785;5420.91868621971;5423.511883930465;5446.782128714807;4366.934495982563;4742.739149346819;4917;4918.581920536794;4946.282788995575;4061.7156799024374;4128.938065929014;4138.112296550117;4164.250434921682;4218.472690913636;1284.9421776020101;1336.211635135275;1340.9865901341057;1355.7966305054322;1356.9118007329491;963.5375019990304;994.9204063674889;998.7902540466583;1003.6838395905412;1019.3883669798062;5928.911066334009;5953.702314884238;6053.848653783691;6103.1455596216565;6115.327313995457;481.8554433669885;491.2385802006875;491.8499857543412;498.4218306764136;502.8943921776468;4191.8532851350055;4200.579942005775;4216.810243539048;4363.52001279859;4572.428446444194;11080.667579972614;11258.21192516516;11293.830592541119;11405.885941140648;11415.942920285512;11172.776544469227;11183.273087249303;11197.384143872165;11208.887911120948;11279.379634120038;7789.805254868674;8190.140035296327;8215.260626543639;8241.052278987872;8404;5779.422057794187;5903.026000709835;5934.881302373842;6027.36712645166;6050.12792806227;10196.235282353704;10328.845067323846;10353.482325883826;10366.429846358522;10449.738756530844;10226.130778883879;10315.587376504856;10474.266801323834;10483.161347092368;10514.947425262824;6508.707108180049;7613.809654758676;7782.416318776228;7906.327962123284;7982.760517184493;8772;8783.824323513367;8811.118888111137;8811.33914956368;8838.425502342585;7656.157822639394;7697.8845317319165;7780.066392032993;7937.285644292041;8089.029316481824;7810.765677029698;7921.524708517507;7939.206079392246;7981.920180798118;7992.600369981361;7231.4937954342695;7255.354266510299;7288.380487658396;7331.120265568166;7349.375303099297;5307.283516725192;5308.867278318073;5403.189521571796;5422.810201642924;5470.124780035176;5308.309919710413;5353.652012619323;5363.517283444508;5450.482204190595;5492.780288788564 22:31:52 INFO - PROCESS | 4890 | |4;prototype.html;314.09697120777764;315.55349180909013;323.7733586489458;325.91526203187163;329.6999730245477;5289.693941286696;5412.810551630694;5497.175423686449;5508.944910550898;5509.035918714224;5425.864353391167;5445.346558412996;5447.836564903049;5451.809186678467;5460.535854452366;4262.083652014816;4266.807993640278;4269.701120921537;4273.29490634045;4279.1441711657635;4142.877836552634;4262.381954616579;4270.6760904119665;4275.337322714969;4288.721233119837;4228.6617070634275;4230.957690423103;4236.978815105936;4243.978780106095;4247.469066366704;4236.406903033578;4242.80907359168;4248.171606536695;4254.702460671234;4262.0591791663655;3532.5054492371087;3648.908777280563;3668.4313931340685;3674.926501469956;3763.478469425464;5313.707746073965;5315.123004704219;5324.361076670785;5326.760295786699;5328.20076988451;4812.446568644616;4823.300621409876;4828.155072862235;4830.3720516333005;4833.975830120862;5500.944990550083;5654.151877218409;5691.207269710028;5697.829065128053;5701.2018317435595;4018.9196216075807;4026.6778657707605;4032.979835100835;4033.7176397652174;4038.7980600969836;5876.647401155944;5880;5891.49922256613;5902.97048514759;5931.495822855062;3912.667423268997;4025.8389664413094;4076.7374107370692;4138.586141385837;4161.771102589387;4170.666346692257;4188.3874708237545;4192.559781222989;4203.516595591485;4203.91592168155;4788.712677239377;4795.098965126118;4795.904081918412;4811.27830825379;4854.466008739107;5445.9727701362035;5709.628874123168;5746.540276777848;5773.451522105393;5779.768809247667;1444.7905053767145;1484.9851501484848;1488.3153749275455;1492.276246020679;1496.940122395092;923.4301687131903;941.4586612697726;951.4909523405083;969.9718298603503;973.965911193119;4809.927851082237;4848.781804818721;4875.268709693574;4891.951080489221;4913.877153071202;5107.974460127675;5131.358580177478;5136.638790720462;5145.122030458931;5187.403448603383;4585.839495617637;4755.588014646318;4866.31871537985;4892.951070489249;4897.4857639947295;2691.206094202215;2701.405690748032;2731.3581308392513;2744.4785490756694;2747.5191841427672;5265.183896496049;5304.355649748513;5306.548943339782;5311.176767601028;5334.653247538975;5004.874878128003;5185.740712964337;5214.7914083437;5225.268462415189;5230.973845130826;5268.710220937808;5287.365516138011;5303.575713942875;5306.734663266744;5306.8407947761625;5114.4374118847645;5114.769835357492;5149.665271757323;5163.709072731817;5183.486009285418;4893.08861227569;5062.594992400525;5065.265536497261;5074.619403544675;5098.260752190986;5311;5342.599305052059;5344.412114667306;5352.330958630171;5366.946330536801;3787.659110680052;3837;3861.4014827701753;3881.592432794629;3881.670058045098;4773.737444440589;5029.84910452687;5080.771365288497;5113.386393632788;5124.487551244845;5009.447071407875;5018.799248030184;5021.748912554431;5026.4973502649445;5030.421501527225;4938.8765280868265;4946.491320147389;5007.874803129951;5009.423916249678;5010.446761503946;5002.774875130555;5272;5758.683272420057;5778.8266352009505;5793.246877905845;5808.680522571299;5812.447817457335;5817.854553636193;5833.212516310244;5838.10261664969;5453.592029365559;5679.886402271849;5698.1452782083015;5702.857428564319;5714.257146571085 22:31:52 INFO - PROCESS | 4890 | |5;yui.html;727.8726222910991;737.3069314844042;785.0521292546487;818.9426740128193;871.8648609465531;15608.687826243467;16557.66884662306;17176.14119294035;17237.13814309284;17366.305347786107;15821.920890395531;16261.674766504693;16363.100029498373;16397.18014099296;16407.097609631466;662.5891946992871;808.7735434078453;809.4374409785202;822.4037572759731;828.511178404741;827.6854795177824;837.7235512280963;838.5849004742661;839.1063517353998;842.2419822160074;884.6549845560237;886.6453418632566;887.760304717729;891.1133422244875;891.7057371067532;875.0287181228863;877.2280393253959;877.8332116897769;882.1663527966107;882.5940067568926;639;640.1741753138446;644.2944975252138;644.3427703742157;644.5133923887435;15836.76244856328;15917.761233581505;15992.28034738428;16015.919920400323;16079.035257884565;15632.758031188274;15657.608559785982;15970.661889160525;16316.592085197846;16531.83468165327;13068.86931130686;13089.47642094315;13231;13368.264745438997;13566.660833479242;3970.4838371011583;3970.7617542947514;3979.8408063677416;4007.9599204007877;4034.979825100885;88310.67533986995;88425.67361489647;88928.55535722345;90098;90640.54679726624;12426.254424734545;12451.315177665316;12508;12627.936860315824;12641.304728239851;24119.15582954588;24205.15281965158;24232.87883560606;24253.39366515816;24272.514549708907;8701.695440659672;8800.8679869802;8901.688440904538;8954.328425368123;9034.14175653312;4883.58489528387;5000.89998200034;5027.145385284511;5054.949450505522;5265.973670131625;3685.3734865073;3808.5429748430365;3822.1591249924973;3826.196498735241;3837.520309961255;596.1415561591381;605.9575829691879;607.908813677943;616.5899676714935;617.3486971245289;584.3513699793226;737.5390381011867;741.1587847792794;778.4823092643329;779.766070178944;10348.221119914251;10363.2222488611;10667.573297068031;11169.776604467865;11274.718132046764;665.4077870695086;720.5748608321115;732.4433430592787;746.6266866566716;779.7504798464437;4998.425181104147;5214.426413094557;5253.868653283698;5325.041492531304;5326.227696983916;72212.63893680499;101119.49440252752;115515;116554.41722791332;121843.39078304551;96999;98282;98749;99333.50333248432;100019.49990250148;76299;81766.59116704378;88815.55592222126;90983;91347.54326228326;8845.911540884767;9033.909660903308;10193.788956478686;10696.14430845515;11149.777004459704;38588.80705596566;49454.50545494499;50293.74853125711;53163.20255196098;53390.46609533855;76230;77053.61473192822;78864.60567697354;81340;82633.58683206786;11163.776724465628;11733.530658773554;11828.881711182778;11879.643610691694;12095.939520302694;13515;13585.84555540132;13590.59228223155;13793.34389225892;14019.579412617637;13034.022448316604;13146.079774415699;13154.276514791778;13221.074524783173;14313.642158945693;14275.928620356832;14341.282935852956;14442.494512692005;14479.782803258171;14741.778873317124;13867.930660346634;14204.928975355057;14373.425062997363;14605.780913286097;14679.119252844863;10924;11209.15931305139;11385.886141138482;11399.943000284946;11507.539698412305;11308.717282068013;11427.371494567546;11762.828504463241;12431.813522797345;12891.677708057374 22:31:52 INFO - PROCESS | 4890 | __end_tp_report 22:31:52 INFO - PROCESS | 4890 | __start_cc_report 22:31:52 INFO - PROCESS | 4890 | _x_x_mozilla_cycle_collect,342 22:31:52 INFO - PROCESS | 4890 | __end_cc_report 22:31:52 INFO - PROCESS | 4890 | __startTimestamp1471671112566__endTimestamp 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | ------- Summary: start ------- 22:31:52 INFO - PROCESS | 4890 | Number of tests: 6 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#0] dojo.html Cycles:165 Average:5455.47 Median:5670.91 stddev:632.58 (11.2%) stddev-sans-first:606.97 22:31:52 INFO - PROCESS | 4890 | Values: 3101.4 3139.1 3148.4 3156.0 3156.4 5309.2 5495.6 5544.6 5544.9 5568.1 5435.3 5449.7 5465.9 5551.2 5553.3 4763.7 5012.1 5059.1 5139.8 5145.0 5082.5 5089.2 5095.2 5137.6 5137.6 4751.7 4872.9 4888.7 4928.1 4971.7 4935.1 4939.5 4944.5 5004.8 5011.2 4946.4 4980.5 4980.5 4984.0 5001.8 5407.3 5411.7 5493.3 5549.4 5573.1 5882.8 5922.9 5929.1 5951.5 5957.9 5678.6 5733.3 5894.9 5951.9 5955.2 5350.3 5356.1 5374.4 5381.9 5387.9 5894.8 5907.8 5913.0 5918.7 5922.8 5650.4 5662.1 5692.4 5696.7 5700.9 5670.9 5682.6 5900.9 5921.8 5926.3 5756.9 5832.5 5833.8 5838.3 5839.0 5615.8 5839.9 5841.0 5842.2 5848.4 4409.8 4422.6 4449.0 4497.7 4499.6 3957.5 3972.1 3988.4 3989.8 3990.7 5531.5 5569.7 5583.4 5584.0 5609.5 5913.7 5974.3 5990.1 6005.9 6009.0 5697.8 5707.5 5714.2 5729.2 5737.9 5001.0 5034.9 5130.1 5145.1 5157.5 6088.3 6200.5 6201.7 6208.6 6210.9 6003.5 6010.3 6018.8 6020.2 6023.5 5903.9 5937.5 6171.0 6193.3 6202.8 5657.4 5744.4 5766.3 5797.9 5800.4 5799.7 5838.9 5854.6 5865.9 5870.4 5567.1 5658.1 5744.9 5745.1 5747.3 5660.6 5730.1 5761.3 5772.6 5781.8 5759.1 5766.0 5788.3 5788.8 5791.9 5608.3 5638.7 5814.1 5841.6 5853.7 5561.4 5643.6 5661.2 5678.3 5678.6 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#1] ext.html Cycles:180 Average:59847.71 Median:41692.37 stddev:118114.28 (283.3%) stddev-sans-first:118361.72 22:31:52 INFO - PROCESS | 4890 | Values: 553.4 555.2 556.2 570.2 591.1 40703.2 45249.5 45402.5 45454.3 45464.8 44817.0 45456.8 45489.5 45529.0 45610.8 8833.3 9001.1 9001.1 9003.8 9007.0 8835.0 8844.6 8886.7 8890.6 8926.5 8941.5 8994.3 8998.8 9003.2 9022.6 8835.0 8846.0 8874.0 8892.2 8924.0 8863.6 8866.8 8933.9 8951.9 8953.5 41603.0 41818.4 41822.2 41825.6 41883.8 3532.5 3759.7 3960.5 4023.7 4160.1 30922.5 33556.5 33989.8 34108.5 35968.3 4322.5 4402.8 4529.7 4625.0 4653.1 373690.0 379887.0 380891.0 382313.0 384162.0 65652.0 65956.7 65960.3 66105.0 66199.0 38224.4 38470.4 38477.0 41610.8 41750.4 17496.1 17608.6 17628.8 17709.9 17759.1 12674.4 12735.3 12735.9 12776.7 12797.4 19643.3 19980.8 20160.9 20297.4 20314.8 7600.9 7621.6 7781.0 7808.3 7883.3 905.7 1004.5 1010.8 1047.3 1083.1 33019.7 34004.0 34087.0 34130.5 34160.7 1063.8 1093.5 1104.0 1116.0 1126.2 16396.4 17387.9 17518.2 17583.9 17811.7 568963.0 575174.0 576768.0 578301.0 579754.0 59336.7 59479.1 59693.0 59895.7 59962.7 1328.1 1345.7 1364.1 1365.8 1368.3 27255.0 27380.3 27592.9 28356.3 29245.6 54610.5 54739.2 54792.7 54812.2 54827.5 342315.0 343302.0 343824.0 344011.7 344924.0 29490.0 29663.7 29843.6 30406.5 30726.0 50590.0 50881.0 51034.5 51191.5 51425.7 41045.2 41065.8 41634.4 42126.4 43180.4 41136.2 42128.6 42633.0 43356.6 44290.3 40541.2 40808.4 41910.0 42023.0 42105.0 35152.6 38078.8 39203.6 39210.4 39373.0 29354.7 29407.9 29627.6 30068.2 30164.7 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#2] jquery.html Cycles:180 Average:29611.27 Median:20449.54 stddev:81339.16 (397.8%) stddev-sans-first:81537.73 22:31:52 INFO - PROCESS | 4890 | Values: 382.1 387.7 394.5 396.9 416.3 13970.6 18686.4 19504.0 20192.5 20359.4 19218.7 19325.3 19641.7 19684.6 19820.9 5572.5 5611.8 5692.3 5713.4 5838.5 5622.2 5677.5 5688.3 5691.1 5691.8 5423.2 5622.3 5680.5 5689.6 5689.6 5661.7 5679.1 5698.9 5745.9 5752.5 4898.5 5057.8 5062.4 5094.4 5111.0 23273.4 23901.6 24131.4 24176.8 24202.3 2369.5 2613.0 2630.0 3056.0 3079.5 14422.5 14512.3 14544.3 14933.6 15877.8 1894.9 1938.7 1966.2 2022.4 2025.0 84343.6 85532.6 85691.6 87365.6 88114.6 10127.7 10223.2 10611.5 10627.8 10780.1 14530.8 14558.3 14574.3 14574.3 14621.6 8033.3 8366.1 8399.4 8611.1 8654.1 8296.3 8349.6 8427.5 8607.5 8640.7 6372.5 6415.9 6433.2 6484.8 6525.6 1901.0 1914.1 1944.6 1964.4 1998.2 916.3 970.4 1014.4 1039.4 1083.8 20378.5 20398.7 20500.4 20556.0 20614.6 978.0 999.4 1010.1 1012.2 1048.6 10758.5 11584.1 11688.2 11734.5 11874.0 477890.0 482121.0 499983.0 502465.0 507791.0 48993.8 81602.2 86877.6 88801.6 104255.5 1003.9 1041.8 1043.6 1054.0 1054.4 18061.3 18226.6 18273.4 18283.9 18295.6 31441.4 36767.4 41900.0 43779.3 44213.0 57296.1 61438.1 63627.7 64194.0 64408.7 8418.2 8802.5 9016.2 11986.5 12114.6 13933.7 14112.5 14137.4 14299.2 15130.5 12386.4 12789.7 12791.6 13018.7 13026.4 12460.2 12631.7 12724.4 12790.5 12860.2 12668.9 12933.5 13038.2 13173.9 13313.2 12458.3 12543.7 12668.7 12812.6 12872.4 12640.4 12674.5 12960.3 13043.0 13213.9 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#3] mootools.html Cycles:180 Average:5894.52 Median:2612.30 stddev:3370.88 (129.0%) stddev-sans-first:3363.95 22:31:52 INFO - PROCESS | 4890 | Values: 1471.5 1492.9 1636.5 1716.7 1755.1 7750.5 8331.0 8497.8 9139.3 9160.3 8366.0 8624.7 8637.9 8677.4 8718.5 2300.2 2323.4 2331.4 2332.8 2350.3 2323.7 2334.1 2361.4 2365.6 2371.1 2314.4 2325.2 2335.4 2358.2 2365.3 2295.0 2316.2 2327.4 2337.8 2349.3 2283.2 2297.9 2311.1 2315.4 2318.6 8887.4 9040.2 9101.0 9104.0 9133.9 5215.7 5364.1 5376.2 5385.9 5390.8 3374.2 3470.9 3492.2 3530.8 3541.0 1114.8 1151.5 1153.2 1167.9 1173.7 12517.4 12531.6 12555.9 12570.2 12572.2 4537.6 4674.8 4822.6 4844.0 4844.8 10246.9 10357.3 10395.3 10436.6 10470.7 5416.7 5419.1 5420.9 5423.5 5446.8 4366.9 4742.7 4917.0 4918.6 4946.3 4061.7 4128.9 4138.1 4164.3 4218.5 1284.9 1336.2 1341.0 1355.8 1356.9 963.5 994.9 998.8 1003.7 1019.4 5928.9 5953.7 6053.8 6103.1 6115.3 481.9 491.2 491.8 498.4 502.9 4191.9 4200.6 4216.8 4363.5 4572.4 11080.7 11258.2 11293.8 11405.9 11415.9 11172.8 11183.3 11197.4 11208.9 11279.4 7789.8 8190.1 8215.3 8241.1 8404.0 5779.4 5903.0 5934.9 6027.4 6050.1 10196.2 10328.8 10353.5 10366.4 10449.7 10226.1 10315.6 10474.3 10483.2 10514.9 6508.7 7613.8 7782.4 7906.3 7982.8 8772.0 8783.8 8811.1 8811.3 8838.4 7656.2 7697.9 7780.1 7937.3 8089.0 7810.8 7921.5 7939.2 7981.9 7992.6 7231.5 7255.4 7288.4 7331.1 7349.4 5307.3 5308.9 5403.2 5422.8 5470.1 5308.3 5353.7 5363.5 5450.5 5492.8 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#4] prototype.html Cycles:180 Average:4541.34 Median:5020.27 stddev:1298.70 (25.9%) stddev-sans-first:1262.99 22:31:52 INFO - PROCESS | 4890 | Values: 314.1 315.6 323.8 325.9 329.7 5289.7 5412.8 5497.2 5508.9 5509.0 5425.9 5445.3 5447.8 5451.8 5460.5 4262.1 4266.8 4269.7 4273.3 4279.1 4142.9 4262.4 4270.7 4275.3 4288.7 4228.7 4231.0 4237.0 4244.0 4247.5 4236.4 4242.8 4248.2 4254.7 4262.1 3532.5 3648.9 3668.4 3674.9 3763.5 5313.7 5315.1 5324.4 5326.8 5328.2 4812.4 4823.3 4828.2 4830.4 4834.0 5500.9 5654.2 5691.2 5697.8 5701.2 4018.9 4026.7 4033.0 4033.7 4038.8 5876.6 5880.0 5891.5 5903.0 5931.5 3912.7 4025.8 4076.7 4138.6 4161.8 4170.7 4188.4 4192.6 4203.5 4203.9 4788.7 4795.1 4795.9 4811.3 4854.5 5446.0 5709.6 5746.5 5773.5 5779.8 1444.8 1485.0 1488.3 1492.3 1496.9 923.4 941.5 951.5 970.0 974.0 4809.9 4848.8 4875.3 4892.0 4913.9 5108.0 5131.4 5136.6 5145.1 5187.4 4585.8 4755.6 4866.3 4893.0 4897.5 2691.2 2701.4 2731.4 2744.5 2747.5 5265.2 5304.4 5306.5 5311.2 5334.7 5004.9 5185.7 5214.8 5225.3 5231.0 5268.7 5287.4 5303.6 5306.7 5306.8 5114.4 5114.8 5149.7 5163.7 5183.5 4893.1 5062.6 5065.3 5074.6 5098.3 5311.0 5342.6 5344.4 5352.3 5366.9 3787.7 3837.0 3861.4 3881.6 3881.7 4773.7 5029.8 5080.8 5113.4 5124.5 5009.4 5018.8 5021.7 5026.5 5030.4 4938.9 4946.5 5007.9 5009.4 5010.4 5002.8 5272.0 5758.7 5778.8 5793.2 5808.7 5812.4 5817.9 5833.2 5838.1 5453.6 5679.9 5698.1 5702.9 5714.3 22:31:52 INFO - PROCESS | 4890 | 22:31:52 INFO - PROCESS | 4890 | [#5] yui.html Cycles:180 Average:21331.39 Median:3975.30 stddev:30101.46 (757.2%) stddev-sans-first:30146.15 22:31:52 INFO - PROCESS | 4890 | Values: 727.9 737.3 785.1 818.9 871.9 15608.7 16557.7 17176.1 17237.1 17366.3 15821.9 16261.7 16363.1 16397.2 16407.1 662.6 808.8 809.4 822.4 828.5 827.7 837.7 838.6 839.1 842.2 884.7 886.6 887.8 891.1 891.7 875.0 877.2 877.8 882.2 882.6 639.0 640.2 644.3 644.3 644.5 15836.8 15917.8 15992.3 16015.9 16079.0 15632.8 15657.6 15970.7 16316.6 16531.8 13068.9 13089.5 13231.0 13368.3 13566.7 3970.5 3970.8 3979.8 4008.0 4035.0 88310.7 88425.7 88928.6 90098.0 90640.5 12426.3 12451.3 12508.0 12627.9 12641.3 24119.2 24205.2 24232.9 24253.4 24272.5 8701.7 8800.9 8901.7 8954.3 9034.1 4883.6 5000.9 5027.1 5054.9 5266.0 3685.4 3808.5 3822.2 3826.2 3837.5 596.1 606.0 607.9 616.6 617.3 584.4 737.5 741.2 778.5 779.8 10348.2 10363.2 10667.6 11169.8 11274.7 665.4 720.6 732.4 746.6 779.8 4998.4 5214.4 5253.9 5325.0 5326.2 72212.6 101119.5 115515.0 116554.4 121843.4 96999.0 98282.0 98749.0 99333.5 100019.5 76299.0 81766.6 88815.6 90983.0 91347.5 8845.9 9033.9 10193.8 10696.1 11149.8 38588.8 49454.5 50293.7 53163.2 53390.5 76230.0 77053.6 78864.6 81340.0 82633.6 11163.8 11733.5 11828.9 11879.6 12095.9 13515.0 13585.8 13590.6 13793.3 14019.6 13034.0 13146.1 13154.3 13221.1 14313.6 14275.9 14341.3 14442.5 14479.8 14741.8 13867.9 14204.9 14373.4 14605.8 14679.1 10924.0 11209.2 11385.9 11399.9 11507.5 11308.7 11427.4 11762.8 12431.8 12891.7 22:31:52 INFO - PROCESS | 4890 | -------- Summary: end -------- 22:31:52 INFO - PROCESS | 4890 | 22:31:53 INFO - TEST-INFO | 4890: exit 0 22:31:53 INFO - TEST-OK | dromaeo_css | took 1112609ms 22:31:53 INFO - TEST-START | kraken 22:31:53 INFO - operating with platform_type : linux_ 22:31:53 INFO - Initialising browser for kraken test... 22:31:53 INFO - TEST-INFO | started process 5247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTbQmY/profile http://localhost:33628/getInfo.html) 22:31:58 INFO - PROCESS | 5247 | __metrics Screen width/height:1600/1200 22:31:58 INFO - PROCESS | 5247 | colorDepth:24 22:31:58 INFO - PROCESS | 5247 | Browser inner width/height: 1024/697 22:31:58 INFO - PROCESS | 5247 | __metrics 22:31:58 ERROR - PROCESS | 5247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 22:31:59 INFO - TEST-INFO | 5247: exit 0 22:31:59 INFO - Browser initialized. 22:31:59 INFO - Running cycle 1/1 for kraken test... 22:31:59 INFO - TEST-INFO | started process 5366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTbQmY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:11 INFO - PROCESS | 5366 | RSS: Main: 186617856 22:32:11 INFO - PROCESS | 5366 | 22:32:14 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33628/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:15 INFO - PROCESS | 5366 | RSS: Main: 199602176 22:32:15 INFO - PROCESS | 5366 | 22:32:17 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33628/tests/kraken/driver.html?testName=audio-dft) 22:32:18 INFO - PROCESS | 5366 | RSS: Main: 198307840 22:32:18 INFO - PROCESS | 5366 | 22:32:21 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33628/tests/kraken/driver.html?testName=audio-fft) 22:32:22 INFO - PROCESS | 5366 | RSS: Main: 194961408 22:32:22 INFO - PROCESS | 5366 | 22:32:24 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33628/tests/kraken/driver.html?testName=audio-oscillator) 22:32:24 INFO - PROCESS | 5366 | RSS: Main: 195842048 22:32:24 INFO - PROCESS | 5366 | 22:32:27 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33628/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:27 INFO - PROCESS | 5366 | RSS: Main: 195649536 22:32:27 INFO - PROCESS | 5366 | 22:32:30 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33628/tests/kraken/driver.html?testName=imaging-darkroom) 22:32:31 INFO - PROCESS | 5366 | RSS: Main: 195985408 22:32:31 INFO - PROCESS | 5366 | 22:32:34 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33628/tests/kraken/driver.html?testName=imaging-desaturate) 22:32:35 INFO - PROCESS | 5366 | RSS: Main: 193171456 22:32:35 INFO - PROCESS | 5366 | 22:32:38 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33628/tests/kraken/driver.html?testName=json-parse-financial) 22:32:39 INFO - PROCESS | 5366 | RSS: Main: 194961408 22:32:39 INFO - PROCESS | 5366 | 22:32:40 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33628/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:32:41 INFO - PROCESS | 5366 | RSS: Main: 194985984 22:32:41 INFO - PROCESS | 5366 | 22:32:43 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:32:43 INFO - PROCESS | 5366 | RSS: Main: 195108864 22:32:43 INFO - PROCESS | 5366 | 22:32:45 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:32:46 INFO - PROCESS | 5366 | RSS: Main: 195833856 22:32:46 INFO - PROCESS | 5366 | 22:32:49 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:32:49 INFO - PROCESS | 5366 | RSS: Main: 195842048 22:32:49 INFO - PROCESS | 5366 | 22:32:52 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:32:53 INFO - PROCESS | 5366 | RSS: Main: 196263936 22:32:53 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | Cycle 1(1): loaded http://localhost:33628/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33628/tests/kraken/driver.html?testName=ai-astar) 22:32:55 INFO - PROCESS | 5366 | RSS: Main: 197881856 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | __start_tp_report 22:32:55 INFO - PROCESS | 5366 | _x_x_mozilla_page_load 22:32:55 INFO - PROCESS | 5366 | _x_x_mozilla_page_load_details 22:32:55 INFO - PROCESS | 5366 | |i|pagename|runs| 22:32:55 INFO - PROCESS | 5366 | |0;ai-astar;126;113;109;115;115;111;119;112;112;114 22:32:55 INFO - PROCESS | 5366 | |1;audio-beat-detection;151;124;151;178;128;156;149;124;178;124 22:32:55 INFO - PROCESS | 5366 | |2;audio-dft;164;171;169;167;164;162;164;170;166;165 22:32:55 INFO - PROCESS | 5366 | |3;audio-fft;75;78;76;193;79;77;77;79;164;78 22:32:55 INFO - PROCESS | 5366 | |4;audio-oscillator;87;87;149;89;94;88;137;87;86;155 22:32:55 INFO - PROCESS | 5366 | |5;imaging-gaussian-blur;118;121;118;118;118;118;118;118;118;118 22:32:55 INFO - PROCESS | 5366 | |6;imaging-darkroom;147;147;149;149;148;151;148;148;149;148 22:32:55 INFO - PROCESS | 5366 | |7;imaging-desaturate;96;97;97;96;96;95;96;97;96;96 22:32:55 INFO - PROCESS | 5366 | |8;json-parse-financial;51;53;58;62;56;52;54;54;53;53 22:32:55 INFO - PROCESS | 5366 | |9;json-stringify-tinderbox;62;65;61;63;64;62;65;68;63;63 22:32:55 INFO - PROCESS | 5366 | |10;stanford-crypto-aes;80;92;80;85;82;87;81;81;83;82 22:32:55 INFO - PROCESS | 5366 | |11;stanford-crypto-ccm;138;131;144;135;136;141;135;142;151;144 22:32:55 INFO - PROCESS | 5366 | |12;stanford-crypto-pbkdf2;165;170;164;172;165;173;169;170;165;167 22:32:55 INFO - PROCESS | 5366 | |13;stanford-crypto-sha256-iterative;69;68;67;66;68;65;66;69;64;69 22:32:55 INFO - PROCESS | 5366 | __end_tp_report 22:32:55 INFO - PROCESS | 5366 | __start_cc_report 22:32:55 INFO - PROCESS | 5366 | _x_x_mozilla_cycle_collect,903 22:32:55 INFO - PROCESS | 5366 | __end_cc_report 22:32:55 INFO - PROCESS | 5366 | __startTimestamp1471671175363__endTimestamp 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | ------- Summary: start ------- 22:32:55 INFO - PROCESS | 5366 | Number of tests: 14 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:4.84 (4.2%) stddev-sans-first:2.87 22:32:55 INFO - PROCESS | 5366 | Values: 126.0 113.0 109.0 115.0 115.0 111.0 119.0 112.0 112.0 114.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:151.00 stddev:21.03 (13.9%) stddev-sans-first:22.24 22:32:55 INFO - PROCESS | 5366 | Values: 151.0 124.0 151.0 178.0 128.0 156.0 149.0 124.0 178.0 124.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.50 stddev:2.97 (1.8%) stddev-sans-first:3.05 22:32:55 INFO - PROCESS | 5366 | Values: 164.0 171.0 169.0 167.0 164.0 162.0 164.0 170.0 166.0 165.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#3] audio-fft Cycles:10 Average:97.60 Median:77.50 stddev:43.20 (55.7%) stddev-sans-first:45.04 22:32:55 INFO - PROCESS | 5366 | Values: 75.0 78.0 76.0 193.0 79.0 77.0 77.0 79.0 164.0 78.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:87.00 stddev:28.77 (33.1%) stddev-sans-first:29.69 22:32:55 INFO - PROCESS | 5366 | Values: 87.0 87.0 149.0 89.0 94.0 88.0 137.0 87.0 86.0 155.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 22:32:55 INFO - PROCESS | 5366 | Values: 118.0 121.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.17 (0.8%) stddev-sans-first:1.13 22:32:55 INFO - PROCESS | 5366 | Values: 147.0 147.0 149.0 149.0 148.0 151.0 148.0 148.0 149.0 148.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:32:55 INFO - PROCESS | 5366 | Values: 96.0 97.0 97.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.27 (6.1%) stddev-sans-first:3.20 22:32:55 INFO - PROCESS | 5366 | Values: 51.0 53.0 58.0 62.0 56.0 52.0 54.0 54.0 53.0 53.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:63.50 stddev:2.01 (3.2%) stddev-sans-first:2.05 22:32:55 INFO - PROCESS | 5366 | Values: 62.0 65.0 61.0 63.0 64.0 62.0 65.0 68.0 63.0 63.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.77 (4.6%) stddev-sans-first:3.81 22:32:55 INFO - PROCESS | 5366 | Values: 80.0 92.0 80.0 85.0 82.0 87.0 81.0 81.0 83.0 82.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:141.50 stddev:5.85 (4.1%) stddev-sans-first:6.17 22:32:55 INFO - PROCESS | 5366 | Values: 138.0 131.0 144.0 135.0 136.0 141.0 135.0 142.0 151.0 144.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.50 stddev:3.23 (1.9%) stddev-sans-first:3.24 22:32:55 INFO - PROCESS | 5366 | Values: 165.0 170.0 164.0 172.0 165.0 173.0 169.0 170.0 165.0 167.0 22:32:55 INFO - PROCESS | 5366 | 22:32:55 INFO - PROCESS | 5366 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.76 22:32:55 INFO - PROCESS | 5366 | Values: 69.0 68.0 67.0 66.0 68.0 65.0 66.0 69.0 64.0 69.0 22:32:55 INFO - PROCESS | 5366 | -------- Summary: end -------- 22:32:55 INFO - PROCESS | 5366 | 22:32:56 INFO - TEST-INFO | 5366: exit 0 22:32:56 INFO - TEST-OK | kraken | took 62866ms 22:32:56 INFO - SUITE-END | took 1175s 22:32:56 INFO - Completed test suite (00:19:35) 22:32:56 INFO - javascript benchmark 22:32:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7377.532058595564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.441740486713, 3139.1210461070896, 3148.386064717381, 3156.037408590382, 3156.41606302834, 5309.230161626571, 5495.615306928512, 5544.584156188287, 5544.9464601725695, 5568.053430916743, 5435.320584926884, 5449.727513624312, 5465.879494703586, 5551.1673249012665, 5553.278073850404, 4763.666543341968, 5012.097822391959, 5059.139946209153, 5139.768710408022, 5145.0, 5082.466341034194, 5089.211172268304, 5095.210242412413, 5137.588992880579, 5137.6403651744395, 4751.738654374008, 4872.853814385557, 4888.657793954425, 4928.137575924235, 4971.651984361096, 4935.111679897617, 4939.456659767423, 4944.53026962438, 5004.774785134678, 5011.173156429185, 4946.40643122824, 4980.477049909744, 4980.526849949249, 4984.028114517634, 5001.774920128603, 5407.324084489439, 5411.729413529308, 5493.258410114623, 5549.389567147651, 5573.08044172711, 5882.794102206445, 5922.940770592282, 5929.140274660193, 5951.523878089785, 5957.940420595782, 5678.5741069419955, 5733.283339582552, 5894.882102357972, 5951.880962380771, 5955.166276721263, 5350.3312085989255, 5356.062689029404, 5374.355077390738, 5381.946180538183, 5387.946120538783, 5894.764209431574, 5907.8227653169615, 5913.019138588535, 5918.674472903946, 5922.822315330547, 5650.350209725934, 5662.065759149777, 5692.430756924357, 5696.686682232517, 5700.914486282709, 5670.914936275959, 5682.6306290091015, 5900.940990590039, 5921.822345329647, 5926.259217597801, 5756.884862302814, 5832.504237139806, 5833.79581714638, 5838.2702162229725, 5839.0, 5615.831525054255, 5839.9124013139835, 5841.0, 5842.240508733922, 5848.444397782204, 4409.801558929856, 4422.557744225552, 4448.977755111268, 4497.662675299365, 4499.550044995474, 3957.5053118360206, 3972.08642012333, 3988.3818008208773, 3989.800509974548, 3990.7206495545033, 5531.474509921551, 5569.721513924287, 5583.4137415571595, 5584.0, 5609.467100625434, 5913.704314784243, 5974.3428222895445, 5990.131430942489, 6005.909911351333, 6009.0, 5697.772089116472, 5707.514861236758, 5714.228579141846, 5729.2265544151005, 5737.88524229513, 5000.974995125001, 5034.917492739006, 5130.076586214443, 5145.125328694131, 5157.458466860926, 6088.330283668793, 6200.503959683305, 6201.720922558496, 6208.565400421927, 6210.875782484415, 6003.549733770072, 6010.278766548042, 6018.849528761816, 6020.157177994996, 6023.45788879003, 5903.852403689771, 5937.465628093492, 6170.994426811394, 6193.349698281796, 6202.844928876814, 5657.43425657431, 5744.42555744439, 5766.3368712598585, 5797.9420205797405, 5800.419958004166, 5799.652020878592, 5838.912416313674, 5854.619449735754, 5865.9441300566305, 5870.412958704266, 5567.137093750475, 5658.094704847204, 5744.856378590569, 5745.052066409163, 5747.252857128714, 5660.575456840671, 5730.140478928194, 5761.251037365116, 5772.614572502485, 5781.82654520365, 5759.136129580429, 5766.0, 5788.27646544182, 5788.768449262151, 5791.9131213031, 5608.270924779753, 5638.661680299195, 5814.127880817742, 5841.591088623925, 5853.678047707247, 5561.416051314553, 5643.604947653789, 5661.235733175969, 5678.261825962599, 5678.602497825113], "value": 5411.822914438338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.3995614757987, 555.244866980906, 556.1574215064179, 570.1846359705621, 591.0985746736224, 40703.185936281254, 45249.54750452495, 45402.54597454025, 45454.31818522725, 45464.77267613657, 44817.0, 45456.77271613637, 45489.545104548946, 45529.0, 45610.7719461403, 8833.337499687534, 9001.099890010979, 9001.144891235323, 9003.774905627379, 9007.0, 8835.028146903835, 8844.5577721114, 8886.688965886195, 8890.59992300348, 8926.46441213526, 8941.50821704806, 8994.325425593073, 8998.775030624254, 9003.234725048378, 9022.639094436214, 8834.955825220897, 8846.0, 8874.0, 8892.155245251723, 8923.955380223122, 8863.645454181826, 8866.778330541789, 8933.865992010125, 8951.910480895172, 8953.507557084358, 41603.0, 41818.37272440916, 41822.163556728694, 41825.581744182775, 41883.79058104721, 3532.4877892705413, 3759.661630453245, 3960.5049368828895, 4023.7384570002855, 4160.126373461577, 30922.53616195759, 33556.49665255023, 33989.83005084959, 34108.48837267443, 35968.280634387425, 4322.546132656089, 4402.7578483183415, 4529.728216307032, 4624.976875115636, 4653.139169253699, 373690.0, 379887.0, 380891.0, 382313.0, 384162.0, 65652.0, 65956.67021664957, 65960.34039659542, 66105.0, 66199.0, 38224.42663360052, 38470.42294365587, 38477.0, 41610.79194604007, 41750.37374439386, 17496.125193740263, 17608.55978600545, 17628.823711762718, 17709.911450442665, 17759.112044397727, 12674.36628168588, 12735.299558524184, 12735.872641273654, 12776.6805829855, 12797.424115914806, 19643.312484063274, 19980.800191998183, 20160.899195503927, 20297.391078267676, 20314.796852031584, 7600.923990760132, 7621.580813055224, 7781.0, 7808.297253247121, 7883.251091146332, 905.7463910105181, 1004.492731170754, 1010.757418219622, 1047.3192424923861, 1083.1172594335749, 33019.70743803338, 34004.0, 34087.0, 34130.48804267888, 34160.65839341625, 1063.787242551493, 1093.5188517052472, 1103.9668809935715, 1115.9788793254081, 1126.2060247525476, 16396.426125085563, 17387.913060434617, 17518.21168047441, 17583.91208043977, 17811.73282400765, 568963.0, 575174.0, 576768.0, 578301.0, 579754.0, 59336.703316484, 59479.107813382834, 59693.0, 59895.700521497114, 59962.70018649879, 1328.0902581731546, 1345.6904911870129, 1364.1405914273944, 1365.8429280632656, 1368.288489985222, 27255.0, 27380.315492112855, 27592.862035689694, 28356.29862208274, 29245.561316580694, 54610.45389546054, 54739.178912315554, 54792.72603636956, 54812.177817331976, 54827.451725482235, 342315.0, 343302.0, 343824.0, 344011.6796496109, 344924.0, 29490.0, 29663.703362966095, 29843.552346714383, 30406.543901841047, 30726.0, 50590.0, 50881.0, 51034.489655102974, 51191.488085118675, 51425.7428712854, 41045.179096417305, 41065.79467102645, 41634.375484367156, 42126.36810447907, 43180.352294716235, 41136.1772764549, 42128.57871421369, 42633.0, 43356.56643433651, 44290.335644966, 40541.18917621572, 40808.3878741825, 41910.0, 42023.0, 42105.0, 35152.648473514935, 38078.80960595179, 39203.607963919996, 39210.41184382179, 39373.0, 29354.706452935196, 29407.85296073506, 29627.555586665785, 30068.248293791956, 30164.69835301619], "value": 20287.27406002992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.1058722589141, 387.7150294533516, 394.53050869465324, 396.910695093604, 416.3380225441549, 13970.580882573513, 18686.4394068178, 19504.0, 20192.495187620316, 20359.38921832344, 19218.711719324223, 19325.32361367349, 19641.705374419395, 19684.606307873833, 19820.90089549554, 5572.5263352615075, 5611.7755289788465, 5692.345380281279, 5713.371529131792, 5838.503727183173, 5622.212890195356, 5677.460641239076, 5688.345840228385, 5691.08942569189, 5691.800786972457, 5423.240746295522, 5622.269105016342, 5680.460356266169, 5689.60172787903, 5689.630174038695, 5661.66030038199, 5679.119736440837, 5698.914516282259, 5745.88508229833, 5752.5110365618975, 4898.461169271377, 5057.772400241998, 5062.443131255596, 5094.363204599425, 5110.97444512775, 23273.418164545852, 23901.641475377884, 24131.396715082086, 24176.758232417804, 24202.273931782074, 2369.5142495788323, 2613.033177724254, 2630.040035387089, 3055.960973269099, 3079.5226739855134, 14422.495212667507, 14512.274386280644, 14544.345504452325, 14933.626659333495, 15877.841221587752, 1894.9336773212872, 1938.6898096304524, 1966.223341779989, 2022.4337185588058, 2024.979750202494, 84343.5782821088, 85532.57233713854, 85691.57154214189, 87365.56317218373, 88114.55942720246, 10127.696169114939, 10223.233257505568, 10611.522481488351, 10627.787444251071, 10780.113480140944, 14530.782038269434, 14558.344874480674, 14574.271286435636, 14574.344154513072, 14621.561353159423, 8033.317168040782, 8366.121557236524, 8399.41204115706, 8611.095834937367, 8654.091320411266, 8296.253337199681, 8349.624266908004, 8427.494350338999, 8607.483550986835, 8640.654373824977, 6372.490200783926, 6415.871682566322, 6433.225565779657, 6484.837879052967, 6525.575837570543, 1900.9619807604047, 1914.1003728247701, 1944.578999146044, 1964.4008577384036, 1998.2206939293396, 916.2807196350833, 970.4468452981873, 1014.3964341216964, 1039.449091981251, 1083.8428427877914, 20378.47161462896, 20398.69401958972, 20500.38498845037, 20556.0, 20614.556981011185, 977.9755506112405, 999.3560592824763, 1010.0505524806805, 1012.2205901455837, 1048.6172547020435, 10758.515866786014, 11584.131190160771, 11688.18182727201, 11734.530618775325, 11874.0, 477890.0, 482121.0, 499983.0, 502465.0, 507791.0, 48993.75503122462, 81602.18397816064, 86877.56561217153, 88801.55599222092, 104255.4787226059, 1003.9369096506603, 1041.807265655856, 1043.6138628707274, 1054.0302921312411, 1054.4200689620677, 18061.277548898423, 18226.63053802997, 18273.3604323848, 18283.908580457013, 18295.634087318445, 31441.371172575964, 36767.448488273236, 41900.0, 43779.34330984974, 44213.0, 57296.14055789083, 61438.07842882271, 63627.6818615904, 64194.0, 64408.677956609914, 8418.158184181533, 8802.515861627671, 9016.18854303116, 11986.46060927243, 12114.575989840314, 13933.651658708208, 14112.506062288181, 14137.36381862798, 14299.21354325522, 15130.470433534774, 12386.442610082748, 12789.744205116032, 12791.616251512469, 13018.674533136747, 13026.413811378321, 12460.202821913448, 12631.747365052464, 12724.363781810687, 12790.488380464678, 12860.164089334163, 12668.936655316664, 12933.482660693468, 13038.217706937614, 13173.868261317264, 13313.201207927556, 12458.314792686127, 12543.686407839512, 12668.746625067632, 12812.615621530997, 12872.35638218104, 12640.431180596712, 12674.493020279086, 12960.287184204959, 13043.0, 13213.933930330288], "value": 9738.785203456784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.5364660132057, 1492.8731057860082, 1636.451788650802, 1716.6909956207894, 1755.0785837435353, 7750.496217745843, 8330.958630171228, 8497.830043399128, 9139.314551408637, 9160.312976526762, 8366.0, 8624.655013799456, 8637.870431943526, 8677.435966662162, 8718.476891386505, 2300.229423143249, 2323.384303159664, 2331.4404542909665, 2332.790048895599, 2350.25966820451, 2323.6979192704925, 2334.136369543263, 2361.397843549901, 2365.597848365782, 2371.0752806405517, 2314.3751187179537, 2325.197806756666, 2335.369450248432, 2358.2099996501192, 2365.314058922919, 2295.0, 2316.2240649382393, 2327.3948773318975, 2337.836351455399, 2349.259983105316, 2283.178055899875, 2297.908083676651, 2311.0755697721047, 2315.386422597996, 2318.629019356895, 8887.377883548153, 9040.231580315682, 9100.953390360128, 9104.0, 9133.90866091344, 5215.739213039333, 5364.1149210380245, 5376.220448035052, 5385.892282154335, 5390.78436862525, 3374.223928496435, 3470.8958731238104, 3492.1793378556017, 3530.75284730069, 3541.043918142113, 1114.777044591077, 1151.4645689754304, 1153.2273376837538, 1167.8832116788337, 1173.730042090324, 12517.43671534783, 12531.624051278477, 12555.874441255562, 12570.245785252822, 12572.171261466188, 4537.591616754508, 4674.836380726658, 4822.565969062801, 4844.031193761261, 4844.806207751651, 10246.897531024744, 10357.274990750726, 10395.272330936914, 10436.5825366986, 10470.685879423629, 5416.729163541807, 5419.132938729785, 5420.91868621971, 5423.511883930465, 5446.782128714807, 4366.934495982563, 4742.739149346819, 4917.0, 4918.581920536794, 4946.282788995575, 4061.7156799024374, 4128.938065929014, 4138.112296550117, 4164.250434921682, 4218.472690913636, 1284.9421776020101, 1336.211635135275, 1340.9865901341057, 1355.7966305054322, 1356.9118007329491, 963.5375019990304, 994.9204063674889, 998.7902540466583, 1003.6838395905412, 1019.3883669798062, 5928.911066334009, 5953.702314884238, 6053.848653783691, 6103.1455596216565, 6115.327313995457, 481.8554433669885, 491.2385802006875, 491.8499857543412, 498.4218306764136, 502.8943921776468, 4191.8532851350055, 4200.579942005775, 4216.810243539048, 4363.52001279859, 4572.428446444194, 11080.667579972614, 11258.21192516516, 11293.830592541119, 11405.885941140648, 11415.942920285512, 11172.776544469227, 11183.273087249303, 11197.384143872165, 11208.887911120948, 11279.379634120038, 7789.805254868674, 8190.140035296327, 8215.260626543639, 8241.052278987872, 8404.0, 5779.422057794187, 5903.026000709835, 5934.881302373842, 6027.36712645166, 6050.12792806227, 10196.235282353704, 10328.845067323846, 10353.482325883826, 10366.429846358522, 10449.738756530844, 10226.130778883879, 10315.587376504856, 10474.266801323834, 10483.161347092368, 10514.947425262824, 6508.707108180049, 7613.809654758676, 7782.416318776228, 7906.327962123284, 7982.760517184493, 8772.0, 8783.824323513367, 8811.118888111137, 8811.33914956368, 8838.425502342585, 7656.157822639394, 7697.8845317319165, 7780.066392032993, 7937.285644292041, 8089.029316481824, 7810.765677029698, 7921.524708517507, 7939.206079392246, 7981.920180798118, 7992.600369981361, 7231.4937954342695, 7255.354266510299, 7288.380487658396, 7331.120265568166, 7349.375303099297, 5307.283516725192, 5308.867278318073, 5403.189521571796, 5422.810201642924, 5470.124780035176, 5308.309919710413, 5353.652012619323, 5363.517283444508, 5450.482204190595, 5492.780288788564], "value": 4646.815910872465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.09697120777764, 315.55349180909013, 323.7733586489458, 325.91526203187163, 329.6999730245477, 5289.693941286696, 5412.810551630694, 5497.175423686449, 5508.944910550898, 5509.035918714224, 5425.864353391167, 5445.346558412996, 5447.836564903049, 5451.809186678467, 5460.535854452366, 4262.083652014816, 4266.807993640278, 4269.701120921537, 4273.29490634045, 4279.1441711657635, 4142.877836552634, 4262.381954616579, 4270.6760904119665, 4275.337322714969, 4288.721233119837, 4228.6617070634275, 4230.957690423103, 4236.978815105936, 4243.978780106095, 4247.469066366704, 4236.406903033578, 4242.80907359168, 4248.171606536695, 4254.702460671234, 4262.0591791663655, 3532.5054492371087, 3648.908777280563, 3668.4313931340685, 3674.926501469956, 3763.478469425464, 5313.707746073965, 5315.123004704219, 5324.361076670785, 5326.760295786699, 5328.20076988451, 4812.446568644616, 4823.300621409876, 4828.155072862235, 4830.3720516333005, 4833.975830120862, 5500.944990550083, 5654.151877218409, 5691.207269710028, 5697.829065128053, 5701.2018317435595, 4018.9196216075807, 4026.6778657707605, 4032.979835100835, 4033.7176397652174, 4038.7980600969836, 5876.647401155944, 5880.0, 5891.49922256613, 5902.97048514759, 5931.495822855062, 3912.667423268997, 4025.8389664413094, 4076.7374107370692, 4138.586141385837, 4161.771102589387, 4170.666346692257, 4188.3874708237545, 4192.559781222989, 4203.516595591485, 4203.91592168155, 4788.712677239377, 4795.098965126118, 4795.904081918412, 4811.27830825379, 4854.466008739107, 5445.9727701362035, 5709.628874123168, 5746.540276777848, 5773.451522105393, 5779.768809247667, 1444.7905053767145, 1484.9851501484848, 1488.3153749275455, 1492.276246020679, 1496.940122395092, 923.4301687131903, 941.4586612697726, 951.4909523405083, 969.9718298603503, 973.965911193119, 4809.927851082237, 4848.781804818721, 4875.268709693574, 4891.951080489221, 4913.877153071202, 5107.974460127675, 5131.358580177478, 5136.638790720462, 5145.122030458931, 5187.403448603383, 4585.839495617637, 4755.588014646318, 4866.31871537985, 4892.951070489249, 4897.4857639947295, 2691.206094202215, 2701.405690748032, 2731.3581308392513, 2744.4785490756694, 2747.5191841427672, 5265.183896496049, 5304.355649748513, 5306.548943339782, 5311.176767601028, 5334.653247538975, 5004.874878128003, 5185.740712964337, 5214.7914083437, 5225.268462415189, 5230.973845130826, 5268.710220937808, 5287.365516138011, 5303.575713942875, 5306.734663266744, 5306.8407947761625, 5114.4374118847645, 5114.769835357492, 5149.665271757323, 5163.709072731817, 5183.486009285418, 4893.08861227569, 5062.594992400525, 5065.265536497261, 5074.619403544675, 5098.260752190986, 5311.0, 5342.599305052059, 5344.412114667306, 5352.330958630171, 5366.946330536801, 3787.659110680052, 3837.0, 3861.4014827701753, 3881.592432794629, 3881.670058045098, 4773.737444440589, 5029.84910452687, 5080.771365288497, 5113.386393632788, 5124.487551244845, 5009.447071407875, 5018.799248030184, 5021.748912554431, 5026.4973502649445, 5030.421501527225, 4938.8765280868265, 4946.491320147389, 5007.874803129951, 5009.423916249678, 5010.446761503946, 5002.774875130555, 5272.0, 5758.683272420057, 5778.8266352009505, 5793.246877905845, 5808.680522571299, 5812.447817457335, 5817.854553636193, 5833.212516310244, 5838.10261664969, 5453.592029365559, 5679.886402271849, 5698.1452782083015, 5702.857428564319, 5714.257146571085], "value": 4130.4503225180515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.8726222910991, 737.3069314844042, 785.0521292546487, 818.9426740128193, 871.8648609465531, 15608.687826243467, 16557.66884662306, 17176.14119294035, 17237.13814309284, 17366.305347786107, 15821.920890395531, 16261.674766504693, 16363.100029498373, 16397.18014099296, 16407.097609631466, 662.5891946992871, 808.7735434078453, 809.4374409785202, 822.4037572759731, 828.511178404741, 827.6854795177824, 837.7235512280963, 838.5849004742661, 839.1063517353998, 842.2419822160074, 884.6549845560237, 886.6453418632566, 887.760304717729, 891.1133422244875, 891.7057371067532, 875.0287181228863, 877.2280393253959, 877.8332116897769, 882.1663527966107, 882.5940067568926, 639.0, 640.1741753138446, 644.2944975252138, 644.3427703742157, 644.5133923887435, 15836.76244856328, 15917.761233581505, 15992.28034738428, 16015.919920400323, 16079.035257884565, 15632.758031188274, 15657.608559785982, 15970.661889160525, 16316.592085197846, 16531.83468165327, 13068.86931130686, 13089.47642094315, 13231.0, 13368.264745438997, 13566.660833479242, 3970.4838371011583, 3970.7617542947514, 3979.8408063677416, 4007.9599204007877, 4034.979825100885, 88310.67533986995, 88425.67361489647, 88928.55535722345, 90098.0, 90640.54679726624, 12426.254424734545, 12451.315177665316, 12508.0, 12627.936860315824, 12641.304728239851, 24119.15582954588, 24205.15281965158, 24232.87883560606, 24253.39366515816, 24272.514549708907, 8701.695440659672, 8800.8679869802, 8901.688440904538, 8954.328425368123, 9034.14175653312, 4883.58489528387, 5000.89998200034, 5027.145385284511, 5054.949450505522, 5265.973670131625, 3685.3734865073, 3808.5429748430365, 3822.1591249924973, 3826.196498735241, 3837.520309961255, 596.1415561591381, 605.9575829691879, 607.908813677943, 616.5899676714935, 617.3486971245289, 584.3513699793226, 737.5390381011867, 741.1587847792794, 778.4823092643329, 779.766070178944, 10348.221119914251, 10363.2222488611, 10667.573297068031, 11169.776604467865, 11274.718132046764, 665.4077870695086, 720.5748608321115, 732.4433430592787, 746.6266866566716, 779.7504798464437, 4998.425181104147, 5214.426413094557, 5253.868653283698, 5325.041492531304, 5326.227696983916, 72212.63893680499, 101119.49440252752, 115515.0, 116554.41722791332, 121843.39078304551, 96999.0, 98282.0, 98749.0, 99333.50333248432, 100019.49990250148, 76299.0, 81766.59116704378, 88815.55592222126, 90983.0, 91347.54326228326, 8845.911540884767, 9033.909660903308, 10193.788956478686, 10696.14430845515, 11149.777004459704, 38588.80705596566, 49454.50545494499, 50293.74853125711, 53163.20255196098, 53390.46609533855, 76230.0, 77053.61473192822, 78864.60567697354, 81340.0, 82633.58683206786, 11163.776724465628, 11733.530658773554, 11828.881711182778, 11879.643610691694, 12095.939520302694, 13515.0, 13585.84555540132, 13590.59228223155, 13793.34389225892, 14019.579412617637, 13034.022448316604, 13146.079774415699, 13154.276514791778, 13221.074524783173, 14313.642158945693, 14275.928620356832, 14341.282935852956, 14442.494512692005, 14479.782803258171, 14741.778873317124, 13867.930660346634, 14204.928975355057, 14373.425062997363, 14605.780913286097, 14679.119252844863, 10924.0, 11209.15931305139, 11385.886141138482, 11399.943000284946, 11507.539698412305, 11308.717282068013, 11427.371494567546, 11762.828504463241, 12431.813522797345, 12891.677708057374], "value": 7855.878856683231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 113.0, 109.0, 115.0, 115.0, 111.0, 119.0, 112.0, 112.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 151.0, 178.0, 128.0, 156.0, 149.0, 124.0, 178.0, 124.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 169.0, 167.0, 164.0, 162.0, 164.0, 170.0, 166.0, 165.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 193.0, 79.0, 77.0, 77.0, 79.0, 164.0, 78.0], "value": 97.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 149.0, 89.0, 94.0, 88.0, 137.0, 87.0, 86.0, 155.0], "value": 105.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 149.0, 148.0, 151.0, 148.0, 148.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 58.0, 62.0, 56.0, 52.0, 54.0, 54.0, 53.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 61.0, 63.0, 64.0, 62.0, 65.0, 68.0, 63.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 92.0, 80.0, 85.0, 82.0, 87.0, 81.0, 81.0, 83.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 144.0, 135.0, 136.0, 141.0, 135.0, 142.0, 151.0, 144.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 164.0, 172.0, 165.0, 173.0, 169.0, 170.0, 165.0, 167.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 66.0, 68.0, 65.0, 66.0, 69.0, 64.0, 69.0], "value": 67.1, "unit": "score"}]}]} 22:32:56 INFO - Return code: 0 22:32:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:32:56 ERROR - # TBPL SUCCESS # 22:32:56 INFO - Running post-action listener: _resource_record_post_action 22:32:56 INFO - [mozharness: 2016-08-20 05:32:56.635020Z] Finished run-tests step (success) 22:32:56 INFO - Running post-run listener: _resource_record_post_run 22:32:56 INFO - Total resource usage - Wall time: 1193s; CPU: 14.0%; Read bytes: 0; Write bytes: 417497088; Read time: 0; Write time: 281188 22:32:56 INFO - TinderboxPrint: CPU usage
13.9% 22:32:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:32:56 INFO - TinderboxPrint: I/O write bytes / time
417,497,088 / 281,188 22:32:56 INFO - TinderboxPrint: CPU idle
8,189.3 (86.1%) 22:32:56 INFO - TinderboxPrint: CPU user
1,225.4 (12.9%) 22:32:56 INFO - TinderboxPrint: Swap in / out
0 / 0 22:32:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 129671168; Read time: 0; Write time: 90460 22:32:56 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 0; Write bytes: 287481856; Read time: 0; Write time: 190728 22:32:57 INFO - Running post-run listener: _upload_blobber_files 22:32:57 INFO - Blob upload gear active. 22:32:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:32:57 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 22:32:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:32:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:32:57 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:58 INFO - (blobuploader) - INFO - Done attempting. 22:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:01 INFO - (blobuploader) - INFO - Done attempting. 22:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:02 INFO - (blobuploader) - INFO - Done attempting. 22:33:02 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:02 INFO - Return code: 0 22:33:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9445ba4416d6e79a14e8fc95f075e252d2b0de8c2b7b301bae47bd406d6f32eb4975b28ea42b472683ef221193afac4534c0cf31c9fa93c9df12bc072a7e27a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc5b198dd88a58169c9ed3793b9fbd67d32724b4669c569469d11a6d9dc788739d9871203edc744aa94ed00dfd742b7b3f7ceb06af18dfa18b9103cb3ae72754", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88100146fd0f421a719c5d30c1d9662663d857634893905c69db88d7e680da8d530f2723c652cbcfe7e65b4efab2e3f502acaf3e5816f77fc5a8cc44db4b48c"} 22:33:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:02 INFO - Contents: 22:33:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9445ba4416d6e79a14e8fc95f075e252d2b0de8c2b7b301bae47bd406d6f32eb4975b28ea42b472683ef221193afac4534c0cf31c9fa93c9df12bc072a7e27a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc5b198dd88a58169c9ed3793b9fbd67d32724b4669c569469d11a6d9dc788739d9871203edc744aa94ed00dfd742b7b3f7ceb06af18dfa18b9103cb3ae72754", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88100146fd0f421a719c5d30c1d9662663d857634893905c69db88d7e680da8d530f2723c652cbcfe7e65b4efab2e3f502acaf3e5816f77fc5a8cc44db4b48c"} 22:33:02 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:02 INFO - Copying logs to upload dir... 22:33:02 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.653564 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-19 22:33:02.311419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 22:33:02.315793) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9445ba4416d6e79a14e8fc95f075e252d2b0de8c2b7b301bae47bd406d6f32eb4975b28ea42b472683ef221193afac4534c0cf31c9fa93c9df12bc072a7e27a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc5b198dd88a58169c9ed3793b9fbd67d32724b4669c569469d11a6d9dc788739d9871203edc744aa94ed00dfd742b7b3f7ceb06af18dfa18b9103cb3ae72754", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88100146fd0f421a719c5d30c1d9662663d857634893905c69db88d7e680da8d530f2723c652cbcfe7e65b4efab2e3f502acaf3e5816f77fc5a8cc44db4b48c"} build_url:https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/G2UwxmnyQjypC0FNA7lCxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9445ba4416d6e79a14e8fc95f075e252d2b0de8c2b7b301bae47bd406d6f32eb4975b28ea42b472683ef221193afac4534c0cf31c9fa93c9df12bc072a7e27a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc5b198dd88a58169c9ed3793b9fbd67d32724b4669c569469d11a6d9dc788739d9871203edc744aa94ed00dfd742b7b3f7ceb06af18dfa18b9103cb3ae72754", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88100146fd0f421a719c5d30c1d9662663d857634893905c69db88d7e680da8d530f2723c652cbcfe7e65b4efab2e3f502acaf3e5816f77fc5a8cc44db4b48c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 22:33:02.347162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:33:02.347509) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471669773.122187-73542756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 22:33:02.434862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 22:33:02.435500) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 22:33:02.436141) ========= ========= Total master_lag: 0.19 =========