builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1472779284.78 results: success (0) buildid: 20160901170142 builduid: 02cab5aab2a24838b41e2ab04ee0f466 revision: 4bee815089891447e819466885b771bf1db1f59a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.781717) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.782117) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.782395) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.826813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.827109) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 18:21:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-09-01 18:21:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.948519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:24.948918) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018136 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.059372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.059684) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4bee815089891447e819466885b771bf1db1f59a --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 4bee815089891447e819466885b771bf1db1f59a --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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 18:21:25,351 truncating revision to first 12 chars 2016-09-01 18:21:25,351 Setting DEBUG logging. 2016-09-01 18:21:25,351 attempt 1/10 2016-09-01 18:21:25,351 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4bee81508989?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 18:21:25,645 unpacking tar archive at: mozilla-central-4bee81508989/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.709680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.709982) ========= script_repo_revision: 4bee815089891447e819466885b771bf1db1f59a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.710405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.710674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 18:21:25.720261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-01 18:21:25.720543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:21:26 INFO - MultiFileLogger online at 20160901 18:21:26 in /builds/slave/test 18:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:21:26 INFO - {'append_to_log': False, 18:21:26 INFO - 'base_work_dir': '/builds/slave/test', 18:21:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:21:26 INFO - 'branch': 'Firefox-Non-PGO', 18:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:21:26 INFO - 'config_files': ('talos/linux_config.py',), 18:21:26 INFO - 'default_actions': ('clobber', 18:21:26 INFO - 'read-buildbot-config', 18:21:26 INFO - 'download-and-extract', 18:21:26 INFO - 'populate-webroot', 18:21:26 INFO - 'create-virtualenv', 18:21:26 INFO - 'install', 18:21:26 INFO - 'run-tests'), 18:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:21:26 INFO - 'download_minidump_stackwalk': True, 18:21:26 INFO - 'download_symbols': 'ondemand', 18:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:21:26 INFO - 'installer_path': 'installer.exe', 18:21:26 INFO - 'log_level': 'info', 18:21:26 INFO - 'log_name': 'talos', 18:21:26 INFO - 'log_to_console': True, 18:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:21:26 INFO - 'opt_config_files': (), 18:21:26 INFO - 'pip_index': False, 18:21:26 INFO - 'sps_profile': False, 18:21:26 INFO - 'sps_profile_interval': 0, 18:21:26 INFO - 'suite': 'dromaeojs-e10s', 18:21:26 INFO - 'system_bits': '32', 18:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:21:26 INFO - 'title': 'talos-linux64-ix-041', 18:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:21:26 INFO - 'use_talos_json': True, 18:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:21:26 INFO - 'work_dir': 'build'} 18:21:26 INFO - [mozharness: 2016-09-02 01:21:26.112165Z] Running clobber step. 18:21:26 INFO - Running pre-action listener: _resource_record_pre_action 18:21:26 INFO - Running main action method: clobber 18:21:26 INFO - rmtree: /builds/slave/test/build 18:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:21:27 INFO - Running post-action listener: _resource_record_post_action 18:21:27 INFO - [mozharness: 2016-09-02 01:21:27.090502Z] Finished clobber step (success) 18:21:27 INFO - [mozharness: 2016-09-02 01:21:27.090604Z] Running read-buildbot-config step. 18:21:27 INFO - Running pre-action listener: _resource_record_pre_action 18:21:27 INFO - Running main action method: read_buildbot_config 18:21:27 INFO - Using buildbot properties: 18:21:27 INFO - { 18:21:27 INFO - "project": "", 18:21:27 INFO - "product": "firefox", 18:21:27 INFO - "script_repo_revision": "production", 18:21:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:21:27 INFO - "repository": "", 18:21:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:21:27 INFO - "buildid": "20160901170142", 18:21:27 INFO - "pgo_build": "False", 18:21:27 INFO - "basedir": "/builds/slave/test", 18:21:27 INFO - "buildnumber": 432, 18:21:27 INFO - "slavename": "talos-linux64-ix-041", 18:21:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:21:27 INFO - "platform": "ubuntu64_hw", 18:21:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:21:27 INFO - "branch": "mozilla-central", 18:21:27 INFO - "repo_path": "mozilla-central", 18:21:27 INFO - "revision": "4bee815089891447e819466885b771bf1db1f59a", 18:21:27 INFO - "stage_platform": "linux64", 18:21:27 INFO - "builduid": "02cab5aab2a24838b41e2ab04ee0f466", 18:21:27 INFO - "slavebuilddir": "test" 18:21:27 INFO - } 18:21:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:21:27 INFO - Running post-action listener: _resource_record_post_action 18:21:27 INFO - [mozharness: 2016-09-02 01:21:27.093022Z] Finished read-buildbot-config step (success) 18:21:27 INFO - [mozharness: 2016-09-02 01:21:27.093111Z] Running download-and-extract step. 18:21:27 INFO - Running pre-action listener: _resource_record_pre_action 18:21:27 INFO - Running main action method: download_and_extract 18:21:27 INFO - mkdir: /builds/slave/test/build/tests 18:21: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')]} 18:21:27 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:21:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:27 INFO - Downloaded 1361 bytes. 18:21:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:21:27 INFO - Using the following test package requirements: 18:21:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:21:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:21:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'jsshell-linux-x86_64.zip'], 18:21:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:21:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:21:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:21:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:21:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:21:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:21: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')]} 18:21:27 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:21:27 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:28 INFO - Downloaded 20334479 bytes. 18:21: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 18:21: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 18:21: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')]} 18:21:32 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:21:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:33 INFO - Downloaded 20334479 bytes. 18:21: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 18:21: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')]} 18:21:38 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:38 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:39 INFO - Downloaded 14413998 bytes. 18:21:39 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 18:21:39 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')]} 18:21:39 INFO - trying https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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 18:21:40 INFO - Downloaded 55870683 bytes. 18:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:40 INFO - mkdir: /builds/slave/test/properties 18:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:21:40 INFO - Writing to file /builds/slave/test/properties/build_url 18:21:40 INFO - Contents: 18:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:21:41 INFO - Running post-action listener: _resource_record_post_action 18:21:41 INFO - Running post-action listener: set_extra_try_arguments 18:21:41 INFO - [mozharness: 2016-09-02 01:21:41.514468Z] Finished download-and-extract step (success) 18:21:41 INFO - [mozharness: 2016-09-02 01:21:41.514695Z] Running populate-webroot step. 18:21:41 INFO - Running pre-action listener: _resource_record_pre_action 18:21:41 INFO - Running main action method: populate_webroot 18:21:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:41 INFO - '--tppagecycles', 18:21:41 INFO - '7'], 18:21:41 INFO - 'tests': ['tsvgm']}}, 18:21:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:21:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:21:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:21:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['damp', 'tps']}, 18:21:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'tests': ['damp', 'tps']}, 18:21:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['dromaeo_dom']}, 18:21:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['basic_compositor_video']}, 18:21:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:21:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['a11yr', 18:21:41 INFO - 'ts_paint', 18:21:41 INFO - 'tpaint', 18:21:41 INFO - 'sessionrestore', 18:21:41 INFO - 'sessionrestore_no_auto_restore', 18:21:41 INFO - 'tabpaint']}, 18:21:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['tsvgx', 18:21:41 INFO - 'tsvgr_opacity', 18:21:41 INFO - 'tart', 18:21:41 INFO - 'tscrollx', 18:21:41 INFO - 'cart']}, 18:21:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:21:41 INFO - 'tsvgr_opacity', 18:21:41 INFO - 'tart', 18:21:41 INFO - 'tscrollx', 18:21:41 INFO - 'cart']}, 18:21:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'talos_options': ['--disable-e10s'], 18:21:41 INFO - 'tests': ['tp5o']}, 18:21:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'tests': ['tp5o']}, 18:21:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'talos_options': ['--disable-e10s', 18:21:41 INFO - '--xperf_path', 18:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:41 INFO - 'tests': ['tp5n']}, 18:21:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:41 INFO - 'talos_options': ['--xperf_path', 18:21:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:41 INFO - 'tests': ['tp5n']}}, 18:21:41 INFO - 'talos.zip': {'path': '', 18:21:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:41 INFO - Running post-action listener: _resource_record_post_action 18:21:41 INFO - [mozharness: 2016-09-02 01:21:41.537167Z] Finished populate-webroot step (success) 18:21:41 INFO - [mozharness: 2016-09-02 01:21:41.537256Z] Running create-virtualenv step. 18:21:41 INFO - Running pre-action listener: _resource_record_pre_action 18:21:41 INFO - Running main action method: create_virtualenv 18:21:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:21: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 18:21:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:21:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:41 INFO - Using real prefix '/usr' 18:21:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:21:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:44 INFO - Installing pip.................done. 18:21:44 INFO - Return code: 0 18:21:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:44 INFO - Using env: {'DISPLAY': ':0', 18:21:44 INFO - 'HOME': '/home/cltbld', 18:21:44 INFO - 'LANG': 'en_US.UTF-8', 18:21:44 INFO - 'LANGUAGE': 'en_US:en', 18:21:44 INFO - 'LOGNAME': 'cltbld', 18:21:44 INFO - 'MAIL': '/var/mail/cltbld', 18:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:44 INFO - 'MOZ_NO_REMOTE': '1', 18:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:44 INFO - 'NO_EM_RESTART': '1', 18:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:44 INFO - 'PWD': '/builds/slave/test', 18:21:44 INFO - 'SHELL': '/bin/bash', 18:21:44 INFO - 'SHLVL': '1', 18:21:44 INFO - 'TERM': 'linux', 18:21:44 INFO - 'TMOUT': '86400', 18:21:44 INFO - 'USER': 'cltbld', 18:21:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:44 INFO - '_': '/tools/buildbot/bin/python'} 18:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21: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 18:21:44 INFO - Cleaning up... 18:21:44 INFO - Return code: 0 18:21:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:44 INFO - Using env: {'DISPLAY': ':0', 18:21:44 INFO - 'HOME': '/home/cltbld', 18:21:44 INFO - 'LANG': 'en_US.UTF-8', 18:21:44 INFO - 'LANGUAGE': 'en_US:en', 18:21:44 INFO - 'LOGNAME': 'cltbld', 18:21:44 INFO - 'MAIL': '/var/mail/cltbld', 18:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:44 INFO - 'MOZ_NO_REMOTE': '1', 18:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:44 INFO - 'NO_EM_RESTART': '1', 18:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:44 INFO - 'PWD': '/builds/slave/test', 18:21:44 INFO - 'SHELL': '/bin/bash', 18:21:44 INFO - 'SHLVL': '1', 18:21:44 INFO - 'TERM': 'linux', 18:21:44 INFO - 'TMOUT': '86400', 18:21:44 INFO - 'USER': 'cltbld', 18:21:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:44 INFO - '_': '/tools/buildbot/bin/python'} 18:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:44 INFO - Downloading/unpacking psutil>=3.1.1 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:46 INFO - Installing collected packages: psutil 18:21:46 INFO - Running setup.py install for psutil 18:21:46 INFO - building 'psutil._psutil_linux' extension 18:21: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 18:21: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 18:21:46 INFO - building 'psutil._psutil_posix' extension 18:21: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 18:21: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:47 INFO - Successfully installed psutil 18:21:47 INFO - Cleaning up... 18:21:47 INFO - Return code: 0 18:21:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:47 INFO - Using env: {'DISPLAY': ':0', 18:21:47 INFO - 'HOME': '/home/cltbld', 18:21:47 INFO - 'LANG': 'en_US.UTF-8', 18:21:47 INFO - 'LANGUAGE': 'en_US:en', 18:21:47 INFO - 'LOGNAME': 'cltbld', 18:21:47 INFO - 'MAIL': '/var/mail/cltbld', 18:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:47 INFO - 'MOZ_NO_REMOTE': '1', 18:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:47 INFO - 'NO_EM_RESTART': '1', 18:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:47 INFO - 'PWD': '/builds/slave/test', 18:21:47 INFO - 'SHELL': '/bin/bash', 18:21:47 INFO - 'SHLVL': '1', 18:21:47 INFO - 'TERM': 'linux', 18:21:47 INFO - 'TMOUT': '86400', 18:21:47 INFO - 'USER': 'cltbld', 18:21:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:47 INFO - '_': '/tools/buildbot/bin/python'} 18:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:21:49 INFO - Installing collected packages: mozsystemmonitor 18:21:49 INFO - Running setup.py install for mozsystemmonitor 18:21:49 INFO - Successfully installed mozsystemmonitor 18:21:49 INFO - Cleaning up... 18:21:49 INFO - Return code: 0 18:21:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:49 INFO - Using env: {'DISPLAY': ':0', 18:21:49 INFO - 'HOME': '/home/cltbld', 18:21:49 INFO - 'LANG': 'en_US.UTF-8', 18:21:49 INFO - 'LANGUAGE': 'en_US:en', 18:21:49 INFO - 'LOGNAME': 'cltbld', 18:21:49 INFO - 'MAIL': '/var/mail/cltbld', 18:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:49 INFO - 'MOZ_NO_REMOTE': '1', 18:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:49 INFO - 'NO_EM_RESTART': '1', 18:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:49 INFO - 'PWD': '/builds/slave/test', 18:21:49 INFO - 'SHELL': '/bin/bash', 18:21:49 INFO - 'SHLVL': '1', 18:21:49 INFO - 'TERM': 'linux', 18:21:49 INFO - 'TMOUT': '86400', 18:21:49 INFO - 'USER': 'cltbld', 18:21:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:49 INFO - '_': '/tools/buildbot/bin/python'} 18:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:49 INFO - Downloading/unpacking jsonschema==2.5.1 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:21:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:51 INFO - Downloading functools32-3.2.3-2.tar.gz 18:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:21:51 INFO - warning: no files found matching '*.txt' 18:21:51 INFO - no previously-included directories found matching 'build' 18:21:51 INFO - no previously-included directories found matching 'dist' 18:21:51 INFO - no previously-included directories found matching '.git*' 18:21:51 INFO - Installing collected packages: jsonschema, functools32 18:21:51 INFO - Running setup.py install for functools32 18:21:51 INFO - warning: no files found matching '*.txt' 18:21:51 INFO - no previously-included directories found matching 'build' 18:21:51 INFO - no previously-included directories found matching 'dist' 18:21:51 INFO - no previously-included directories found matching '.git*' 18:21:51 INFO - Successfully installed jsonschema functools32 18:21:51 INFO - Cleaning up... 18:21:51 INFO - Return code: 0 18:21:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:21:51 INFO - Using env: {'DISPLAY': ':0', 18:21:51 INFO - 'HOME': '/home/cltbld', 18:21:51 INFO - 'LANG': 'en_US.UTF-8', 18:21:51 INFO - 'LANGUAGE': 'en_US:en', 18:21:51 INFO - 'LOGNAME': 'cltbld', 18:21:51 INFO - 'MAIL': '/var/mail/cltbld', 18:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:51 INFO - 'MOZ_NO_REMOTE': '1', 18:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:51 INFO - 'NO_EM_RESTART': '1', 18:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:51 INFO - 'PWD': '/builds/slave/test', 18:21:51 INFO - 'SHELL': '/bin/bash', 18:21:51 INFO - 'SHLVL': '1', 18:21:51 INFO - 'TERM': 'linux', 18:21:51 INFO - 'TMOUT': '86400', 18:21:51 INFO - 'USER': 'cltbld', 18:21:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:51 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:21:52 INFO - Cleaning up... 18:21:52 INFO - Return code: 0 18:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:52 INFO - Using env: {'DISPLAY': ':0', 18:21:52 INFO - 'HOME': '/home/cltbld', 18:21:52 INFO - 'LANG': 'en_US.UTF-8', 18:21:52 INFO - 'LANGUAGE': 'en_US:en', 18:21:52 INFO - 'LOGNAME': 'cltbld', 18:21:52 INFO - 'MAIL': '/var/mail/cltbld', 18:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:52 INFO - 'MOZ_NO_REMOTE': '1', 18:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:52 INFO - 'NO_EM_RESTART': '1', 18:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:52 INFO - 'PWD': '/builds/slave/test', 18:21:52 INFO - 'SHELL': '/bin/bash', 18:21:52 INFO - 'SHLVL': '1', 18:21:52 INFO - 'TERM': 'linux', 18:21:52 INFO - 'TMOUT': '86400', 18:21:52 INFO - 'USER': 'cltbld', 18:21:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:52 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:54 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:54 INFO - Downloading docopt-0.6.1.tar.gz 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:54 INFO - Running setup.py install for blobuploader 18:21:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:55 INFO - Running setup.py install for requests 18:21:55 INFO - Running setup.py install for docopt 18:21:55 INFO - Successfully installed blobuploader requests docopt 18:21:55 INFO - Cleaning up... 18:21:55 INFO - Return code: 0 18:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21: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 18:21: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 18:21:55 INFO - Using env: {'DISPLAY': ':0', 18:21:55 INFO - 'HOME': '/home/cltbld', 18:21:55 INFO - 'LANG': 'en_US.UTF-8', 18:21:55 INFO - 'LANGUAGE': 'en_US:en', 18:21:55 INFO - 'LOGNAME': 'cltbld', 18:21:55 INFO - 'MAIL': '/var/mail/cltbld', 18:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:55 INFO - 'MOZ_NO_REMOTE': '1', 18:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:55 INFO - 'NO_EM_RESTART': '1', 18:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:55 INFO - 'PWD': '/builds/slave/test', 18:21:55 INFO - 'SHELL': '/bin/bash', 18:21:55 INFO - 'SHLVL': '1', 18:21:55 INFO - 'TERM': 'linux', 18:21:55 INFO - 'TMOUT': '86400', 18:21:55 INFO - 'USER': 'cltbld', 18:21:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:55 INFO - '_': '/tools/buildbot/bin/python'} 18:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:55 INFO - Running setup.py (path:/tmp/pip-KgJIQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:55 INFO - Running setup.py (path:/tmp/pip-kGZ3lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:55 INFO - Running setup.py (path:/tmp/pip-cAPLWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:56 INFO - Running setup.py (path:/tmp/pip-rl92OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:56 INFO - Running setup.py (path:/tmp/pip-iwJ8i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:56 INFO - Running setup.py (path:/tmp/pip-xNWqOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:56 INFO - Running setup.py (path:/tmp/pip-i889MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:56 INFO - Running setup.py (path:/tmp/pip-Ntftfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:56 INFO - Running setup.py (path:/tmp/pip-ZbPFsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:56 INFO - Running setup.py (path:/tmp/pip-zsJu_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:56 INFO - Running setup.py (path:/tmp/pip-1j3tMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:56 INFO - Running setup.py (path:/tmp/pip-YWSRvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:56 INFO - Running setup.py (path:/tmp/pip-AxaNWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:56 INFO - Running setup.py (path:/tmp/pip-96iLnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:56 INFO - Running setup.py (path:/tmp/pip-7vGvBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:56 INFO - Running setup.py (path:/tmp/pip-SWn4MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:56 INFO - Running setup.py (path:/tmp/pip-Nq5IcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:57 INFO - Running setup.py install for manifestparser 18:21:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozcrash 18:21:57 INFO - Running setup.py install for mozdebug 18:21:57 INFO - Running setup.py install for mozdevice 18:21:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozfile 18:21:57 INFO - Running setup.py install for mozhttpd 18:21:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozinfo 18:21:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozInstall 18:21:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:57 INFO - Running setup.py install for mozleak 18:21:57 INFO - Running setup.py install for mozlog 18:21:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for moznetwork 18:21:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozprocess 18:21:58 INFO - Running setup.py install for mozprofile 18:21:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozrunner 18:21:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Running setup.py install for mozscreenshot 18:21:58 INFO - Running setup.py install for moztest 18:21:58 INFO - Running setup.py install for mozversion 18:21:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:58 INFO - Cleaning up... 18:21:58 INFO - Return code: 0 18:21:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:58 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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:21:58 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 18:21:58 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 18:21:58 INFO - Using env: {'DISPLAY': ':0', 18:21:58 INFO - 'HOME': '/home/cltbld', 18:21:58 INFO - 'LANG': 'en_US.UTF-8', 18:21:58 INFO - 'LANGUAGE': 'en_US:en', 18:21:58 INFO - 'LOGNAME': 'cltbld', 18:21:58 INFO - 'MAIL': '/var/mail/cltbld', 18:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:58 INFO - 'MOZ_NO_REMOTE': '1', 18:21:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:58 INFO - 'NO_EM_RESTART': '1', 18:21:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:58 INFO - 'PWD': '/builds/slave/test', 18:21:58 INFO - 'SHELL': '/bin/bash', 18:21:58 INFO - 'SHLVL': '1', 18:21:58 INFO - 'TERM': 'linux', 18:21:58 INFO - 'TMOUT': '86400', 18:21:58 INFO - 'USER': 'cltbld', 18:21:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:58 INFO - '_': '/tools/buildbot/bin/python'} 18:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:59 INFO - Running setup.py (path:/tmp/pip-6mB9JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:59 INFO - Running setup.py (path:/tmp/pip-_w3phx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:59 INFO - Running setup.py (path:/tmp/pip-ioX2HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:59 INFO - Running setup.py (path:/tmp/pip-YfCtXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:59 INFO - Running setup.py (path:/tmp/pip-687hoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:59 INFO - Running setup.py (path:/tmp/pip-Kcbf9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:59 INFO - Running setup.py (path:/tmp/pip-DnaEqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:59 INFO - Running setup.py (path:/tmp/pip-qRdMYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:59 INFO - Running setup.py (path:/tmp/pip-31VASc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21: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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:59 INFO - Running setup.py (path:/tmp/pip-QNA3bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:59 INFO - Running setup.py (path:/tmp/pip-dPAXkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:59 INFO - Running setup.py (path:/tmp/pip-J8SWDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:59 INFO - Running setup.py (path:/tmp/pip-XSbkBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:59 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)) 18:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:00 INFO - Running setup.py (path:/tmp/pip-KeMFdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22: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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:00 INFO - Running setup.py (path:/tmp/pip-UGKB_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22: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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:00 INFO - Running setup.py (path:/tmp/pip-Me5dgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22: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)) 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:00 INFO - Running setup.py (path:/tmp/pip-KtDSMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22: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)) 18:22: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)) 18:22: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)) 18:22: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)) 18:22: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)) 18:22: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)) 18:22:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:02 INFO - Downloading blessings-1.6.tar.gz 18:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:02 INFO - Installing collected packages: blessings 18:22:02 INFO - Running setup.py install for blessings 18:22:02 INFO - Successfully installed blessings 18:22:02 INFO - Cleaning up... 18:22:02 INFO - Return code: 0 18:22:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:02 INFO - Reading from file tmpfile_stdout 18:22:02 INFO - Current package versions: 18:22:02 INFO - argparse == 1.2.1 18:22:02 INFO - blessings == 1.6 18:22:02 INFO - blobuploader == 1.2.4 18:22:02 INFO - docopt == 0.6.1 18:22:02 INFO - functools32 == 3.2.3-2 18:22:02 INFO - jsonschema == 2.5.1 18:22:02 INFO - manifestparser == 1.1 18:22:02 INFO - mozInstall == 1.12 18:22:02 INFO - mozcrash == 0.17 18:22:02 INFO - mozdebug == 0.1 18:22:02 INFO - mozdevice == 0.48 18:22:02 INFO - mozfile == 1.2 18:22:02 INFO - mozhttpd == 0.7 18:22:02 INFO - mozinfo == 0.9 18:22:02 INFO - mozleak == 0.1 18:22:02 INFO - mozlog == 3.3 18:22:02 INFO - moznetwork == 0.27 18:22:02 INFO - mozprocess == 0.23 18:22:02 INFO - mozprofile == 0.28 18:22:02 INFO - mozrunner == 6.12 18:22:02 INFO - mozscreenshot == 0.1 18:22:02 INFO - mozsystemmonitor == 0.3 18:22:02 INFO - moztest == 0.7 18:22:02 INFO - mozversion == 1.4 18:22:02 INFO - psutil == 3.1.1 18:22:02 INFO - requests == 1.2.3 18:22:02 INFO - wsgiref == 0.1.2 18:22:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:22: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 18:22: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 18:22:02 INFO - Using env: {'DISPLAY': ':0', 18:22:02 INFO - 'HOME': '/home/cltbld', 18:22:02 INFO - 'LANG': 'en_US.UTF-8', 18:22:02 INFO - 'LANGUAGE': 'en_US:en', 18:22:02 INFO - 'LOGNAME': 'cltbld', 18:22:02 INFO - 'MAIL': '/var/mail/cltbld', 18:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:02 INFO - 'MOZ_NO_REMOTE': '1', 18:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:02 INFO - 'NO_EM_RESTART': '1', 18:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:02 INFO - 'PWD': '/builds/slave/test', 18:22:02 INFO - 'SHELL': '/bin/bash', 18:22:02 INFO - 'SHLVL': '1', 18:22:02 INFO - 'TERM': 'linux', 18:22:02 INFO - 'TMOUT': '86400', 18:22:02 INFO - 'USER': 'cltbld', 18:22:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:02 INFO - '_': '/tools/buildbot/bin/python'} 18:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 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)) 18:22:02 INFO - Cleaning up... 18:22:02 INFO - Return code: 0 18:22:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:02 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 0x7fa29e8eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', '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 18:22:02 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 18:22:02 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 18:22:02 INFO - Using env: {'DISPLAY': ':0', 18:22:02 INFO - 'HOME': '/home/cltbld', 18:22:02 INFO - 'LANG': 'en_US.UTF-8', 18:22:02 INFO - 'LANGUAGE': 'en_US:en', 18:22:02 INFO - 'LOGNAME': 'cltbld', 18:22:02 INFO - 'MAIL': '/var/mail/cltbld', 18:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:02 INFO - 'MOZ_NO_REMOTE': '1', 18:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:02 INFO - 'NO_EM_RESTART': '1', 18:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:02 INFO - 'PWD': '/builds/slave/test', 18:22:02 INFO - 'SHELL': '/bin/bash', 18:22:02 INFO - 'SHLVL': '1', 18:22:02 INFO - 'TERM': 'linux', 18:22:02 INFO - 'TMOUT': '86400', 18:22:02 INFO - 'USER': 'cltbld', 18:22:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:02 INFO - '_': '/tools/buildbot/bin/python'} 18:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:22:03 INFO - Cleaning up... 18:22:03 INFO - Return code: 0 18:22:03 INFO - Running post-action listener: _resource_record_post_action 18:22:03 INFO - Running post-action listener: _start_resource_monitoring 18:22:03 INFO - Starting resource monitoring. 18:22:03 INFO - [mozharness: 2016-09-02 01:22:03.110064Z] Finished create-virtualenv step (success) 18:22:03 INFO - [mozharness: 2016-09-02 01:22:03.110579Z] Running install step. 18:22:03 INFO - Running pre-action listener: _resource_record_pre_action 18:22:03 INFO - Running main action method: install 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Output received: 18:22:03 INFO - Usage: mozinstall [options] installer 18:22:03 INFO - Options: 18:22:03 INFO - -h, --help show this help message and exit 18:22:03 INFO - -d DEST, --destination=DEST 18:22:03 INFO - Directory to install application into. [default: 18:22:03 INFO - "/builds/slave/test"] 18:22:03 INFO - --app=APP Application being installed. [default: firefox] 18:22:03 INFO - mkdir: /builds/slave/test/build/application 18:22: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'] 18:22: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 18:22:20 INFO - Reading from file tmpfile_stdout 18:22:20 INFO - Output received: 18:22:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:22:20 INFO - Running post-action listener: _resource_record_post_action 18:22:20 INFO - [mozharness: 2016-09-02 01:22:20.114392Z] Finished install step (success) 18:22:20 INFO - [mozharness: 2016-09-02 01:22:20.114672Z] Running run-tests step. 18:22:20 INFO - Running pre-action listener: _resource_record_pre_action 18:22:20 INFO - Running main action method: run_tests 18:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:22:20 INFO - Python 2.7.3 18:22:20 INFO - Return code: 0 18:22:20 INFO - grabbing minidump binary from tooltool 18:22: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')]} 18:22: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 0x283e090>, '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 0x28419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:22: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 18:22: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 18:22: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 18:22:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:22:20 INFO - Return code: 0 18:22:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:22:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 18:22:20 INFO - Using env: {'DISPLAY': ':0', 18:22:20 INFO - 'HOME': '/home/cltbld', 18:22:20 INFO - 'LANG': 'en_US.UTF-8', 18:22:20 INFO - 'LANGUAGE': 'en_US:en', 18:22:20 INFO - 'LOGNAME': 'cltbld', 18:22:20 INFO - 'MAIL': '/var/mail/cltbld', 18:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:20 INFO - 'MOZ_NO_REMOTE': '1', 18:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:20 INFO - 'NO_EM_RESTART': '1', 18:22:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:20 INFO - 'PWD': '/builds/slave/test', 18:22:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:22:20 INFO - 'SHELL': '/bin/bash', 18:22:20 INFO - 'SHLVL': '1', 18:22:20 INFO - 'TERM': 'linux', 18:22:20 INFO - 'TMOUT': '86400', 18:22:20 INFO - 'USER': 'cltbld', 18:22:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772', 18:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:20 INFO - '_': '/tools/buildbot/bin/python'} 18:22:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:22:20 INFO - mozversion application_buildid: 20160901170142 18:22:20 INFO - mozversion application_changeset: 4bee815089891447e819466885b771bf1db1f59a 18:22:20 INFO - mozversion application_display_name: Nightly 18:22:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:22:20 INFO - mozversion application_name: Firefox 18:22:20 INFO - mozversion application_remotingname: firefox 18:22:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:22:20 INFO - mozversion application_vendor: Mozilla 18:22:20 INFO - mozversion application_version: 51.0a1 18:22:20 INFO - mozversion platform_buildid: 20160901170142 18:22:20 INFO - mozversion platform_changeset: 4bee815089891447e819466885b771bf1db1f59a 18:22:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:22:20 INFO - mozversion platform_version: 51.0a1 18:22:20 INFO - using testdate: 1472779340 18:22:20 INFO - actual date: 1472779340 18:22:20 INFO - starting webserver on 'localhost:36502' 18:22:20 INFO - SUITE-START | Running 2 tests 18:22:20 INFO - TEST-START | dromaeo_css 18:22:20 INFO - operating with platform_type : linux_ 18:22:20 INFO - Initialising browser for dromaeo_css test... 18:22:20 INFO - TEST-INFO | started process 29037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnzUC0s/profile http://localhost:36502/getInfo.html) 18:22:25 INFO - PROCESS | 29037 | __metrics Screen width/height:1600/1200 18:22:25 INFO - PROCESS | 29037 | colorDepth:24 18:22:25 INFO - PROCESS | 29037 | Browser inner width/height: 1024/697 18:22:25 INFO - PROCESS | 29037 | __metrics 18:22:26 ERROR - PROCESS | 29037 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 18:22:26 INFO - TEST-INFO | 29037: exit 0 18:22:26 INFO - Browser initialized. 18:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 18:22:27 INFO - TEST-INFO | started process 29159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnzUC0s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:39 INFO - PROCESS | 29159 | RSS: Main: 193683456 18:22:39 INFO - PROCESS | 29159 | 18:23:28 INFO - PROCESS | 29159 | 1472779408955 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] 18:25:42 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36502/tests/dromaeo/cssquery-ext.html) 18:25:43 INFO - PROCESS | 29159 | RSS: Main: 207683584 18:25:43 INFO - PROCESS | 29159 | 18:28:45 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-ext.html (next: http://localhost:36502/tests/dromaeo/cssquery-jquery.html) 18:28:46 INFO - PROCESS | 29159 | RSS: Main: 201637888 18:28:46 INFO - PROCESS | 29159 | 18:31:48 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36502/tests/dromaeo/cssquery-mootools.html) 18:31:49 INFO - PROCESS | 29159 | RSS: Main: 201986048 18:31:49 INFO - PROCESS | 29159 | 18:34:51 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36502/tests/dromaeo/cssquery-prototype.html) 18:34:51 INFO - PROCESS | 29159 | RSS: Main: 195432448 18:34:51 INFO - PROCESS | 29159 | 18:37:54 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36502/tests/dromaeo/cssquery-yui.html) 18:37:55 INFO - PROCESS | 29159 | RSS: Main: 199282688 18:37:55 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | Cycle 1(1): loaded http://localhost:36502/tests/dromaeo/cssquery-yui.html (next: http://localhost:36502/tests/dromaeo/cssquery-dojo.html) 18:40:58 INFO - PROCESS | 29159 | RSS: Main: 200658944 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | __start_tp_report 18:40:58 INFO - PROCESS | 29159 | _x_x_mozilla_page_load 18:40:58 INFO - PROCESS | 29159 | _x_x_mozilla_page_load_details 18:40:58 INFO - PROCESS | 29159 | |i|pagename|runs| 18:40:58 INFO - PROCESS | 29159 | |0;dojo.html;2666.0535509893975;2672.4120693447444;2687.556553168727;2690.7712844408225;2693.434378780456;4747.691400058994;4782.545658162473;4829.203181475061;4868.756562171895;4950.653454258194;4824.879378015551;4827.058723548909;4835.057163853041;4878.536539028795;4902.09311277414;4410.911781764363;4502.212112880249;4513.7517436540975;4623.468301145378;4628.074385122972;4561.156186105564;4570.588647021767;4589.265717485203;4602.194615942197;4614.792334344946;4361.6074553290355;4462.1968045751755;4466.12910482456;4514.052049069666;4546.749928753918;4452.710573812692;4462.308342206963;4467.106578684276;4538.251188553884;4580.770961451914;4477.552244775529;4489.034857505652;4504.842330518449;4507.459104907432;4571.451425828922;4838.322634831126;4878.658493905428;4890.535399137077;4895.363602731622;4933.161362568372;5200.063988482072;5200.92198617021;5227.18978558324;5227.320448341729;5262.421133675292;5228.686278823283;5247.86880327991;5255.159174532095;5275.525202731773;5301.098813201765;4719.268513380432;4757.738324392191;4786.928196077061;4806.062817750505;4851.223804191312;5253.842384728464;5264.184051472028;5277.788888444496;5283.1546952487415;5283.392409872837;5050.84847454577;5060.342155519833;5068.797248110108;5072.315237442898;5125.15434953236;5036.496350364934;5176.06830770465;5217.139172036572;5225.399079105876;5331.600129990266;5210.244514545369;5213.244079608511;5226.555742761908;5231.267622532849;5234.345706786652;5130.9230361544605;5200.141976573898;5208.244804503326;5214.765335559909;5261.605379596545;4235.682323825664;4357.629601483909;4406.5593440655675;4431.8670439886855;4470.798814053375;3847.3074846527893;3854.6338097880657;3859.729818912649;3907.7264591478324;3909.3745000800304;4567.588916997486;4598.885027874263;4599.655025873073;4611.930821037688;4673.813047478063;5110.412302585176;5191.039657663345;5229.529342359206;5246.842594722164;5316.680999140064;4533.705309154894;4555.088982203572;4570.360149579062;4572.702774319659;4628.652851036186;4717.481077081518;4721.811127554928;4723.811047558128;4731;4783.330333753277;4762.238041913277;4878.731669758197;4916.606671466346;4936.82721104774;5004.499550044967;5257.237700533325;5262.631615786858;5280.075986702389;5292.338457692788;5298.682079075268;4794.760261986817;4940.283658869515;4945.4807245238735;4954.058728841508;4994.400671919393;5076.18780995039;5136.5377116059735;5144.279800827812;5150.819721309736;5156.61325400589;5230.424653288059;5274.683518988873;5303.522682958553;5353.411124776349;5354.303940487712;5145.61407894402;5151.381834179772;5154;5155.252488389087;5158.3552055993005;5140.126178549581;5143.665661731976;5145.845624631267;5157.793688252428;5189.040027594907;4840.782164802663;4941.50584941503;4990.226514890198;5010.49895010496;5102.515261050195;5143.61422893292;5146.279520867157;5149.459306772735;5152.742362881916;5153.845384638467;5034.043531728959;5035.043341765053;5038.647294689336;5045.899082018413;5087.033463641897 18:40:58 INFO - PROCESS | 29159 | |1;ext.html;532.8587924200085;539.3527766679983;553.5571542765787;555.9944400555993;569.6752850875002;34374.48438273425;38609.80695096524;38642.806785966066;38744.61255387445;38754.41868371977;38248;38602.227955440874;38682.22635547287;38689;39089.21821563567;7197.82005449864;7359.3744531714865;7372.18905920351;7383.261673832628;7388.482806203568;6381.904271435932;6403.263624683151;6450.516211284149;6451.741930322782;6453.225612926455;6417.39034791694;6433.6461494618015;6446.935530644704;6473.223213214421;6485.67571621417;6418.229812422539;6447.323031081739;6468.15913931186;6474.870502589945;6477.74089036438;7459.44054195932;7658.808529786744;7658.961705191438;7670.348020418215;7684.807879802994;36592.26815463676;36831.81584092062;36840;36888.63111368879;36892;2879.7984141110132;2920.7225313595172;2973.2418233350572;2985.9552106718415;3223.8549265282886;27373.589396159074;27826.443471130668;28132.85933570319;28419.715802841914;28709;3423.5207071010077;3432.2105915639295;3500.611384223802;3536.3634545781747;3539.522164507784;257103;257698;257919;258251;258481;27180.320491987462;50133;50408.49591504038;50413.24380134301;50529.494705053214;32632.510512341858;32644;32716;32807.67192328046;33002.17494562655;13541.1198272112;13662.658433539042;13698.726025479635;13718.794218086736;13730.51943181984;11047.558097676003;11101.500432480396;11125.054370378446;11128.165387595962;11134.610288639858;7497.2877576630135;7627.809304767426;7680.34717049046;7680.9231907680205;7700.576468294185;2994.2633272701783;3005.4590173768493;3049.9172793658377;3070.6008218931397;3111.6266048074376;833.6707000734797;852.6887685994567;853.1298075962608;853.9146085391411;916.0107084348887;24536.877315613663;27028.324291892466;27234.45531089367;27937.16188514348;28000.579991300147;935.475175464003;957.5978089202413;1024.262530977695;1028.9176865850714;1045.9163266938626;14341.498047568284;14450.757764222275;14452.277386130652;14546.199959002144;14600.707985840223;376755;378405;378865;379862;380184;46926;47475.762621187365;47504;47515;47652.28521572179;1120.7478317378689;1152.7262574289227;1166.9299842009507;1168.6201984355118;1173.5481839491856;24123.28951232754;24782.38044048913;26327.605085923344;26380.60429093527;26621.600675990263;40792.59207407888;40992.79503602463;41045.58954410418;41046;41052.17895642011;315665;317072;317126;317480;319440;23994.76005239925;24225.757742423055;24367.14714984967;24963.251102466955;25065.87467062653;40503;40589.59410405976;40885.79557102315;40917.38623920584;41380.37929431121;34625.653743462244;35009;35273;35582.46626300556;35843;33436;34847;34885.82557087198;35416.29167416689;35746.28507429785;33550.32899342048;34116;34315.65684343225;34978.825105874304;35103;29420.852895735385;31933.520997185526;31950;32309.35381292408;32420.675793241764;24296.51406971886;24313.149039783522;24676.753232467447;24912.37719057038;25146.49707005813 18:40:58 INFO - PROCESS | 29159 | |2;jquery.html;364.475155775683;367.45433031947556;371.1093375897845;374.9793761343129;386.72928949735194;15278.15970121643;16215.756763648555;16658.916705416486;16670.58323541912;16729.16354182292;15540.689186216297;16294.429694960649;16318.102504362256;16414.09722465264;16434.013959162457;4793.897403597183;5060.797568097271;5061.6962982221185;5071.695698258098;5071.923921141186;3607.4047782115917;5088.745562721868;5706.629069110515;5995.051608227343;5995.370486098962;6029.397060293979;6044.123602077696;6044.848878778043;6046.54650901182;6064.120702498135;5004.199328107504;5251;5292.867678308035;5330.173823057394;5343.492368225013;5064.215046667772;5138.229265610188;5147.691138531663;5153.098207813618;5166.095933211673;11122.221444498888;11389.715257118556;11389.772204555862;11393.202475826696;11450.255733377388;1887.9811201887942;1911.827935485813;2067.080149333547;2115.862468939514;2194.7914948079906;8556.358273129541;8815.426997245158;9060.275177985812;9307.3019523536;12229.877701222962;1648.785657864482;1714.6594897964314;1714.7342161964916;1732.540876667684;1831.4139475367888;69547;70326.2418439538;71397.2860271401;71399.64300178518;72423.27576724219;9626.374285671409;9784.755381115387;9894.554745036347;9966.900330996597;10048.145907597936;13338.199343088752;13519.188848669111;13526.729465410637;13528.32358382077;13612.251326177155;7234.96382518084;7362;7418.851622967511;7541.773746787605;7550.622468876534;6965.164180298295;7010.92991992513;7166.498345115792;7250.3112204340505;7358.190599034102;4092.5498195198506;4186.937195942063;4200.5799420058365;4341.696081274281;4364.388985542027;1656.5113291579014;1693.3649881294514;1739.365131726936;1835.108897392133;1860.4697661166504;793.8134538383475;826.338928856912;905.2576886952636;914.1452741686544;928.8003079337975;15416.537503874903;15559.688806223812;15916.204189790464;15960.441384551485;16484.505464836075;826.4586396829773;829.6805729793952;833.4874052457695;842.5492361586645;845.9323254139654;8639;9032.27741780656;9176.632934682539;9329;9361.4383137012;362463;365436;366082;368620;373771;75689.62155189189;77183;77996;78337.21662783413;80279;862.4480332587149;880.0275695356667;881.7619242804407;883.2536506651869;885.8715486254457;14307.64230894236;14507.782383264048;14564.41742330295;14578.489752859023;15228.771568426704;36564.268714626094;36768.713095042614;36944.26111477809;37381;37505.81247093747;48554.514454855;49253.50746492489;51867.740661296455;52147.47852521578;54049.18926216188;6317.178766760292;6701.463882889455;6812.625305608239;6820.35206655367;6838.897416538855;9920.454375009444;12054.939725301318;12077.75844483123;12310.26138431697;12502.124851260325;10289;10377.221708371751;10384;10396.324238924446;10438.164946804085;4734.337192792943;8039.914611527369;9490.667826626035;9564.282678798978;9586.137247647745;10321.48392580353;10348.327358721659;10447.320924140211;10748.731281717706;10821.404822734825;6684.598924064571;6776.45788336922;6786.76246331376;6797.966010169917;6836.965815171091;9928.702138935843;10016.232073982668;10056;10337.74155646115;10561.41912194806 18:40:58 INFO - PROCESS | 29159 | |3;mootools.html;1345.7375811716715;1372.8283964504437;1424.985750142499;1628.7801146845172;1650.8101568319646;6720.3615656512675;7446.813829654261;7470.925290747105;8030.1166871644145;8044.9597752011305;7603;7767.650455729492;7941.245581669747;7976.242256985577;7977.401694872893;2123.235635171337;2182.869027858326;2187.7812218778154;2190.87950162741;2201.2075652764993;2137.9203502231353;2175.05385157457;2218.5119273759747;2219.0901730290584;2220.0897631970897;2190.9233176838816;2192.813610843072;2193.6599827026757;2208.3264604295764;2226.198568515333;2151.7955794199524;2159.686845407423;2160.092761040351;2168.934931952044;2169.5877783221135;2114.228306668055;2162.643163877958;2164.047818959653;2167.7723838996994;2175.195177784214;7862.095858976234;7903.051633803922;7916.208379162038;7919.762407127795;7924.167962363927;4405.074934263808;4510.345999830006;4516.1193567254395;4542.750148741818;4552.408186935711;2922.956155657667;2953.896613618513;2985.4178435205145;3042.3306872488015;3046.6191726034244;897.1432282170512;929.7768535551487;939.3659279985982;956.6316967967313;957.6360982826551;10589.629362972337;10736.677899663022;10803.459827008619;10825.13398928084;10875.728106797314;4097.180563887235;4152;4333.9133217335475;4356.520782713899;4368.60682538573;9192.080791920755;9208.033156518602;9211.585478653476;9227.354085214105;9254.305927055499;4626.236670949323;4697.882552936204;4709.058188362273;4723.622110231242;4728.929066064012;3584.1577229351083;4073.327900896319;4197.18154959786;4219.578042195756;4225.514065882463;3659.5425571803526;3709.4435834625024;3770.8868733938025;3783.281176576442;3800.1639639279315;1214.3199808107488;1231.2981600487635;1232.7041510037527;1238.238483332744;1259.2696236182992;784.2941352782541;814.9429539932148;820.7742870710483;827.735124760071;831.6340810043562;5139.922901156486;5266.710330931835;5331.973340133352;5370.91943620846;5450.727463626803;404.32074115485676;406.997965010179;413.2478888423041;414.9232392007488;419.58251539718174;3449.2411669433186;3554.7156227501737;3582.6775590197008;3613.349597072552;3644.872429464956;9417.717468475958;9696.0788725071;9736.805263894683;9764.951175244078;9771;9698.321117521706;9698.951505242429;9701.563429645541;9731.221502279801;9780.510974451248;6892.689828957709;7241.5293005954445;7361.595112268769;7369.963150184322;7377.704891804375;5302.549283310962;5372.301600791872;5401.405845357086;5473.494788932916;5597.020521408818;8972.775680608038;9006.144416280706;9050.140236677506;9149.908500914906;9231.215346695606;8515.574221289035;8706.564671766513;8717.825643486967;9177.990421053812;9210.815783684155;5890.440408161217;6373.74505019794;6526.738930442729;6834.897476537756;6991.650417479207;7341.74303899361;7611.923880761122;7612.429067819825;7613.733519326797;7618.619069046415;6720.697568609522;6758.425533829482;6874.415674667509;6892.414144797548;6955.513114081966;6538.738450461929;6637.668116594247;6644.767433139817;6850.177978642595;6895.551789133891;6066.090086487062;6162.691865406801;6192.071189321638;6196.659183744938;6202.81391558254;4508.391367165522;4509.729416235036;4627.051454451762;4687.10944920464;4690.742009189527;4261.91476170481;4358.76026818528;4375.912481750411;4456.064226512469;4602.930956035595 18:40:58 INFO - PROCESS | 29159 | |4;prototype.html;290.35396243358525;300.29430837531805;301.3806627380732;306.2206683989247;309.33338655198054;4939.901201975963;4961.454240033598;4980.377452818402;4984.953159836429;4993.775280112394;4916.827911023115;4923.876903077425;4932.235503496964;5031.622628302883;5039.092963266619;3704.2035962268174;3793.544774627049;3871.1483473635753;3908.609139086097;3911.3155197840406;3884.4367566702813;3892.2604705106082;3901.8244179012013;3903.160820423608;3908.2769687607883;3859.6333348331864;3872.9225415491674;3873.593272706353;3877.806109694518;3907.8241479133367;3770.2836461072307;3862.517185351831;3864.285107255139;3878.806059697004;3884.242572698325;3422.0247229539464;3427.1664659407347;3427.8286085695618;3437;3444.4488881778793;4744.979829336675;4762.428508578958;4776.5701086902345;4788.592969597588;4828.879278018043;4360.869173924787;4374.540673229297;4375.234333991539;4383.912321753547;4388;4844.32179494871;5112.897742045138;5151.5878729701535;5154.175331946871;5154.639175257734;3622.2393297407575;3622.4023036198996;3627.437747149196;3629.5825980012373;3685.5761587417255;5342.439043900374;5376.623636345457;5376.65583604099;5383.43473935235;5465.344158700942;3616.5479315085613;3668.5597728272246;3699.946529676002;3736.3648179808956;3741.9064523386587;3779.565349984732;3789.5831458539537;3791.2038471920655;3794.2790869735213;3798.2973149967343;4295.613394794484;4317.697761156752;4327.285997810389;4332.848350307724;4405.29515277554;4989.850304490871;5147.588192944556;5190.92213616796;5191;5197.506236907488;1279.181323952671;1294.8964082873347;1302.5636411801963;1304.419533307688;1307.7842156044337;772.7140957845521;807.6890397197121;817.0440584516131;838.0571856661256;839.341117222977;4417.646588272931;4480.297486954936;4620.514845941195;4625.074985003012;4628.282616194495;5359;5361.410244873061;5363.678179309254;5371.838844834661;5378.1932710093015;4613.700109492872;4621.861344159681;4622.260438329851;4625.838095666635;4641.257398816173;2633.4074833162767;2818.9295267618472;2873.5258682317185;2876.8993085241914;2881.150060732089;5072.594192464594;5075.974620126875;5077;5082.593392528589;5090.745462726849;5310.92033619496;5502.284702988586;5544.750486228048;5545.556355491551;5546.362168350611;5025.623078269071;5036.571891389273;5047.192449208109;5057.822976195889;5072.492750724898;5315.4153043166;5349.866253343697;5361.222622719762;5368.275282836923;5427.782888684566;5076.1878099505375;5211.426743058185;5262.158054711228;5268.78817871884;5273.44628813969;5007.222436035301;5016.924746128884;5026.421961474477;5027.3464449621315;5031.113332500312;3420.794752314869;3429.5713035870517;3453.4647129694936;3465.185681364827;3475.409180439281;4500.794610640828;4741.407324084489;4757.191277482905;4763.833265835679;4767.713937163781;4589.58693717567;4593.26507758757;4595.310703394518;4604.470485894165;4625.7455839929125;4643.953560464487;4650.651201159994;4663.717477693662;4682.859514214579;4702.459217190067;4297.818100022394;4557.44782921565;4627.506232794353;4636.6058884995155;4647.65142614312;4651.976740116278;4693.647976401715;4948.455669876383;5135.537801597874;5241.68549887008;5112.795488180431;5113.53978141969;5121.437961421802;5124.154514505214;5125.74371281427 18:40:58 INFO - PROCESS | 29159 | |5;yui.html;611.8439797851547;615.963042217467;643.9130717353156;666.8599594085242;684.727004916499;13019.609411717653;14339.856601433983;14394.928025359884;14414.92792536037;14853.777193342108;14944.178070206135;15057.472988445406;15101.471448499306;15117.848821511781;15130.848691513109;719.6725489902095;740.7703611880335;742.4209116888835;742.9777106686781;743.4127039638679;715.3597530210459;739.2201227704796;745.4744405194325;746.0599644448007;747.9700811967515;781.9335356494677;783.6982761636782;784.3137254901961;785.0657717316403;786.0606575142707;768.2624680306913;774.6359211170741;775.3951917504355;775.5928137727682;776.022212012865;569.9544036477072;570.3782876664415;570.4238718893905;571.0463525911738;571.5113577890885;12702.555410560586;12715.682107947283;12716.364181790874;12723.427445764963;12755.744885102245;12576.874231257661;12830.166039207515;13031.543895963596;13281.867181328256;13285.86714132856;10543.683689489328;10609.522571484302;10795.946020269927;10856.688709943464;11075;3152.8738850445957;3169.524571314298;3184.3153721949893;3244.383567122239;3289.342131573695;65892.67053664749;66052.66973665149;67154;67378.9999999995;67565.32434675688;9730.708078757649;9899.257555683353;9950.1542368898;10066.949665251626;10238;18534.721979170325;18567.16447759854;18735.906320468584;18757.155927983273;18830.71753923692;6579.868402632016;6606.86786264272;6615;6637.900431493532;6653.833654158685;3582.140286331262;3591.824541312932;3670.2737744975493;3690.391085470921;3705.9073523161596;2900.76793856491;2996.640403151636;3006.428778532072;3007.8796848126267;3008.8345141017453;507.77150282373077;508.92111722683046;517.8058228164439;518.390890703422;527.3566249175999;484.2639188433561;518.590313652218;524.9448807875194;532.9653572517774;554.1604469229121;7256.364642040349;7334.193238743734;7546.9622651887485;7622.199669034782;7699.422543309274;424.82157493852657;468.00315328350393;476.7044432451902;530.615303904666;566.4448840136689;3385.6614338565946;3434.10713214566;3454.6199918008997;3482.8258587070545;3549.3256281306467;87800;88281.55859220792;88632;89176.55411723029;101127.49436252919;45949;46274.30588541175;46629;54329;72612.64324140569;44442.77778611086;68732.3126768736;68847;69346.30653693399;70734.64632676804;7775.883361749691;7988.201179882198;8047.356211502949;8075.313598344206;8255.876161857697;41119.7944010278;41414.792926035174;41656.54202102912;41951.37072943847;42526.78736606297;49920.25119623281;54832.45167548433;55177.172342414095;62582.374176257654;64469;10378.377297362182;10454.215933804842;10504.527296271533;10834.295770774874;10921.83617245726;12052.156349055482;12106.757864842477;12169.513219471477;12398.752024959631;12419.689507762378;10272.794544109225;10494;11003.779924401628;11698.824517632413;12138.332391718188;11408.201425900108;11792.76414471723;11972.64082077539;12012.75974480488;12218.45016974256;10963;11327.773444531229;11664.727002599975;11771.587994420153;11801.940990294994;8962.14859588338;9036.683716070169;9258.629654813732;9446.638340414896;9937.602495900082;8881.511516866634;9400.997511179772;9478.715638530855;9537.726486092772;9808.85286720714 18:40:58 INFO - PROCESS | 29159 | __end_tp_report 18:40:58 INFO - PROCESS | 29159 | __start_cc_report 18:40:58 INFO - PROCESS | 29159 | _x_x_mozilla_cycle_collect,358 18:40:58 INFO - PROCESS | 29159 | __end_cc_report 18:40:58 INFO - PROCESS | 29159 | __startTimestamp1472780458513__endTimestamp 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | ------- Summary: start ------- 18:40:58 INFO - PROCESS | 29159 | Number of tests: 6 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#0] dojo.html Cycles:165 Average:4833.91 Median:4945.48 stddev:509.19 (10.3%) stddev-sans-first:481.52 18:40:58 INFO - PROCESS | 29159 | Values: 2666.1 2672.4 2687.6 2690.8 2693.4 4747.7 4782.5 4829.2 4868.8 4950.7 4824.9 4827.1 4835.1 4878.5 4902.1 4410.9 4502.2 4513.8 4623.5 4628.1 4561.2 4570.6 4589.3 4602.2 4614.8 4361.6 4462.2 4466.1 4514.1 4546.7 4452.7 4462.3 4467.1 4538.3 4580.8 4477.6 4489.0 4504.8 4507.5 4571.5 4838.3 4878.7 4890.5 4895.4 4933.2 5200.1 5200.9 5227.2 5227.3 5262.4 5228.7 5247.9 5255.2 5275.5 5301.1 4719.3 4757.7 4786.9 4806.1 4851.2 5253.8 5264.2 5277.8 5283.2 5283.4 5050.8 5060.3 5068.8 5072.3 5125.2 5036.5 5176.1 5217.1 5225.4 5331.6 5210.2 5213.2 5226.6 5231.3 5234.3 5130.9 5200.1 5208.2 5214.8 5261.6 4235.7 4357.6 4406.6 4431.9 4470.8 3847.3 3854.6 3859.7 3907.7 3909.4 4567.6 4598.9 4599.7 4611.9 4673.8 5110.4 5191.0 5229.5 5246.8 5316.7 4533.7 4555.1 4570.4 4572.7 4628.7 4717.5 4721.8 4723.8 4731.0 4783.3 4762.2 4878.7 4916.6 4936.8 5004.5 5257.2 5262.6 5280.1 5292.3 5298.7 4794.8 4940.3 4945.5 4954.1 4994.4 5076.2 5136.5 5144.3 5150.8 5156.6 5230.4 5274.7 5303.5 5353.4 5354.3 5145.6 5151.4 5154.0 5155.3 5158.4 5140.1 5143.7 5145.8 5157.8 5189.0 4840.8 4941.5 4990.2 5010.5 5102.5 5143.6 5146.3 5149.5 5152.7 5153.8 5034.0 5035.0 5038.6 5045.9 5087.0 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#1] ext.html Cycles:180 Average:45428.67 Median:19254.81 stddev:84965.00 (441.3%) stddev-sans-first:85136.49 18:40:58 INFO - PROCESS | 29159 | Values: 532.9 539.4 553.6 556.0 569.7 34374.5 38609.8 38642.8 38744.6 38754.4 38248.0 38602.2 38682.2 38689.0 39089.2 7197.8 7359.4 7372.2 7383.3 7388.5 6381.9 6403.3 6450.5 6451.7 6453.2 6417.4 6433.6 6446.9 6473.2 6485.7 6418.2 6447.3 6468.2 6474.9 6477.7 7459.4 7658.8 7659.0 7670.3 7684.8 36592.3 36831.8 36840.0 36888.6 36892.0 2879.8 2920.7 2973.2 2986.0 3223.9 27373.6 27826.4 28132.9 28419.7 28709.0 3423.5 3432.2 3500.6 3536.4 3539.5 257103.0 257698.0 257919.0 258251.0 258481.0 27180.3 50133.0 50408.5 50413.2 50529.5 32632.5 32644.0 32716.0 32807.7 33002.2 13541.1 13662.7 13698.7 13718.8 13730.5 11047.6 11101.5 11125.1 11128.2 11134.6 7497.3 7627.8 7680.3 7680.9 7700.6 2994.3 3005.5 3049.9 3070.6 3111.6 833.7 852.7 853.1 853.9 916.0 24536.9 27028.3 27234.5 27937.2 28000.6 935.5 957.6 1024.3 1028.9 1045.9 14341.5 14450.8 14452.3 14546.2 14600.7 376755.0 378405.0 378865.0 379862.0 380184.0 46926.0 47475.8 47504.0 47515.0 47652.3 1120.7 1152.7 1166.9 1168.6 1173.5 24123.3 24782.4 26327.6 26380.6 26621.6 40792.6 40992.8 41045.6 41046.0 41052.2 315665.0 317072.0 317126.0 317480.0 319440.0 23994.8 24225.8 24367.1 24963.3 25065.9 40503.0 40589.6 40885.8 40917.4 41380.4 34625.7 35009.0 35273.0 35582.5 35843.0 33436.0 34847.0 34885.8 35416.3 35746.3 33550.3 34116.0 34315.7 34978.8 35103.0 29420.9 31933.5 31950.0 32309.4 32420.7 24296.5 24313.1 24676.8 24912.4 25146.5 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#2] jquery.html Cycles:180 Average:23318.43 Median:5032.50 stddev:60934.45 (1210.8%) stddev-sans-first:61081.01 18:40:58 INFO - PROCESS | 29159 | Values: 364.5 367.5 371.1 375.0 386.7 15278.2 16215.8 16658.9 16670.6 16729.2 15540.7 16294.4 16318.1 16414.1 16434.0 4793.9 5060.8 5061.7 5071.7 5071.9 3607.4 5088.7 5706.6 5995.1 5995.4 6029.4 6044.1 6044.8 6046.5 6064.1 5004.2 5251.0 5292.9 5330.2 5343.5 5064.2 5138.2 5147.7 5153.1 5166.1 11122.2 11389.7 11389.8 11393.2 11450.3 1888.0 1911.8 2067.1 2115.9 2194.8 8556.4 8815.4 9060.3 9307.3 12229.9 1648.8 1714.7 1714.7 1732.5 1831.4 69547.0 70326.2 71397.3 71399.6 72423.3 9626.4 9784.8 9894.6 9966.9 10048.1 13338.2 13519.2 13526.7 13528.3 13612.3 7235.0 7362.0 7418.9 7541.8 7550.6 6965.2 7010.9 7166.5 7250.3 7358.2 4092.5 4186.9 4200.6 4341.7 4364.4 1656.5 1693.4 1739.4 1835.1 1860.5 793.8 826.3 905.3 914.1 928.8 15416.5 15559.7 15916.2 15960.4 16484.5 826.5 829.7 833.5 842.5 845.9 8639.0 9032.3 9176.6 9329.0 9361.4 362463.0 365436.0 366082.0 368620.0 373771.0 75689.6 77183.0 77996.0 78337.2 80279.0 862.4 880.0 881.8 883.3 885.9 14307.6 14507.8 14564.4 14578.5 15228.8 36564.3 36768.7 36944.3 37381.0 37505.8 48554.5 49253.5 51867.7 52147.5 54049.2 6317.2 6701.5 6812.6 6820.4 6838.9 9920.5 12054.9 12077.8 12310.3 12502.1 10289.0 10377.2 10384.0 10396.3 10438.2 4734.3 8039.9 9490.7 9564.3 9586.1 10321.5 10348.3 10447.3 10748.7 10821.4 6684.6 6776.5 6786.8 6798.0 6837.0 9928.7 10016.2 10056.0 10337.7 10561.4 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#3] mootools.html Cycles:180 Average:5140.10 Median:5203.32 stddev:2909.92 (55.9%) stddev-sans-first:2904.11 18:40:58 INFO - PROCESS | 29159 | Values: 1345.7 1372.8 1425.0 1628.8 1650.8 6720.4 7446.8 7470.9 8030.1 8045.0 7603.0 7767.7 7941.2 7976.2 7977.4 2123.2 2182.9 2187.8 2190.9 2201.2 2137.9 2175.1 2218.5 2219.1 2220.1 2190.9 2192.8 2193.7 2208.3 2226.2 2151.8 2159.7 2160.1 2168.9 2169.6 2114.2 2162.6 2164.0 2167.8 2175.2 7862.1 7903.1 7916.2 7919.8 7924.2 4405.1 4510.3 4516.1 4542.8 4552.4 2923.0 2953.9 2985.4 3042.3 3046.6 897.1 929.8 939.4 956.6 957.6 10589.6 10736.7 10803.5 10825.1 10875.7 4097.2 4152.0 4333.9 4356.5 4368.6 9192.1 9208.0 9211.6 9227.4 9254.3 4626.2 4697.9 4709.1 4723.6 4728.9 3584.2 4073.3 4197.2 4219.6 4225.5 3659.5 3709.4 3770.9 3783.3 3800.2 1214.3 1231.3 1232.7 1238.2 1259.3 784.3 814.9 820.8 827.7 831.6 5139.9 5266.7 5332.0 5370.9 5450.7 404.3 407.0 413.2 414.9 419.6 3449.2 3554.7 3582.7 3613.3 3644.9 9417.7 9696.1 9736.8 9765.0 9771.0 9698.3 9699.0 9701.6 9731.2 9780.5 6892.7 7241.5 7361.6 7370.0 7377.7 5302.5 5372.3 5401.4 5473.5 5597.0 8972.8 9006.1 9050.1 9149.9 9231.2 8515.6 8706.6 8717.8 9178.0 9210.8 5890.4 6373.7 6526.7 6834.9 6991.7 7341.7 7611.9 7612.4 7613.7 7618.6 6720.7 6758.4 6874.4 6892.4 6955.5 6538.7 6637.7 6644.8 6850.2 6895.6 6066.1 6162.7 6192.1 6196.7 6202.8 4508.4 4509.7 4627.1 4687.1 4690.7 4261.9 4358.8 4375.9 4456.1 4602.9 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#4] prototype.html Cycles:180 Average:4225.00 Median:4645.80 stddev:1230.06 (26.5%) stddev-sans-first:1197.53 18:40:58 INFO - PROCESS | 29159 | Values: 290.4 300.3 301.4 306.2 309.3 4939.9 4961.5 4980.4 4985.0 4993.8 4916.8 4923.9 4932.2 5031.6 5039.1 3704.2 3793.5 3871.1 3908.6 3911.3 3884.4 3892.3 3901.8 3903.2 3908.3 3859.6 3872.9 3873.6 3877.8 3907.8 3770.3 3862.5 3864.3 3878.8 3884.2 3422.0 3427.2 3427.8 3437.0 3444.4 4745.0 4762.4 4776.6 4788.6 4828.9 4360.9 4374.5 4375.2 4383.9 4388.0 4844.3 5112.9 5151.6 5154.2 5154.6 3622.2 3622.4 3627.4 3629.6 3685.6 5342.4 5376.6 5376.7 5383.4 5465.3 3616.5 3668.6 3699.9 3736.4 3741.9 3779.6 3789.6 3791.2 3794.3 3798.3 4295.6 4317.7 4327.3 4332.8 4405.3 4989.9 5147.6 5190.9 5191.0 5197.5 1279.2 1294.9 1302.6 1304.4 1307.8 772.7 807.7 817.0 838.1 839.3 4417.6 4480.3 4620.5 4625.1 4628.3 5359.0 5361.4 5363.7 5371.8 5378.2 4613.7 4621.9 4622.3 4625.8 4641.3 2633.4 2818.9 2873.5 2876.9 2881.2 5072.6 5076.0 5077.0 5082.6 5090.7 5310.9 5502.3 5544.8 5545.6 5546.4 5025.6 5036.6 5047.2 5057.8 5072.5 5315.4 5349.9 5361.2 5368.3 5427.8 5076.2 5211.4 5262.2 5268.8 5273.4 5007.2 5016.9 5026.4 5027.3 5031.1 3420.8 3429.6 3453.5 3465.2 3475.4 4500.8 4741.4 4757.2 4763.8 4767.7 4589.6 4593.3 4595.3 4604.5 4625.7 4644.0 4650.7 4663.7 4682.9 4702.5 4297.8 4557.4 4627.5 4636.6 4647.7 4652.0 4693.6 4948.5 5135.5 5241.7 5112.8 5113.5 5121.4 5124.2 5125.7 18:40:58 INFO - PROCESS | 29159 | 18:40:58 INFO - PROCESS | 29159 | [#5] yui.html Cycles:180 Average:16285.79 Median:25202.26 stddev:22325.07 (88.6%) stddev-sans-first:22356.68 18:40:58 INFO - PROCESS | 29159 | Values: 611.8 616.0 643.9 666.9 684.7 13019.6 14339.9 14394.9 14414.9 14853.8 14944.2 15057.5 15101.5 15117.8 15130.8 719.7 740.8 742.4 743.0 743.4 715.4 739.2 745.5 746.1 748.0 781.9 783.7 784.3 785.1 786.1 768.3 774.6 775.4 775.6 776.0 570.0 570.4 570.4 571.0 571.5 12702.6 12715.7 12716.4 12723.4 12755.7 12576.9 12830.2 13031.5 13281.9 13285.9 10543.7 10609.5 10795.9 10856.7 11075.0 3152.9 3169.5 3184.3 3244.4 3289.3 65892.7 66052.7 67154.0 67379.0 67565.3 9730.7 9899.3 9950.2 10066.9 10238.0 18534.7 18567.2 18735.9 18757.2 18830.7 6579.9 6606.9 6615.0 6637.9 6653.8 3582.1 3591.8 3670.3 3690.4 3705.9 2900.8 2996.6 3006.4 3007.9 3008.8 507.8 508.9 517.8 518.4 527.4 484.3 518.6 524.9 533.0 554.2 7256.4 7334.2 7547.0 7622.2 7699.4 424.8 468.0 476.7 530.6 566.4 3385.7 3434.1 3454.6 3482.8 3549.3 87800.0 88281.6 88632.0 89176.6 101127.5 45949.0 46274.3 46629.0 54329.0 72612.6 44442.8 68732.3 68847.0 69346.3 70734.6 7775.9 7988.2 8047.4 8075.3 8255.9 41119.8 41414.8 41656.5 41951.4 42526.8 49920.3 54832.5 55177.2 62582.4 64469.0 10378.4 10454.2 10504.5 10834.3 10921.8 12052.2 12106.8 12169.5 12398.8 12419.7 10272.8 10494.0 11003.8 11698.8 12138.3 11408.2 11792.8 11972.6 12012.8 12218.5 10963.0 11327.8 11664.7 11771.6 11801.9 8962.1 9036.7 9258.6 9446.6 9937.6 8881.5 9401.0 9478.7 9537.7 9808.9 18:40:58 INFO - PROCESS | 29159 | -------- Summary: end -------- 18:40:58 INFO - PROCESS | 29159 | 18:40:59 INFO - TEST-INFO | 29159: exit 0 18:40:59 INFO - TEST-OK | dromaeo_css | took 1119103ms 18:40:59 INFO - TEST-START | kraken 18:40:59 INFO - operating with platform_type : linux_ 18:40:59 INFO - Initialising browser for kraken test... 18:40:59 INFO - TEST-INFO | started process 29514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3AxfuC/profile http://localhost:36502/getInfo.html) 18:41:04 INFO - PROCESS | 29514 | __metrics Screen width/height:1600/1200 18:41:04 INFO - PROCESS | 29514 | colorDepth:24 18:41:04 INFO - PROCESS | 29514 | Browser inner width/height: 1024/697 18:41:04 INFO - PROCESS | 29514 | __metrics 18:41:05 ERROR - PROCESS | 29514 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 18:41:05 INFO - TEST-INFO | 29514: exit 0 18:41:05 INFO - Browser initialized. 18:41:05 INFO - Running cycle 1/1 for kraken test... 18:41:05 INFO - TEST-INFO | started process 29631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3AxfuC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:18 INFO - PROCESS | 29631 | RSS: Main: 193183744 18:41:18 INFO - PROCESS | 29631 | 18:41:21 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36502/tests/kraken/driver.html?testName=audio-beat-detection) 18:41:22 INFO - PROCESS | 29631 | RSS: Main: 205230080 18:41:22 INFO - PROCESS | 29631 | 18:41:24 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36502/tests/kraken/driver.html?testName=audio-dft) 18:41:25 INFO - PROCESS | 29631 | RSS: Main: 204484608 18:41:25 INFO - PROCESS | 29631 | 18:41:28 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36502/tests/kraken/driver.html?testName=audio-fft) 18:41:29 INFO - PROCESS | 29631 | RSS: Main: 195309568 18:41:29 INFO - PROCESS | 29631 | 18:41:31 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36502/tests/kraken/driver.html?testName=audio-oscillator) 18:41:31 INFO - PROCESS | 29631 | RSS: Main: 196022272 18:41:31 INFO - PROCESS | 29631 | 18:41:34 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:41:34 INFO - PROCESS | 29631 | RSS: Main: 196202496 18:41:34 INFO - PROCESS | 29631 | 18:41:38 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36502/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:38 INFO - PROCESS | 29631 | RSS: Main: 196505600 18:41:38 INFO - PROCESS | 29631 | 18:41:42 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36502/tests/kraken/driver.html?testName=imaging-desaturate) 18:41:42 INFO - PROCESS | 29631 | RSS: Main: 192716800 18:41:42 INFO - PROCESS | 29631 | 18:41:45 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36502/tests/kraken/driver.html?testName=json-parse-financial) 18:41:46 INFO - PROCESS | 29631 | RSS: Main: 195014656 18:41:46 INFO - PROCESS | 29631 | 18:41:48 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:41:48 INFO - PROCESS | 29631 | RSS: Main: 194998272 18:41:48 INFO - PROCESS | 29631 | 18:41:50 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:41:51 INFO - PROCESS | 29631 | RSS: Main: 195301376 18:41:51 INFO - PROCESS | 29631 | 18:41:53 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:41:54 INFO - PROCESS | 29631 | RSS: Main: 195715072 18:41:54 INFO - PROCESS | 29631 | 18:41:57 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:41:57 INFO - PROCESS | 29631 | RSS: Main: 195899392 18:41:57 INFO - PROCESS | 29631 | 18:42:00 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:01 INFO - PROCESS | 29631 | RSS: Main: 196046848 18:42:01 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | Cycle 1(1): loaded http://localhost:36502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36502/tests/kraken/driver.html?testName=ai-astar) 18:42:03 INFO - PROCESS | 29631 | RSS: Main: 198602752 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | __start_tp_report 18:42:03 INFO - PROCESS | 29631 | _x_x_mozilla_page_load 18:42:03 INFO - PROCESS | 29631 | _x_x_mozilla_page_load_details 18:42:03 INFO - PROCESS | 29631 | |i|pagename|runs| 18:42:03 INFO - PROCESS | 29631 | |0;ai-astar;110;115;114;117;117;116;117;118;114;132 18:42:03 INFO - PROCESS | 29631 | |1;audio-beat-detection;156;130;152;189;126;164;158;131;192;127 18:42:03 INFO - PROCESS | 29631 | |2;audio-dft;179;166;164;163;164;166;166;165;164;164 18:42:03 INFO - PROCESS | 29631 | |3;audio-fft;77;76;78;171;77;77;78;76;168;80 18:42:03 INFO - PROCESS | 29631 | |4;audio-oscillator;84;85;141;86;83;85;133;84;84;142 18:42:03 INFO - PROCESS | 29631 | |5;imaging-gaussian-blur;118;118;117;117;117;119;120;118;117;118 18:42:03 INFO - PROCESS | 29631 | |6;imaging-darkroom;149;147;148;150;151;148;148;148;148;148 18:42:03 INFO - PROCESS | 29631 | |7;imaging-desaturate;96;96;96;95;96;97;97;96;95;95 18:42:03 INFO - PROCESS | 29631 | |8;json-parse-financial;67;69;68;68;70;71;68;67;66;67 18:42:03 INFO - PROCESS | 29631 | |9;json-stringify-tinderbox;66;66;67;67;65;66;65;66;66;66 18:42:03 INFO - PROCESS | 29631 | |10;stanford-crypto-aes;83;85;86;83;84;85;82;83;89;83 18:42:03 INFO - PROCESS | 29631 | |11;stanford-crypto-ccm;139;136;139;147;148;138;144;138;181;142 18:42:03 INFO - PROCESS | 29631 | |12;stanford-crypto-pbkdf2;174;176;175;177;179;190;175;184;184;176 18:42:03 INFO - PROCESS | 29631 | |13;stanford-crypto-sha256-iterative;72;75;72;72;71;69;69;70;71;77 18:42:03 INFO - PROCESS | 29631 | __end_tp_report 18:42:03 INFO - PROCESS | 29631 | __start_cc_report 18:42:03 INFO - PROCESS | 29631 | _x_x_mozilla_cycle_collect,871 18:42:03 INFO - PROCESS | 29631 | __end_cc_report 18:42:03 INFO - PROCESS | 29631 | __startTimestamp1472780523699__endTimestamp 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | ------- Summary: start ------- 18:42:03 INFO - PROCESS | 29631 | Number of tests: 14 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#0] ai-astar Cycles:10 Average:117.00 Median:117.00 stddev:5.75 (4.9%) stddev-sans-first:5.52 18:42:03 INFO - PROCESS | 29631 | Values: 110.0 115.0 114.0 117.0 117.0 116.0 117.0 118.0 114.0 132.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:157.00 stddev:24.47 (15.6%) stddev-sans-first:25.92 18:42:03 INFO - PROCESS | 29631 | Values: 156.0 130.0 152.0 189.0 126.0 164.0 158.0 131.0 192.0 127.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:4.65 (2.8%) stddev-sans-first:1.12 18:42:03 INFO - PROCESS | 29631 | Values: 179.0 166.0 164.0 163.0 164.0 166.0 166.0 165.0 164.0 164.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:38.87 (50.5%) stddev-sans-first:40.62 18:42:03 INFO - PROCESS | 29631 | Values: 77.0 76.0 78.0 171.0 77.0 77.0 78.0 76.0 168.0 80.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:84.00 stddev:26.31 (31.3%) stddev-sans-first:27.21 18:42:03 INFO - PROCESS | 29631 | Values: 84.0 85.0 141.0 86.0 83.0 85.0 133.0 84.0 84.0 142.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 18:42:03 INFO - PROCESS | 29631 | Values: 118.0 118.0 117.0 117.0 117.0 119.0 120.0 118.0 117.0 118.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 18:42:03 INFO - PROCESS | 29631 | Values: 149.0 147.0 148.0 150.0 151.0 148.0 148.0 148.0 148.0 148.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 18:42:03 INFO - PROCESS | 29631 | Values: 96.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 95.0 95.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.00 stddev:1.52 (2.2%) stddev-sans-first:1.56 18:42:03 INFO - PROCESS | 29631 | Values: 67.0 69.0 68.0 68.0 70.0 71.0 68.0 67.0 66.0 67.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 18:42:03 INFO - PROCESS | 29631 | Values: 66.0 66.0 67.0 67.0 65.0 66.0 65.0 66.0 66.0 66.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:2.06 (2.4%) stddev-sans-first:2.13 18:42:03 INFO - PROCESS | 29631 | Values: 83.0 85.0 86.0 83.0 84.0 85.0 82.0 83.0 89.0 83.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:143.00 stddev:13.21 (9.2%) stddev-sans-first:13.82 18:42:03 INFO - PROCESS | 29631 | Values: 139.0 136.0 139.0 147.0 148.0 138.0 144.0 138.0 181.0 142.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:178.00 stddev:5.27 (3.0%) stddev-sans-first:5.27 18:42:03 INFO - PROCESS | 29631 | Values: 174.0 176.0 175.0 177.0 179.0 190.0 175.0 184.0 184.0 176.0 18:42:03 INFO - PROCESS | 29631 | 18:42:03 INFO - PROCESS | 29631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:2.53 (3.5%) stddev-sans-first:2.68 18:42:03 INFO - PROCESS | 29631 | Values: 72.0 75.0 72.0 72.0 71.0 69.0 69.0 70.0 71.0 77.0 18:42:03 INFO - PROCESS | 29631 | -------- Summary: end -------- 18:42:03 INFO - PROCESS | 29631 | 18:42:04 INFO - TEST-INFO | 29631: exit 0 18:42:04 INFO - TEST-OK | kraken | took 65482ms 18:42:04 INFO - SUITE-END | took 1184s 18:42:05 INFO - Completed test suite (00:19:44) 18:42:05 INFO - javascript benchmark 18:42:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6231.789149608299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2666.0535509893975, 2672.4120693447444, 2687.556553168727, 2690.7712844408225, 2693.434378780456, 4747.691400058994, 4782.545658162473, 4829.203181475061, 4868.756562171895, 4950.653454258194, 4824.879378015551, 4827.058723548909, 4835.057163853041, 4878.536539028795, 4902.09311277414, 4410.911781764363, 4502.212112880249, 4513.7517436540975, 4623.468301145378, 4628.074385122972, 4561.156186105564, 4570.588647021767, 4589.265717485203, 4602.194615942197, 4614.792334344946, 4361.6074553290355, 4462.1968045751755, 4466.12910482456, 4514.052049069666, 4546.749928753918, 4452.710573812692, 4462.308342206963, 4467.106578684276, 4538.251188553884, 4580.770961451914, 4477.552244775529, 4489.034857505652, 4504.842330518449, 4507.459104907432, 4571.451425828922, 4838.322634831126, 4878.658493905428, 4890.535399137077, 4895.363602731622, 4933.161362568372, 5200.063988482072, 5200.92198617021, 5227.18978558324, 5227.320448341729, 5262.421133675292, 5228.686278823283, 5247.86880327991, 5255.159174532095, 5275.525202731773, 5301.098813201765, 4719.268513380432, 4757.738324392191, 4786.928196077061, 4806.062817750505, 4851.223804191312, 5253.842384728464, 5264.184051472028, 5277.788888444496, 5283.1546952487415, 5283.392409872837, 5050.84847454577, 5060.342155519833, 5068.797248110108, 5072.315237442898, 5125.15434953236, 5036.496350364934, 5176.06830770465, 5217.139172036572, 5225.399079105876, 5331.600129990266, 5210.244514545369, 5213.244079608511, 5226.555742761908, 5231.267622532849, 5234.345706786652, 5130.9230361544605, 5200.141976573898, 5208.244804503326, 5214.765335559909, 5261.605379596545, 4235.682323825664, 4357.629601483909, 4406.5593440655675, 4431.8670439886855, 4470.798814053375, 3847.3074846527893, 3854.6338097880657, 3859.729818912649, 3907.7264591478324, 3909.3745000800304, 4567.588916997486, 4598.885027874263, 4599.655025873073, 4611.930821037688, 4673.813047478063, 5110.412302585176, 5191.039657663345, 5229.529342359206, 5246.842594722164, 5316.680999140064, 4533.705309154894, 4555.088982203572, 4570.360149579062, 4572.702774319659, 4628.652851036186, 4717.481077081518, 4721.811127554928, 4723.811047558128, 4731.0, 4783.330333753277, 4762.238041913277, 4878.731669758197, 4916.606671466346, 4936.82721104774, 5004.499550044967, 5257.237700533325, 5262.631615786858, 5280.075986702389, 5292.338457692788, 5298.682079075268, 4794.760261986817, 4940.283658869515, 4945.4807245238735, 4954.058728841508, 4994.400671919393, 5076.18780995039, 5136.5377116059735, 5144.279800827812, 5150.819721309736, 5156.61325400589, 5230.424653288059, 5274.683518988873, 5303.522682958553, 5353.411124776349, 5354.303940487712, 5145.61407894402, 5151.381834179772, 5154.0, 5155.252488389087, 5158.3552055993005, 5140.126178549581, 5143.665661731976, 5145.845624631267, 5157.793688252428, 5189.040027594907, 4840.782164802663, 4941.50584941503, 4990.226514890198, 5010.49895010496, 5102.515261050195, 5143.61422893292, 5146.279520867157, 5149.459306772735, 5152.742362881916, 5153.845384638467, 5034.043531728959, 5035.043341765053, 5038.647294689336, 5045.899082018413, 5087.033463641897], "value": 4800.781237172079, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.8587924200085, 539.3527766679983, 553.5571542765787, 555.9944400555993, 569.6752850875002, 34374.48438273425, 38609.80695096524, 38642.806785966066, 38744.61255387445, 38754.41868371977, 38248.0, 38602.227955440874, 38682.22635547287, 38689.0, 39089.21821563567, 7197.82005449864, 7359.3744531714865, 7372.18905920351, 7383.261673832628, 7388.482806203568, 6381.904271435932, 6403.263624683151, 6450.516211284149, 6451.741930322782, 6453.225612926455, 6417.39034791694, 6433.6461494618015, 6446.935530644704, 6473.223213214421, 6485.67571621417, 6418.229812422539, 6447.323031081739, 6468.15913931186, 6474.870502589945, 6477.74089036438, 7459.44054195932, 7658.808529786744, 7658.961705191438, 7670.348020418215, 7684.807879802994, 36592.26815463676, 36831.81584092062, 36840.0, 36888.63111368879, 36892.0, 2879.7984141110132, 2920.7225313595172, 2973.2418233350572, 2985.9552106718415, 3223.8549265282886, 27373.589396159074, 27826.443471130668, 28132.85933570319, 28419.715802841914, 28709.0, 3423.5207071010077, 3432.2105915639295, 3500.611384223802, 3536.3634545781747, 3539.522164507784, 257103.0, 257698.0, 257919.0, 258251.0, 258481.0, 27180.320491987462, 50133.0, 50408.49591504038, 50413.24380134301, 50529.494705053214, 32632.510512341858, 32644.0, 32716.0, 32807.67192328046, 33002.17494562655, 13541.1198272112, 13662.658433539042, 13698.726025479635, 13718.794218086736, 13730.51943181984, 11047.558097676003, 11101.500432480396, 11125.054370378446, 11128.165387595962, 11134.610288639858, 7497.2877576630135, 7627.809304767426, 7680.34717049046, 7680.9231907680205, 7700.576468294185, 2994.2633272701783, 3005.4590173768493, 3049.9172793658377, 3070.6008218931397, 3111.6266048074376, 833.6707000734797, 852.6887685994567, 853.1298075962608, 853.9146085391411, 916.0107084348887, 24536.877315613663, 27028.324291892466, 27234.45531089367, 27937.16188514348, 28000.579991300147, 935.475175464003, 957.5978089202413, 1024.262530977695, 1028.9176865850714, 1045.9163266938626, 14341.498047568284, 14450.757764222275, 14452.277386130652, 14546.199959002144, 14600.707985840223, 376755.0, 378405.0, 378865.0, 379862.0, 380184.0, 46926.0, 47475.762621187365, 47504.0, 47515.0, 47652.28521572179, 1120.7478317378689, 1152.7262574289227, 1166.9299842009507, 1168.6201984355118, 1173.5481839491856, 24123.28951232754, 24782.38044048913, 26327.605085923344, 26380.60429093527, 26621.600675990263, 40792.59207407888, 40992.79503602463, 41045.58954410418, 41046.0, 41052.17895642011, 315665.0, 317072.0, 317126.0, 317480.0, 319440.0, 23994.76005239925, 24225.757742423055, 24367.14714984967, 24963.251102466955, 25065.87467062653, 40503.0, 40589.59410405976, 40885.79557102315, 40917.38623920584, 41380.37929431121, 34625.653743462244, 35009.0, 35273.0, 35582.46626300556, 35843.0, 33436.0, 34847.0, 34885.82557087198, 35416.29167416689, 35746.28507429785, 33550.32899342048, 34116.0, 34315.65684343225, 34978.825105874304, 35103.0, 29420.852895735385, 31933.520997185526, 31950.0, 32309.35381292408, 32420.675793241764, 24296.51406971886, 24313.149039783522, 24676.753232467447, 24912.37719057038, 25146.49707005813], "value": 15786.578306476427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.475155775683, 367.45433031947556, 371.1093375897845, 374.9793761343129, 386.72928949735194, 15278.15970121643, 16215.756763648555, 16658.916705416486, 16670.58323541912, 16729.16354182292, 15540.689186216297, 16294.429694960649, 16318.102504362256, 16414.09722465264, 16434.013959162457, 4793.897403597183, 5060.797568097271, 5061.6962982221185, 5071.695698258098, 5071.923921141186, 3607.4047782115917, 5088.745562721868, 5706.629069110515, 5995.051608227343, 5995.370486098962, 6029.397060293979, 6044.123602077696, 6044.848878778043, 6046.54650901182, 6064.120702498135, 5004.199328107504, 5251.0, 5292.867678308035, 5330.173823057394, 5343.492368225013, 5064.215046667772, 5138.229265610188, 5147.691138531663, 5153.098207813618, 5166.095933211673, 11122.221444498888, 11389.715257118556, 11389.772204555862, 11393.202475826696, 11450.255733377388, 1887.9811201887942, 1911.827935485813, 2067.080149333547, 2115.862468939514, 2194.7914948079906, 8556.358273129541, 8815.426997245158, 9060.275177985812, 9307.3019523536, 12229.877701222962, 1648.785657864482, 1714.6594897964314, 1714.7342161964916, 1732.540876667684, 1831.4139475367888, 69547.0, 70326.2418439538, 71397.2860271401, 71399.64300178518, 72423.27576724219, 9626.374285671409, 9784.755381115387, 9894.554745036347, 9966.900330996597, 10048.145907597936, 13338.199343088752, 13519.188848669111, 13526.729465410637, 13528.32358382077, 13612.251326177155, 7234.96382518084, 7362.0, 7418.851622967511, 7541.773746787605, 7550.622468876534, 6965.164180298295, 7010.92991992513, 7166.498345115792, 7250.3112204340505, 7358.190599034102, 4092.5498195198506, 4186.937195942063, 4200.5799420058365, 4341.696081274281, 4364.388985542027, 1656.5113291579014, 1693.3649881294514, 1739.365131726936, 1835.108897392133, 1860.4697661166504, 793.8134538383475, 826.338928856912, 905.2576886952636, 914.1452741686544, 928.8003079337975, 15416.537503874903, 15559.688806223812, 15916.204189790464, 15960.441384551485, 16484.505464836075, 826.4586396829773, 829.6805729793952, 833.4874052457695, 842.5492361586645, 845.9323254139654, 8639.0, 9032.27741780656, 9176.632934682539, 9329.0, 9361.4383137012, 362463.0, 365436.0, 366082.0, 368620.0, 373771.0, 75689.62155189189, 77183.0, 77996.0, 78337.21662783413, 80279.0, 862.4480332587149, 880.0275695356667, 881.7619242804407, 883.2536506651869, 885.8715486254457, 14307.64230894236, 14507.782383264048, 14564.41742330295, 14578.489752859023, 15228.771568426704, 36564.268714626094, 36768.713095042614, 36944.26111477809, 37381.0, 37505.81247093747, 48554.514454855, 49253.50746492489, 51867.740661296455, 52147.47852521578, 54049.18926216188, 6317.178766760292, 6701.463882889455, 6812.625305608239, 6820.35206655367, 6838.897416538855, 9920.454375009444, 12054.939725301318, 12077.75844483123, 12310.26138431697, 12502.124851260325, 10289.0, 10377.221708371751, 10384.0, 10396.324238924446, 10438.164946804085, 4734.337192792943, 8039.914611527369, 9490.667826626035, 9564.282678798978, 9586.137247647745, 10321.48392580353, 10348.327358721659, 10447.320924140211, 10748.731281717706, 10821.404822734825, 6684.598924064571, 6776.45788336922, 6786.76246331376, 6797.966010169917, 6836.965815171091, 9928.702138935843, 10016.232073982668, 10056.0, 10337.74155646115, 10561.41912194806], "value": 7915.729963187357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.7375811716715, 1372.8283964504437, 1424.985750142499, 1628.7801146845172, 1650.8101568319646, 6720.3615656512675, 7446.813829654261, 7470.925290747105, 8030.1166871644145, 8044.9597752011305, 7603.0, 7767.650455729492, 7941.245581669747, 7976.242256985577, 7977.401694872893, 2123.235635171337, 2182.869027858326, 2187.7812218778154, 2190.87950162741, 2201.2075652764993, 2137.9203502231353, 2175.05385157457, 2218.5119273759747, 2219.0901730290584, 2220.0897631970897, 2190.9233176838816, 2192.813610843072, 2193.6599827026757, 2208.3264604295764, 2226.198568515333, 2151.7955794199524, 2159.686845407423, 2160.092761040351, 2168.934931952044, 2169.5877783221135, 2114.228306668055, 2162.643163877958, 2164.047818959653, 2167.7723838996994, 2175.195177784214, 7862.095858976234, 7903.051633803922, 7916.208379162038, 7919.762407127795, 7924.167962363927, 4405.074934263808, 4510.345999830006, 4516.1193567254395, 4542.750148741818, 4552.408186935711, 2922.956155657667, 2953.896613618513, 2985.4178435205145, 3042.3306872488015, 3046.6191726034244, 897.1432282170512, 929.7768535551487, 939.3659279985982, 956.6316967967313, 957.6360982826551, 10589.629362972337, 10736.677899663022, 10803.459827008619, 10825.13398928084, 10875.728106797314, 4097.180563887235, 4152.0, 4333.9133217335475, 4356.520782713899, 4368.60682538573, 9192.080791920755, 9208.033156518602, 9211.585478653476, 9227.354085214105, 9254.305927055499, 4626.236670949323, 4697.882552936204, 4709.058188362273, 4723.622110231242, 4728.929066064012, 3584.1577229351083, 4073.327900896319, 4197.18154959786, 4219.578042195756, 4225.514065882463, 3659.5425571803526, 3709.4435834625024, 3770.8868733938025, 3783.281176576442, 3800.1639639279315, 1214.3199808107488, 1231.2981600487635, 1232.7041510037527, 1238.238483332744, 1259.2696236182992, 784.2941352782541, 814.9429539932148, 820.7742870710483, 827.735124760071, 831.6340810043562, 5139.922901156486, 5266.710330931835, 5331.973340133352, 5370.91943620846, 5450.727463626803, 404.32074115485676, 406.997965010179, 413.2478888423041, 414.9232392007488, 419.58251539718174, 3449.2411669433186, 3554.7156227501737, 3582.6775590197008, 3613.349597072552, 3644.872429464956, 9417.717468475958, 9696.0788725071, 9736.805263894683, 9764.951175244078, 9771.0, 9698.321117521706, 9698.951505242429, 9701.563429645541, 9731.221502279801, 9780.510974451248, 6892.689828957709, 7241.5293005954445, 7361.595112268769, 7369.963150184322, 7377.704891804375, 5302.549283310962, 5372.301600791872, 5401.405845357086, 5473.494788932916, 5597.020521408818, 8972.775680608038, 9006.144416280706, 9050.140236677506, 9149.908500914906, 9231.215346695606, 8515.574221289035, 8706.564671766513, 8717.825643486967, 9177.990421053812, 9210.815783684155, 5890.440408161217, 6373.74505019794, 6526.738930442729, 6834.897476537756, 6991.650417479207, 7341.74303899361, 7611.923880761122, 7612.429067819825, 7613.733519326797, 7618.619069046415, 6720.697568609522, 6758.425533829482, 6874.415674667509, 6892.414144797548, 6955.513114081966, 6538.738450461929, 6637.668116594247, 6644.767433139817, 6850.177978642595, 6895.551789133891, 6066.090086487062, 6162.691865406801, 6192.071189321638, 6196.659183744938, 6202.81391558254, 4508.391367165522, 4509.729416235036, 4627.051454451762, 4687.10944920464, 4690.742009189527, 4261.91476170481, 4358.76026818528, 4375.912481750411, 4456.064226512469, 4602.930956035595], "value": 4068.1610952517744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.35396243358525, 300.29430837531805, 301.3806627380732, 306.2206683989247, 309.33338655198054, 4939.901201975963, 4961.454240033598, 4980.377452818402, 4984.953159836429, 4993.775280112394, 4916.827911023115, 4923.876903077425, 4932.235503496964, 5031.622628302883, 5039.092963266619, 3704.2035962268174, 3793.544774627049, 3871.1483473635753, 3908.609139086097, 3911.3155197840406, 3884.4367566702813, 3892.2604705106082, 3901.8244179012013, 3903.160820423608, 3908.2769687607883, 3859.6333348331864, 3872.9225415491674, 3873.593272706353, 3877.806109694518, 3907.8241479133367, 3770.2836461072307, 3862.517185351831, 3864.285107255139, 3878.806059697004, 3884.242572698325, 3422.0247229539464, 3427.1664659407347, 3427.8286085695618, 3437.0, 3444.4488881778793, 4744.979829336675, 4762.428508578958, 4776.5701086902345, 4788.592969597588, 4828.879278018043, 4360.869173924787, 4374.540673229297, 4375.234333991539, 4383.912321753547, 4388.0, 4844.32179494871, 5112.897742045138, 5151.5878729701535, 5154.175331946871, 5154.639175257734, 3622.2393297407575, 3622.4023036198996, 3627.437747149196, 3629.5825980012373, 3685.5761587417255, 5342.439043900374, 5376.623636345457, 5376.65583604099, 5383.43473935235, 5465.344158700942, 3616.5479315085613, 3668.5597728272246, 3699.946529676002, 3736.3648179808956, 3741.9064523386587, 3779.565349984732, 3789.5831458539537, 3791.2038471920655, 3794.2790869735213, 3798.2973149967343, 4295.613394794484, 4317.697761156752, 4327.285997810389, 4332.848350307724, 4405.29515277554, 4989.850304490871, 5147.588192944556, 5190.92213616796, 5191.0, 5197.506236907488, 1279.181323952671, 1294.8964082873347, 1302.5636411801963, 1304.419533307688, 1307.7842156044337, 772.7140957845521, 807.6890397197121, 817.0440584516131, 838.0571856661256, 839.341117222977, 4417.646588272931, 4480.297486954936, 4620.514845941195, 4625.074985003012, 4628.282616194495, 5359.0, 5361.410244873061, 5363.678179309254, 5371.838844834661, 5378.1932710093015, 4613.700109492872, 4621.861344159681, 4622.260438329851, 4625.838095666635, 4641.257398816173, 2633.4074833162767, 2818.9295267618472, 2873.5258682317185, 2876.8993085241914, 2881.150060732089, 5072.594192464594, 5075.974620126875, 5077.0, 5082.593392528589, 5090.745462726849, 5310.92033619496, 5502.284702988586, 5544.750486228048, 5545.556355491551, 5546.362168350611, 5025.623078269071, 5036.571891389273, 5047.192449208109, 5057.822976195889, 5072.492750724898, 5315.4153043166, 5349.866253343697, 5361.222622719762, 5368.275282836923, 5427.782888684566, 5076.1878099505375, 5211.426743058185, 5262.158054711228, 5268.78817871884, 5273.44628813969, 5007.222436035301, 5016.924746128884, 5026.421961474477, 5027.3464449621315, 5031.113332500312, 3420.794752314869, 3429.5713035870517, 3453.4647129694936, 3465.185681364827, 3475.409180439281, 4500.794610640828, 4741.407324084489, 4757.191277482905, 4763.833265835679, 4767.713937163781, 4589.58693717567, 4593.26507758757, 4595.310703394518, 4604.470485894165, 4625.7455839929125, 4643.953560464487, 4650.651201159994, 4663.717477693662, 4682.859514214579, 4702.459217190067, 4297.818100022394, 4557.44782921565, 4627.506232794353, 4636.6058884995155, 4647.65142614312, 4651.976740116278, 4693.647976401715, 4948.455669876383, 5135.537801597874, 5241.68549887008, 5112.795488180431, 5113.53978141969, 5121.437961421802, 5124.154514505214, 5125.74371281427], "value": 3830.889210207008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.8439797851547, 615.963042217467, 643.9130717353156, 666.8599594085242, 684.727004916499, 13019.609411717653, 14339.856601433983, 14394.928025359884, 14414.92792536037, 14853.777193342108, 14944.178070206135, 15057.472988445406, 15101.471448499306, 15117.848821511781, 15130.848691513109, 719.6725489902095, 740.7703611880335, 742.4209116888835, 742.9777106686781, 743.4127039638679, 715.3597530210459, 739.2201227704796, 745.4744405194325, 746.0599644448007, 747.9700811967515, 781.9335356494677, 783.6982761636782, 784.3137254901961, 785.0657717316403, 786.0606575142707, 768.2624680306913, 774.6359211170741, 775.3951917504355, 775.5928137727682, 776.022212012865, 569.9544036477072, 570.3782876664415, 570.4238718893905, 571.0463525911738, 571.5113577890885, 12702.555410560586, 12715.682107947283, 12716.364181790874, 12723.427445764963, 12755.744885102245, 12576.874231257661, 12830.166039207515, 13031.543895963596, 13281.867181328256, 13285.86714132856, 10543.683689489328, 10609.522571484302, 10795.946020269927, 10856.688709943464, 11075.0, 3152.8738850445957, 3169.524571314298, 3184.3153721949893, 3244.383567122239, 3289.342131573695, 65892.67053664749, 66052.66973665149, 67154.0, 67378.9999999995, 67565.32434675688, 9730.708078757649, 9899.257555683353, 9950.1542368898, 10066.949665251626, 10238.0, 18534.721979170325, 18567.16447759854, 18735.906320468584, 18757.155927983273, 18830.71753923692, 6579.868402632016, 6606.86786264272, 6615.0, 6637.900431493532, 6653.833654158685, 3582.140286331262, 3591.824541312932, 3670.2737744975493, 3690.391085470921, 3705.9073523161596, 2900.76793856491, 2996.640403151636, 3006.428778532072, 3007.8796848126267, 3008.8345141017453, 507.77150282373077, 508.92111722683046, 517.8058228164439, 518.390890703422, 527.3566249175999, 484.2639188433561, 518.590313652218, 524.9448807875194, 532.9653572517774, 554.1604469229121, 7256.364642040349, 7334.193238743734, 7546.9622651887485, 7622.199669034782, 7699.422543309274, 424.82157493852657, 468.00315328350393, 476.7044432451902, 530.615303904666, 566.4448840136689, 3385.6614338565946, 3434.10713214566, 3454.6199918008997, 3482.8258587070545, 3549.3256281306467, 87800.0, 88281.55859220792, 88632.0, 89176.55411723029, 101127.49436252919, 45949.0, 46274.30588541175, 46629.0, 54329.0, 72612.64324140569, 44442.77778611086, 68732.3126768736, 68847.0, 69346.30653693399, 70734.64632676804, 7775.883361749691, 7988.201179882198, 8047.356211502949, 8075.313598344206, 8255.876161857697, 41119.7944010278, 41414.792926035174, 41656.54202102912, 41951.37072943847, 42526.78736606297, 49920.25119623281, 54832.45167548433, 55177.172342414095, 62582.374176257654, 64469.0, 10378.377297362182, 10454.215933804842, 10504.527296271533, 10834.295770774874, 10921.83617245726, 12052.156349055482, 12106.757864842477, 12169.513219471477, 12398.752024959631, 12419.689507762378, 10272.794544109225, 10494.0, 11003.779924401628, 11698.824517632413, 12138.332391718188, 11408.201425900108, 11792.76414471723, 11972.64082077539, 12012.75974480488, 12218.45016974256, 10963.0, 11327.773444531229, 11664.727002599975, 11771.587994420153, 11801.940990294994, 8962.14859588338, 9036.683716070169, 9258.629654813732, 9446.638340414896, 9937.602495900082, 8881.511516866634, 9400.997511179772, 9478.715638530855, 9537.726486092772, 9808.85286720714], "value": 6263.884441225154, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 114.0, 117.0, 117.0, 116.0, 117.0, 118.0, 114.0, 132.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 152.0, 189.0, 126.0, 164.0, 158.0, 131.0, 192.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 166.0, 164.0, 163.0, 164.0, 166.0, 166.0, 165.0, 164.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 171.0, 77.0, 77.0, 78.0, 76.0, 168.0, 80.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 141.0, 86.0, 83.0, 85.0, 133.0, 84.0, 84.0, 142.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 120.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 150.0, 151.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 70.0, 71.0, 68.0, 67.0, 66.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 83.0, 84.0, 85.0, 82.0, 83.0, 89.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 139.0, 147.0, 148.0, 138.0, 144.0, 138.0, 181.0, 142.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 175.0, 177.0, 179.0, 190.0, 175.0, 184.0, 184.0, 176.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 72.0, 72.0, 71.0, 69.0, 69.0, 70.0, 71.0, 77.0], "value": 71.8, "unit": "score"}]}]} 18:42:05 INFO - Return code: 0 18:42:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:42:05 ERROR - # TBPL SUCCESS # 18:42:05 INFO - Running post-action listener: _resource_record_post_action 18:42:05 INFO - [mozharness: 2016-09-02 01:42:05.482607Z] Finished run-tests step (success) 18:42:05 INFO - Running post-run listener: _resource_record_post_run 18:42:05 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 422969344; Read time: 112; Write time: 303036 18:42:05 INFO - TinderboxPrint: CPU usage
13.4% 18:42:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 18:42:05 INFO - TinderboxPrint: I/O write bytes / time
422,969,344 / 303,036 18:42:05 INFO - TinderboxPrint: CPU idle
8,296.3 (86.5%) 18:42:05 INFO - TinderboxPrint: CPU user
1,225.7 (12.8%) 18:42:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:42:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 130424832; Read time: 0; Write time: 104236 18:42:05 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292261888; Read time: 112; Write time: 198776 18:42:06 INFO - Running post-run listener: _upload_blobber_files 18:42:06 INFO - Blob upload gear active. 18:42:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:06 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 18:42:06 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:42:06 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:42:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:42:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:10 INFO - (blobuploader) - INFO - Done attempting. 18:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:11 INFO - (blobuploader) - INFO - Done attempting. 18:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:12 INFO - (blobuploader) - INFO - Done attempting. 18:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:12 INFO - Return code: 0 18:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dbc8fa966c370e7ea66b1af798b8307ed75de6adab549112a564a619535c7d5f976379da8b0d5305c9c60c66b07bdff0a6e32b7b4dce27ba49fd55e742dc096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4cac752ef7cad779dee496a9755253fd6403db92d9e677219903030614af18c870fc6690d8ff05aeaa60741406075ad4383df9b264840543ae79dcf9965963b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132087c78ea583a12cee03bcf42ebb19d52759383868d9cd7d08008acaba248b9da3bb2b02c0db3092bfdc4618101b198098aea42022a706710b7bc855c11a73"} 18:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:12 INFO - Contents: 18:42:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dbc8fa966c370e7ea66b1af798b8307ed75de6adab549112a564a619535c7d5f976379da8b0d5305c9c60c66b07bdff0a6e32b7b4dce27ba49fd55e742dc096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4cac752ef7cad779dee496a9755253fd6403db92d9e677219903030614af18c870fc6690d8ff05aeaa60741406075ad4383df9b264840543ae79dcf9965963b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132087c78ea583a12cee03bcf42ebb19d52759383868d9cd7d08008acaba248b9da3bb2b02c0db3092bfdc4618101b198098aea42022a706710b7bc855c11a73"} 18:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:12 INFO - Copying logs to upload dir... 18:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.759916 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-01 18:42:12.495621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:12.499485) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 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-Non-PGO/sha512/1dbc8fa966c370e7ea66b1af798b8307ed75de6adab549112a564a619535c7d5f976379da8b0d5305c9c60c66b07bdff0a6e32b7b4dce27ba49fd55e742dc096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4cac752ef7cad779dee496a9755253fd6403db92d9e677219903030614af18c870fc6690d8ff05aeaa60741406075ad4383df9b264840543ae79dcf9965963b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132087c78ea583a12cee03bcf42ebb19d52759383868d9cd7d08008acaba248b9da3bb2b02c0db3092bfdc4618101b198098aea42022a706710b7bc855c11a73"} build_url:https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/bsVgSYJRQNq2IAukgZ7Clw/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-Non-PGO/sha512/1dbc8fa966c370e7ea66b1af798b8307ed75de6adab549112a564a619535c7d5f976379da8b0d5305c9c60c66b07bdff0a6e32b7b4dce27ba49fd55e742dc096", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4cac752ef7cad779dee496a9755253fd6403db92d9e677219903030614af18c870fc6690d8ff05aeaa60741406075ad4383df9b264840543ae79dcf9965963b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/132087c78ea583a12cee03bcf42ebb19d52759383868d9cd7d08008acaba248b9da3bb2b02c0db3092bfdc4618101b198098aea42022a706710b7bc855c11a73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:12.525228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:12.525533) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1472776821.475991-1583294772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 18:42:12.608899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 18:42:12.609228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 18:42:12.609509) ========= ========= Total master_lag: 0.23 =========