builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1469826473.5 results: success (0) buildid: 20160729113625 builduid: d351db4f208545bab069d0160edf999a revision: aa1f8366541eafaa16fbea50bbf2fc35af36ff61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.497434) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.497979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.498368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.525769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.526058) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 14:07:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-07-29 14:07:53 (45.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.708755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.709110) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.172448 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.893556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:53.893926) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aa1f8366541eafaa16fbea50bbf2fc35af36ff61 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aa1f8366541eafaa16fbea50bbf2fc35af36ff61 --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=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 14:07:54,015 truncating revision to first 12 chars 2016-07-29 14:07:54,015 Setting DEBUG logging. 2016-07-29 14:07:54,015 attempt 1/10 2016-07-29 14:07:54,015 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/aa1f8366541e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 14:07:54,590 unpacking tar archive at: mozilla-aurora-aa1f8366541e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:54.801467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:54.801820) ========= script_repo_revision: aa1f8366541eafaa16fbea50bbf2fc35af36ff61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:54.802219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:54.802556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 14:07:54.810291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-29 14:07:54.810626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:55 INFO - MultiFileLogger online at 20160729 14:07:55 in /builds/slave/test 14:07:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:07:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:55 INFO - {'append_to_log': False, 14:07:55 INFO - 'base_work_dir': '/builds/slave/test', 14:07:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:07:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:55 INFO - 'branch': 'Mozilla-Aurora', 14:07:55 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:55 INFO - 'config_files': ('talos/linux_config.py',), 14:07:55 INFO - 'default_actions': ('clobber', 14:07:55 INFO - 'read-buildbot-config', 14:07:55 INFO - 'download-and-extract', 14:07:55 INFO - 'populate-webroot', 14:07:55 INFO - 'create-virtualenv', 14:07:55 INFO - 'install', 14:07:55 INFO - 'run-tests'), 14:07:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:55 INFO - 'download_minidump_stackwalk': True, 14:07:55 INFO - 'download_symbols': 'ondemand', 14:07:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:55 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:55 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:55 INFO - 'installer_path': 'installer.exe', 14:07:55 INFO - 'log_level': 'info', 14:07:55 INFO - 'log_name': 'talos', 14:07:55 INFO - 'log_to_console': True, 14:07:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:55 INFO - 'opt_config_files': (), 14:07:55 INFO - 'pip_index': False, 14:07:55 INFO - 'sps_profile': False, 14:07:55 INFO - 'sps_profile_interval': 0, 14:07:55 INFO - 'suite': 'dromaeojs-e10s', 14:07:55 INFO - 'system_bits': '32', 14:07:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:55 INFO - 'title': 'talos-linux64-ix-062', 14:07:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:55 INFO - 'use_talos_json': True, 14:07:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:55 INFO - 'work_dir': 'build'} 14:07:55 INFO - ##### 14:07:55 INFO - ##### Running clobber step. 14:07:55 INFO - ##### 14:07:55 INFO - Running pre-action listener: _resource_record_pre_action 14:07:55 INFO - Running main action method: clobber 14:07:55 INFO - rmtree: /builds/slave/test/build 14:07:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:56 INFO - Running post-action listener: _resource_record_post_action 14:07:56 INFO - ##### 14:07:56 INFO - ##### Finished clobber step (success) 14:07:56 INFO - ##### 14:07:56 INFO - ##### 14:07:56 INFO - ##### Running read-buildbot-config step. 14:07:56 INFO - ##### 14:07:56 INFO - Running pre-action listener: _resource_record_pre_action 14:07:56 INFO - Running main action method: read_buildbot_config 14:07:56 INFO - Using buildbot properties: 14:07:56 INFO - { 14:07:56 INFO - "project": "", 14:07:56 INFO - "product": "firefox", 14:07:56 INFO - "script_repo_revision": "production", 14:07:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:07:56 INFO - "repository": "", 14:07:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:07:56 INFO - "buildid": "20160729113625", 14:07:56 INFO - "pgo_build": "True", 14:07:56 INFO - "basedir": "/builds/slave/test", 14:07:56 INFO - "buildnumber": 473, 14:07:56 INFO - "slavename": "talos-linux64-ix-062", 14:07:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:07:56 INFO - "platform": "ubuntu64_hw", 14:07:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:07:56 INFO - "branch": "mozilla-aurora", 14:07:56 INFO - "repo_path": "releases/mozilla-aurora", 14:07:56 INFO - "revision": "aa1f8366541eafaa16fbea50bbf2fc35af36ff61", 14:07:56 INFO - "stage_platform": "linux64-pgo", 14:07:56 INFO - "builduid": "d351db4f208545bab069d0160edf999a", 14:07:56 INFO - "slavebuilddir": "test" 14:07:56 INFO - } 14:07:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:07:56 INFO - Running post-action listener: _resource_record_post_action 14:07:56 INFO - ##### 14:07:56 INFO - ##### Finished read-buildbot-config step (success) 14:07:56 INFO - ##### 14:07:56 INFO - ##### 14:07:56 INFO - ##### Running download-and-extract step. 14:07:56 INFO - ##### 14:07:56 INFO - Running pre-action listener: _resource_record_pre_action 14:07:56 INFO - Running main action method: download_and_extract 14:07:56 INFO - mkdir: /builds/slave/test/build/tests 14:07:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:56 INFO - https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:07:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:07:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:07:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:07:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:07:58 INFO - Downloaded 1361 bytes. 14:07:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:07:58 INFO - Using the following test package requirements: 14:07:58 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:07:58 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:07:58 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:07:58 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'jsshell-linux-x86_64.zip'], 14:07:58 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:07:58 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:07:58 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:07:58 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:07:58 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:07:58 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:07:58 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:07:58 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:07: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:07:58 INFO - https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:07:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:07:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:07:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:07:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:08:01 INFO - Downloaded 24493799 bytes. 14:08:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:08:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:08:03 INFO - Return code: 0 14:08:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:03 INFO - https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:08:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:08:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:08:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:08:06 INFO - Downloaded 24493799 bytes. 14:08:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:08:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:08:07 INFO - Return code: 0 14:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:07 INFO - https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:08:08 INFO - Downloaded 10833369 bytes. 14:08:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:08:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:08:08 INFO - Return code: 0 14:08:08 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:08 INFO - https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:08:10 INFO - Downloaded 63653243 bytes. 14:08:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:08:10 INFO - mkdir: /builds/slave/test/properties 14:08:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:08:10 INFO - Writing to file /builds/slave/test/properties/build_url 14:08:10 INFO - Contents: 14:08:10 INFO - build_url:https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:08:10 INFO - Running post-action listener: _resource_record_post_action 14:08:10 INFO - Running post-action listener: set_extra_try_arguments 14:08:10 INFO - ##### 14:08:10 INFO - ##### Finished download-and-extract step (success) 14:08:10 INFO - ##### 14:08:10 INFO - ##### 14:08:10 INFO - ##### Running populate-webroot step. 14:08:10 INFO - ##### 14:08:10 INFO - Running pre-action listener: _resource_record_pre_action 14:08:10 INFO - Running main action method: populate_webroot 14:08:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:10 INFO - '--tppagecycles', 14:08:10 INFO - '7'], 14:08:10 INFO - 'tests': ['tsvgm']}}, 14:08:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:08:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:08:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['damp', 'tps']}, 14:08:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'tests': ['damp', 'tps']}, 14:08:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['dromaeo_dom']}, 14:08:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'other-e10s': {'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['a11yr', 14:08:10 INFO - 'ts_paint', 14:08:10 INFO - 'tpaint', 14:08:10 INFO - 'sessionrestore', 14:08:10 INFO - 'sessionrestore_no_auto_restore', 14:08:10 INFO - 'tabpaint']}, 14:08:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['tsvgx', 14:08:10 INFO - 'tsvgr_opacity', 14:08:10 INFO - 'tart', 14:08:10 INFO - 'tscrollx', 14:08:10 INFO - 'cart']}, 14:08:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:08:10 INFO - 'tsvgr_opacity', 14:08:10 INFO - 'tart', 14:08:10 INFO - 'tscrollx', 14:08:10 INFO - 'cart']}, 14:08:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'talos_options': ['--disable-e10s'], 14:08:10 INFO - 'tests': ['tp5o']}, 14:08:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'tests': ['tp5o']}, 14:08:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'talos_options': ['--disable-e10s', 14:08:10 INFO - '--xperf_path', 14:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:10 INFO - 'tests': ['tp5n']}, 14:08:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:10 INFO - 'talos_options': ['--xperf_path', 14:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:10 INFO - 'tests': ['tp5n']}}, 14:08:10 INFO - 'talos.zip': {'path': '', 14:08:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:10 INFO - Running post-action listener: _resource_record_post_action 14:08:10 INFO - ##### 14:08:10 INFO - ##### Finished populate-webroot step (success) 14:08:10 INFO - ##### 14:08:10 INFO - ##### 14:08:10 INFO - ##### Running create-virtualenv step. 14:08:10 INFO - ##### 14:08:10 INFO - Running pre-action listener: _resource_record_pre_action 14:08:10 INFO - Running main action method: create_virtualenv 14:08:10 INFO - Creating virtualenv /builds/slave/test/build/venv 14:08:10 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 14:08:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:11 INFO - Using real prefix '/usr' 14:08:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:08:12 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:14 INFO - Installing pip.................done. 14:08:14 INFO - Return code: 0 14:08:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:08:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:14 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 14:08:14 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 14:08:14 INFO - Using env: {'DISPLAY': ':0', 14:08:14 INFO - 'HOME': '/home/cltbld', 14:08:14 INFO - 'LANG': 'en_US.UTF-8', 14:08:14 INFO - 'LANGUAGE': 'en_US:en', 14:08:14 INFO - 'LOGNAME': 'cltbld', 14:08:14 INFO - 'MAIL': '/var/mail/cltbld', 14:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:14 INFO - 'MOZ_NO_REMOTE': '1', 14:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:14 INFO - 'NO_EM_RESTART': '1', 14:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:14 INFO - 'PWD': '/builds/slave/test', 14:08:14 INFO - 'SHELL': '/bin/bash', 14:08:14 INFO - 'SHLVL': '1', 14:08:14 INFO - 'TERM': 'linux', 14:08:14 INFO - 'TMOUT': '86400', 14:08:14 INFO - 'USER': 'cltbld', 14:08:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:14 INFO - '_': '/tools/buildbot/bin/python'} 14:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:14 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 14:08:14 INFO - Cleaning up... 14:08:14 INFO - Return code: 0 14:08:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:08:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:14 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:14 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 14:08:14 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 14:08:14 INFO - Using env: {'DISPLAY': ':0', 14:08:14 INFO - 'HOME': '/home/cltbld', 14:08:14 INFO - 'LANG': 'en_US.UTF-8', 14:08:14 INFO - 'LANGUAGE': 'en_US:en', 14:08:14 INFO - 'LOGNAME': 'cltbld', 14:08:14 INFO - 'MAIL': '/var/mail/cltbld', 14:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:14 INFO - 'MOZ_NO_REMOTE': '1', 14:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:14 INFO - 'NO_EM_RESTART': '1', 14:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:14 INFO - 'PWD': '/builds/slave/test', 14:08:14 INFO - 'SHELL': '/bin/bash', 14:08:14 INFO - 'SHLVL': '1', 14:08:14 INFO - 'TERM': 'linux', 14:08:14 INFO - 'TMOUT': '86400', 14:08:14 INFO - 'USER': 'cltbld', 14:08:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:14 INFO - '_': '/tools/buildbot/bin/python'} 14:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:14 INFO - Downloading/unpacking psutil>=3.1.1 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:14 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 14:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:16 INFO - Installing collected packages: psutil 14:08:16 INFO - Running setup.py install for psutil 14:08:16 INFO - building 'psutil._psutil_linux' extension 14:08:16 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 14:08:18 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 14:08:18 INFO - building 'psutil._psutil_posix' extension 14:08:18 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 14:08:18 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 14:08:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:18 INFO - Successfully installed psutil 14:08:18 INFO - Cleaning up... 14:08:18 INFO - Return code: 0 14:08:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:08:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:18 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:18 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 14:08:18 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 14:08:18 INFO - Using env: {'DISPLAY': ':0', 14:08:18 INFO - 'HOME': '/home/cltbld', 14:08:18 INFO - 'LANG': 'en_US.UTF-8', 14:08:18 INFO - 'LANGUAGE': 'en_US:en', 14:08:18 INFO - 'LOGNAME': 'cltbld', 14:08:18 INFO - 'MAIL': '/var/mail/cltbld', 14:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:18 INFO - 'MOZ_NO_REMOTE': '1', 14:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:18 INFO - 'NO_EM_RESTART': '1', 14:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:18 INFO - 'PWD': '/builds/slave/test', 14:08:18 INFO - 'SHELL': '/bin/bash', 14:08:18 INFO - 'SHLVL': '1', 14:08:18 INFO - 'TERM': 'linux', 14:08:18 INFO - 'TMOUT': '86400', 14:08:18 INFO - 'USER': 'cltbld', 14:08:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:18 INFO - '_': '/tools/buildbot/bin/python'} 14:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:20 INFO - Installing collected packages: mozsystemmonitor 14:08:20 INFO - Running setup.py install for mozsystemmonitor 14:08:20 INFO - Successfully installed mozsystemmonitor 14:08:20 INFO - Cleaning up... 14:08:20 INFO - Return code: 0 14:08:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:20 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:20 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 14:08:20 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 14:08:20 INFO - Using env: {'DISPLAY': ':0', 14:08:20 INFO - 'HOME': '/home/cltbld', 14:08:20 INFO - 'LANG': 'en_US.UTF-8', 14:08:20 INFO - 'LANGUAGE': 'en_US:en', 14:08:20 INFO - 'LOGNAME': 'cltbld', 14:08:20 INFO - 'MAIL': '/var/mail/cltbld', 14:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:20 INFO - 'MOZ_NO_REMOTE': '1', 14:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:20 INFO - 'NO_EM_RESTART': '1', 14:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:20 INFO - 'PWD': '/builds/slave/test', 14:08:20 INFO - 'SHELL': '/bin/bash', 14:08:20 INFO - 'SHLVL': '1', 14:08:20 INFO - 'TERM': 'linux', 14:08:20 INFO - 'TMOUT': '86400', 14:08:20 INFO - 'USER': 'cltbld', 14:08:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:20 INFO - '_': '/tools/buildbot/bin/python'} 14:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:20 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:20 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 14:08:20 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 14:08:20 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 14:08:20 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 14:08:20 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 14:08:20 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 14:08:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 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 14:08:22 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:23 INFO - warning: no files found matching '*.txt' 14:08:23 INFO - no previously-included directories found matching 'build' 14:08:23 INFO - no previously-included directories found matching 'dist' 14:08:23 INFO - no previously-included directories found matching '.git*' 14:08:23 INFO - Installing collected packages: jsonschema, functools32 14:08:23 INFO - Running setup.py install for functools32 14:08:23 INFO - warning: no files found matching '*.txt' 14:08:23 INFO - no previously-included directories found matching 'build' 14:08:23 INFO - no previously-included directories found matching 'dist' 14:08:23 INFO - no previously-included directories found matching '.git*' 14:08:23 INFO - Successfully installed jsonschema functools32 14:08:23 INFO - Cleaning up... 14:08:23 INFO - Return code: 0 14:08:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:23 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:23 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 14:08:23 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 14:08:23 INFO - Using env: {'DISPLAY': ':0', 14:08:23 INFO - 'HOME': '/home/cltbld', 14:08:23 INFO - 'LANG': 'en_US.UTF-8', 14:08:23 INFO - 'LANGUAGE': 'en_US:en', 14:08:23 INFO - 'LOGNAME': 'cltbld', 14:08:23 INFO - 'MAIL': '/var/mail/cltbld', 14:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:23 INFO - 'MOZ_NO_REMOTE': '1', 14:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:23 INFO - 'NO_EM_RESTART': '1', 14:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:23 INFO - 'PWD': '/builds/slave/test', 14:08:23 INFO - 'SHELL': '/bin/bash', 14:08:23 INFO - 'SHLVL': '1', 14:08:23 INFO - 'TERM': 'linux', 14:08:23 INFO - 'TMOUT': '86400', 14:08:23 INFO - 'USER': 'cltbld', 14:08:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:23 INFO - '_': '/tools/buildbot/bin/python'} 14:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:23 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 14:08:23 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 14:08:23 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 14:08:23 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 14:08:23 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 14:08:23 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 14:08:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:25 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 14:08:26 INFO - Downloading docopt-0.6.1.tar.gz 14:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:26 INFO - Running setup.py install for blobuploader 14:08:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:26 INFO - Running setup.py install for requests 14:08:26 INFO - Running setup.py install for docopt 14:08:26 INFO - Successfully installed blobuploader requests docopt 14:08:26 INFO - Cleaning up... 14:08:26 INFO - Return code: 0 14:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:26 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:26 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 14:08:26 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 14:08:26 INFO - Using env: {'DISPLAY': ':0', 14:08:26 INFO - 'HOME': '/home/cltbld', 14:08:26 INFO - 'LANG': 'en_US.UTF-8', 14:08:26 INFO - 'LANGUAGE': 'en_US:en', 14:08:26 INFO - 'LOGNAME': 'cltbld', 14:08:26 INFO - 'MAIL': '/var/mail/cltbld', 14:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:26 INFO - 'MOZ_NO_REMOTE': '1', 14:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:26 INFO - 'NO_EM_RESTART': '1', 14:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:26 INFO - 'PWD': '/builds/slave/test', 14:08:26 INFO - 'SHELL': '/bin/bash', 14:08:26 INFO - 'SHLVL': '1', 14:08:26 INFO - 'TERM': 'linux', 14:08:26 INFO - 'TMOUT': '86400', 14:08:26 INFO - 'USER': 'cltbld', 14:08:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:26 INFO - '_': '/tools/buildbot/bin/python'} 14:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:26 INFO - Running setup.py (path:/tmp/pip-TEUogf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:27 INFO - Running setup.py (path:/tmp/pip-P1DYb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:27 INFO - Running setup.py (path:/tmp/pip-W85xC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:27 INFO - Running setup.py (path:/tmp/pip-EtfKoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:27 INFO - Running setup.py (path:/tmp/pip-gfX5Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:27 INFO - Running setup.py (path:/tmp/pip-R4xwSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:27 INFO - Running setup.py (path:/tmp/pip-bcTAfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:27 INFO - Running setup.py (path:/tmp/pip-TsN6Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:27 INFO - Running setup.py (path:/tmp/pip-DN6vJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:27 INFO - Running setup.py (path:/tmp/pip-kxVPUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:27 INFO - Running setup.py (path:/tmp/pip-VOSLsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:27 INFO - Running setup.py (path:/tmp/pip-l94LYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:27 INFO - Running setup.py (path:/tmp/pip-ay6_ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:27 INFO - Running setup.py (path:/tmp/pip-tv3_MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:27 INFO - Running setup.py (path:/tmp/pip-YBR1af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:28 INFO - Running setup.py (path:/tmp/pip-xuVuqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:28 INFO - Running setup.py (path:/tmp/pip-Wjp6d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:28 INFO - Running setup.py install for manifestparser 14:08:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Running setup.py install for mozcrash 14:08:28 INFO - Running setup.py install for mozdebug 14:08:28 INFO - Running setup.py install for mozdevice 14:08:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Running setup.py install for mozfile 14:08:28 INFO - Running setup.py install for mozhttpd 14:08:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Running setup.py install for mozinfo 14:08:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Running setup.py install for mozInstall 14:08:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Running setup.py install for mozleak 14:08:29 INFO - Running setup.py install for mozlog 14:08:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Running setup.py install for moznetwork 14:08:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Running setup.py install for mozprocess 14:08:29 INFO - Running setup.py install for mozprofile 14:08:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Running setup.py install for mozrunner 14:08:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Running setup.py install for mozscreenshot 14:08:29 INFO - Running setup.py install for moztest 14:08:29 INFO - Running setup.py install for mozversion 14:08:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:29 INFO - Cleaning up... 14:08:29 INFO - Return code: 0 14:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:30 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:30 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 14:08:30 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 14:08:30 INFO - Using env: {'DISPLAY': ':0', 14:08:30 INFO - 'HOME': '/home/cltbld', 14:08:30 INFO - 'LANG': 'en_US.UTF-8', 14:08:30 INFO - 'LANGUAGE': 'en_US:en', 14:08:30 INFO - 'LOGNAME': 'cltbld', 14:08:30 INFO - 'MAIL': '/var/mail/cltbld', 14:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:30 INFO - 'MOZ_NO_REMOTE': '1', 14:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:30 INFO - 'NO_EM_RESTART': '1', 14:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:30 INFO - 'PWD': '/builds/slave/test', 14:08:30 INFO - 'SHELL': '/bin/bash', 14:08:30 INFO - 'SHLVL': '1', 14:08:30 INFO - 'TERM': 'linux', 14:08:30 INFO - 'TMOUT': '86400', 14:08:30 INFO - 'USER': 'cltbld', 14:08:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:30 INFO - '_': '/tools/buildbot/bin/python'} 14:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:30 INFO - Running setup.py (path:/tmp/pip-RyYB9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:30 INFO - Running setup.py (path:/tmp/pip-rIWy9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:30 INFO - Running setup.py (path:/tmp/pip-_NpX7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:30 INFO - Running setup.py (path:/tmp/pip-vCupLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:30 INFO - Running setup.py (path:/tmp/pip-uUBuCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:30 INFO - Running setup.py (path:/tmp/pip-ZBbZyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:30 INFO - Running setup.py (path:/tmp/pip-31Aymn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:30 INFO - Running setup.py (path:/tmp/pip-eAG1sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:30 INFO - Running setup.py (path:/tmp/pip-C7vqUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:30 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:30 INFO - Running setup.py (path:/tmp/pip-XnWfqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 14:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:30 INFO - Running setup.py (path:/tmp/pip-aXHe2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:31 INFO - Running setup.py (path:/tmp/pip-rPbbmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:31 INFO - Running setup.py (path:/tmp/pip-mBCCaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:31 INFO - Running setup.py (path:/tmp/pip-jc1e1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:31 INFO - Running setup.py (path:/tmp/pip-1Dvob9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:31 INFO - Running setup.py (path:/tmp/pip-_ABEOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:31 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)) 14:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:31 INFO - Running setup.py (path:/tmp/pip-5HmZh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:31 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)) 14:08:31 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)) 14:08:31 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)) 14:08:31 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)) 14:08:31 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)) 14:08:31 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)) 14:08:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:31 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 14:08:31 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 14:08:31 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 14:08:31 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 14:08:31 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 14:08:31 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 14:08:33 INFO - Downloading blessings-1.6.tar.gz 14:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:33 INFO - Installing collected packages: blessings 14:08:33 INFO - Running setup.py install for blessings 14:08:33 INFO - Successfully installed blessings 14:08:33 INFO - Cleaning up... 14:08:33 INFO - Return code: 0 14:08:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:33 INFO - Reading from file tmpfile_stdout 14:08:33 INFO - Current package versions: 14:08:33 INFO - argparse == 1.2.1 14:08:33 INFO - blessings == 1.6 14:08:33 INFO - blobuploader == 1.2.4 14:08:33 INFO - docopt == 0.6.1 14:08:33 INFO - functools32 == 3.2.3-2 14:08:33 INFO - jsonschema == 2.5.1 14:08:33 INFO - manifestparser == 1.1 14:08:33 INFO - mozInstall == 1.12 14:08:33 INFO - mozcrash == 0.17 14:08:33 INFO - mozdebug == 0.1 14:08:33 INFO - mozdevice == 0.48 14:08:33 INFO - mozfile == 1.2 14:08:33 INFO - mozhttpd == 0.7 14:08:33 INFO - mozinfo == 0.9 14:08:33 INFO - mozleak == 0.1 14:08:33 INFO - mozlog == 3.2 14:08:33 INFO - moznetwork == 0.27 14:08:33 INFO - mozprocess == 0.23 14:08:33 INFO - mozprofile == 0.28 14:08:33 INFO - mozrunner == 6.12 14:08:33 INFO - mozscreenshot == 0.1 14:08:33 INFO - mozsystemmonitor == 0.3 14:08:33 INFO - moztest == 0.7 14:08:33 INFO - mozversion == 1.4 14:08:33 INFO - psutil == 3.1.1 14:08:33 INFO - requests == 1.2.3 14:08:33 INFO - wsgiref == 0.1.2 14:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:33 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:33 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 14:08:33 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 14:08:33 INFO - Using env: {'DISPLAY': ':0', 14:08:33 INFO - 'HOME': '/home/cltbld', 14:08:33 INFO - 'LANG': 'en_US.UTF-8', 14:08:33 INFO - 'LANGUAGE': 'en_US:en', 14:08:33 INFO - 'LOGNAME': 'cltbld', 14:08:33 INFO - 'MAIL': '/var/mail/cltbld', 14:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:33 INFO - 'MOZ_NO_REMOTE': '1', 14:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:33 INFO - 'NO_EM_RESTART': '1', 14:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:33 INFO - 'PWD': '/builds/slave/test', 14:08:33 INFO - 'SHELL': '/bin/bash', 14:08:33 INFO - 'SHLVL': '1', 14:08:33 INFO - 'TERM': 'linux', 14:08:33 INFO - 'TMOUT': '86400', 14:08:33 INFO - 'USER': 'cltbld', 14:08:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:33 INFO - '_': '/tools/buildbot/bin/python'} 14:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 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)) 14:08:34 INFO - Cleaning up... 14:08:34 INFO - Return code: 0 14:08:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 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 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:34 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 14:08:34 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 14:08:34 INFO - Using env: {'DISPLAY': ':0', 14:08:34 INFO - 'HOME': '/home/cltbld', 14:08:34 INFO - 'LANG': 'en_US.UTF-8', 14:08:34 INFO - 'LANGUAGE': 'en_US:en', 14:08:34 INFO - 'LOGNAME': 'cltbld', 14:08:34 INFO - 'MAIL': '/var/mail/cltbld', 14:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:34 INFO - 'MOZ_NO_REMOTE': '1', 14:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:34 INFO - 'NO_EM_RESTART': '1', 14:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:34 INFO - 'PWD': '/builds/slave/test', 14:08:34 INFO - 'SHELL': '/bin/bash', 14:08:34 INFO - 'SHLVL': '1', 14:08:34 INFO - 'TERM': 'linux', 14:08:34 INFO - 'TMOUT': '86400', 14:08:34 INFO - 'USER': 'cltbld', 14:08:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:34 INFO - '_': '/tools/buildbot/bin/python'} 14:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:34 INFO - Cleaning up... 14:08:34 INFO - Return code: 0 14:08:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:08:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:34 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56907aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', '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 14:08:34 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', 'flake8'] in /builds/slave/test/build 14:08:34 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 flake8 14:08:34 INFO - Using env: {'DISPLAY': ':0', 14:08:34 INFO - 'HOME': '/home/cltbld', 14:08:34 INFO - 'LANG': 'en_US.UTF-8', 14:08:34 INFO - 'LANGUAGE': 'en_US:en', 14:08:34 INFO - 'LOGNAME': 'cltbld', 14:08:34 INFO - 'MAIL': '/var/mail/cltbld', 14:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:34 INFO - 'MOZ_NO_REMOTE': '1', 14:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:34 INFO - 'NO_EM_RESTART': '1', 14:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:34 INFO - 'PWD': '/builds/slave/test', 14:08:34 INFO - 'SHELL': '/bin/bash', 14:08:34 INFO - 'SHLVL': '1', 14:08:34 INFO - 'TERM': 'linux', 14:08:34 INFO - 'TMOUT': '86400', 14:08:34 INFO - 'USER': 'cltbld', 14:08:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:34 INFO - '_': '/tools/buildbot/bin/python'} 14:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:34 INFO - Downloading/unpacking flake8 14:08:34 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 14:08:34 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 14:08:34 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 14:08:34 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 14:08:34 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 14:08:34 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 14:08:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:08:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:08:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:08:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:08:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:08:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:08:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:08:37 INFO - no previously-included directories found matching 'docs/_build' 14:08:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:08:37 INFO - Running setup.py install for pep8 14:08:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:08:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:08:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:08:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:08:37 INFO - no previously-included directories found matching 'docs/_build' 14:08:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:08:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:08:37 INFO - Cleaning up... 14:08:37 INFO - Return code: 0 14:08:37 INFO - Running post-action listener: _resource_record_post_action 14:08:37 INFO - Running post-action listener: _start_resource_monitoring 14:08:37 INFO - Starting resource monitoring. 14:08:37 INFO - ##### 14:08:37 INFO - ##### Finished create-virtualenv step (success) 14:08:37 INFO - ##### 14:08:37 INFO - ##### 14:08:37 INFO - ##### Running install step. 14:08:37 INFO - ##### 14:08:37 INFO - Running pre-action listener: _resource_record_pre_action 14:08:37 INFO - Running main action method: install 14:08:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:37 INFO - Reading from file tmpfile_stdout 14:08:37 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:37 INFO - Reading from file tmpfile_stdout 14:08:37 INFO - Output received: 14:08:37 INFO - Usage: mozinstall [options] installer 14:08:37 INFO - Options: 14:08:37 INFO - -h, --help show this help message and exit 14:08:37 INFO - -d DEST, --destination=DEST 14:08:37 INFO - Directory to install application into. [default: 14:08:37 INFO - "/builds/slave/test"] 14:08:37 INFO - --app=APP Application being installed. [default: firefox] 14:08:37 INFO - mkdir: /builds/slave/test/build/application 14:08:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:08:53 INFO - Reading from file tmpfile_stdout 14:08:53 INFO - Output received: 14:08:53 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:53 INFO - Running post-action listener: _resource_record_post_action 14:08:53 INFO - ##### 14:08:53 INFO - ##### Finished install step (success) 14:08:53 INFO - ##### 14:08:53 INFO - ##### 14:08:53 INFO - ##### Running run-tests step. 14:08:53 INFO - ##### 14:08:53 INFO - Running pre-action listener: _resource_record_pre_action 14:08:53 INFO - Running main action method: run_tests 14:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:53 INFO - Python 2.7.3 14:08:53 INFO - Return code: 0 14:08:53 INFO - grabbing minidump binary from tooltool 14:08:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:53 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 0x2d121c0>, '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 0x2d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d13550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:53 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 14:08:53 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 14:08:53 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 14:08:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:54 INFO - Return code: 0 14:08:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:08:54 INFO - Return code: 0 14:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 14:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 14:08:54 INFO - Using env: {'DISPLAY': ':0', 14:08:54 INFO - 'HOME': '/home/cltbld', 14:08:54 INFO - 'LANG': 'en_US.UTF-8', 14:08:54 INFO - 'LANGUAGE': 'en_US:en', 14:08:54 INFO - 'LOGNAME': 'cltbld', 14:08:54 INFO - 'MAIL': '/var/mail/cltbld', 14:08:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:54 INFO - 'MOZ_NO_REMOTE': '1', 14:08:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:54 INFO - 'NO_EM_RESTART': '1', 14:08:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:54 INFO - 'PWD': '/builds/slave/test', 14:08:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:54 INFO - 'SHELL': '/bin/bash', 14:08:54 INFO - 'SHLVL': '1', 14:08:54 INFO - 'TERM': 'linux', 14:08:54 INFO - 'TMOUT': '86400', 14:08:54 INFO - 'USER': 'cltbld', 14:08:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966', 14:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:54 INFO - '_': '/tools/buildbot/bin/python'} 14:08:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 14:08:55 INFO - mozversion application_buildid: 20160729113625 14:08:55 INFO - mozversion application_changeset: aa1f8366541eafaa16fbea50bbf2fc35af36ff61 14:08:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:08:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:55 INFO - mozversion application_name: Firefox 14:08:55 INFO - mozversion application_remotingname: firefox-dev 14:08:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:08:55 INFO - mozversion application_vendor: Mozilla 14:08:55 INFO - mozversion application_version: 49.0a2 14:08:55 INFO - mozversion platform_buildid: 20160729113625 14:08:55 INFO - mozversion platform_changeset: aa1f8366541eafaa16fbea50bbf2fc35af36ff61 14:08:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:08:55 INFO - mozversion platform_version: 49.0a2 14:08:55 INFO - using testdate: 1469826535 14:08:55 INFO - actual date: 1469826535 14:08:55 INFO - starting webserver on 'localhost:44032' 14:08:55 INFO - SUITE-START | Running 2 tests 14:08:55 INFO - TEST-START | dromaeo_css 14:08:55 INFO - operating with platform_type : linux_ 14:08:55 INFO - Initialising browser for dromaeo_css test... 14:08:55 INFO - TEST-INFO | started process 3328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNysf0/profile http://localhost:44032/getInfo.html) 14:09:02 INFO - PROCESS | 3328 | __metrics Screen width/height:1600/1200 14:09:02 INFO - PROCESS | 3328 | colorDepth:24 14:09:02 INFO - PROCESS | 3328 | Browser inner width/height: 1024/697 14:09:02 INFO - PROCESS | 3328 | __metrics 14:09:03 ERROR - PROCESS | 3328 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:09:04 INFO - TEST-INFO | 3328: exit 0 14:09:04 INFO - Browser initialized. 14:09:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:04 INFO - TEST-INFO | started process 3459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdNysf0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:16 INFO - PROCESS | 3459 | RSS: Main: 156348416 14:09:16 INFO - PROCESS | 3459 | 14:10:05 INFO - PROCESS | 3459 | 1469826605787 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] 14:12:13 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44032/tests/dromaeo/cssquery-ext.html) 14:12:15 INFO - PROCESS | 3459 | RSS: Main: 161116160 14:12:15 INFO - PROCESS | 3459 | 14:15:17 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-ext.html (next: http://localhost:44032/tests/dromaeo/cssquery-jquery.html) 14:15:17 INFO - PROCESS | 3459 | RSS: Main: 156745728 14:15:17 INFO - PROCESS | 3459 | 14:18:19 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44032/tests/dromaeo/cssquery-mootools.html) 14:18:20 INFO - PROCESS | 3459 | RSS: Main: 157839360 14:18:20 INFO - PROCESS | 3459 | 14:21:21 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44032/tests/dromaeo/cssquery-prototype.html) 14:21:22 INFO - PROCESS | 3459 | RSS: Main: 156954624 14:21:22 INFO - PROCESS | 3459 | 14:24:24 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44032/tests/dromaeo/cssquery-yui.html) 14:24:25 INFO - PROCESS | 3459 | RSS: Main: 158601216 14:24:25 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:44032/tests/dromaeo/cssquery-yui.html (next: http://localhost:44032/tests/dromaeo/cssquery-dojo.html) 14:27:27 INFO - PROCESS | 3459 | RSS: Main: 158863360 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | __start_tp_report 14:27:27 INFO - PROCESS | 3459 | _x_x_mozilla_page_load 14:27:27 INFO - PROCESS | 3459 | _x_x_mozilla_page_load_details 14:27:27 INFO - PROCESS | 3459 | |i|pagename|runs| 14:27:27 INFO - PROCESS | 3459 | |0;dojo.html;3360.1263671445427;3412.744044196683;3432.0218737659757;3439.380911435942;3446.896593102206;5643.379228284891;5653.208550802891;5692.402297758737;5695.373508914021;5707.115397113444;5714.542836573075;5720.485156335929;5725.971370143144;5748.453896879801;5771.307443106823;5131.974340128303;5175.456577059392;5251.86870328241;5289.735513224343;5296.655717378358;5069.340985671876;5104.106781313274;5278.577713782907;5278.947210527884;5300.231466437364;5136.152534831748;5143.639945203819;5171;5177.378714554259;5220.92168617471;5157.48425157485;5208.2968799212;5236.240745091978;5242.7640756166065;5266.973665131688;5002.449730529639;5040.949590504085;5155.742212889378;5207.6615020023955;5219.921701174486;5438.640339915021;5467.4532546745;5468.507834294933;5514.944850551483;5563.054280772279;6034.125051867499;6079.544034197453;6094.725737341831;6115.755369785204;6123.4488895999575;6000.219971403733;6003.459688628044;6117.908231376488;6152.3540028297275;6189.938100619026;5648.406917273668;5721.628094173949;5722.399148089432;5731.398203188647;5780.7687692492245;6205.100260462208;6221.471174950089;6230.065490176419;6246.625202487774;6247.875042499125;5869.911951320733;5871.500922421556;5892.381299963527;5982.551308651869;6007.969960150259;6091.908621370683;6093.146959425684;6099.451049405486;6099.634021958696;6125.663088530085;5985.9401405986255;5988.461038506555;6053.182820319289;6054.424829641177;6079.905616988985;5832.912506312408;5968.313643930916;6038.064100064497;6048.092786082035;6070.423309785563;4624.861254162381;4641.559051890065;4652.604528615038;4654.115718013567;4704.341392205094;4192.790360481964;4207.410962465257;4209.095044565433;4215.852445164404;4239.97880010598;5770.826875193751;5879.470847623735;5906.5570082244;5949.137375080676;6013.067974463877;6067.332593414721;6165.691715414301;6168.0439531872635;6176.722047507873;6230.345813689588;5723.399043100415;5902.763889444374;5952.007645328415;5963.135345374896;6031.577789554689;5097.286379906816;5170.638055336166;5177.7152256625495;5186.662866913714;5222.92165617516;6250.281217659936;6344.714487848058;6362.204724409449;6404.647744374011;6466.482681385478;5892.351841297368;6132.324915438508;6145.293291271561;6149.108379285068;6150.261968563801;6406.942854428967;6421.197350331208;6422.100905873088;6480.708368123352;6488.124103246001;5995.5803093783015;6009.2188015557695;6038.215032045806;6045.455908968214;6076.54425918049;5886.646801191942;6036.879262414815;6043.7884674036195;6182.505399568114;6203.348648392034;5879.911801323069;5951.583389162717;5985.191999080069;6011.819645410645;6012.218411606638;5881.617694849821;5891.764329426775;5892.1161825726485;5928.34788173292;5973.223480947449;5662.490375866192;5754.280714910637;5800.622959507618;5880.735366908585;5902.2622172228475;5956.970215148896;5977.3424923257535;6048.123022161674;6048.788292409745;6090.299615544269;5855.268091488564;5861.179434879035;5908.497777688773;5917;5923.170756094237 14:27:27 INFO - PROCESS | 3459 | |1;ext.html;599.3257585216631;632.7722020072775;652.8302641313257;658.5028303630758;662.2516556291391;41345;44825.10349793006;44893.551064489344;44901.7754911225;45289.77355113224;45522.77238613811;45821.54178458214;46200;46333.768331158295;46610.53389466104;8969.282457403424;9130.26957843371;9167.12912273333;9168.633254669838;9171.128742769459;9045.954770226173;9050.818983620356;9100.590473428712;9109.772255693628;9110.088991100904;9155.496447695374;9198.218151457135;9206.585703643352;9209.355345125843;9211.217046551052;9007.909920900773;9054.868141482282;9102.271818254523;9120.635174593042;9130.086991300883;9046.185843274072;9101.544922753903;9113.589888455035;9116.772080697969;9124.361294709373;43062.56937430617;43249.56750432487;43453;43623;43632;3958.3072962231495;3990.86031988879;3994.900127496836;4105.3020986432375;4238.237117318881;33974.830125849214;34107.658923410694;34749.65250347515;34778.65221347779;34886.30227395438;4122.175564887035;4148.730332528376;4170.082581831992;4187.120704652027;4206.47419072616;333012;334771;336643;337242.99999999756;339257;66546.33453665498;66650.33349666442;67268;67377.32622673809;67412;38908.8054559731;40680;40737.38893916594;42252;42541.787291063345;16763.413280535122;16777.328906843835;16893;16897.32410703558;16915.830841691673;11504.309741415542;11512.76974460506;11522;11548.480318385693;11550.480228389742;21235;21693.457663558223;21724.45688857791;21770.78229217719;21824;7671.3862890968585;7692.615369231516;7722.266384693445;7790.688372465038;7851.332636725828;1077.7736675298274;1137.8350139229765;1162.9476673549711;1214.2107630040543;1260.294235228275;33387.49918751221;33795.493067604;33797;34147;34180.92278364086;1187.3588262338412;1244.7510497900457;1256.654420034498;1276.974460510803;1309.4238535044549;17352.392666256874;17948.910255448638;17950.371736989404;18143.092845357678;18157.182926768328;528863;568450;574795;576418;579769;59480.70259648674;65508.672456638364;66000;66058;66565.66717166384;1500.8123984501938;1502.1212590634602;1514.5002149290708;1517.0278637770855;1533.1337794146273;33366.83316583402;34191;34287.82856085704;34289.657103428646;34476.82761586276;55376.169357458864;55799.442005579425;56352.74589016393;56445.71777141088;56660.71669641625;458260;464825;464839;465728;465850;31340.05979820609;31579.21051973719;31592;31672.683273166975;31728.206794830316;49397.25904111369;50911.236331455795;51681.224781629055;53376.73311633417;54055;45134;45162.322565162205;46843.29735053909;47324.2901356473;47330;42922.570774293104;44347;44857;48369.75815120902;48895.75552122216;44010.33984490171;44675.55324446714;45193.32210016918;47893.76053119712;49549;37545.81227093847;37744.811275943444;38028.61971380251;39526.40710389404;39599.2080158401;29891.402171956874;29994.400111998075;30307.545386818776;30317.848410757804;30799.538006929466 14:27:27 INFO - PROCESS | 3459 | |2;jquery.html;414.2440046914382;420.5626148805243;422.6555357383732;424.15169660678635;432.1357285429142;18806;19673.11470983804;20248.392548223557;20976.475588110305;21126.471838204052;19771.802281977176;19953.700694489595;20082.196712131532;20222.39332820014;20631.896840515776;5621.156826476031;5883.47048765611;5892.705364731746;5919.052951527757;5925.34821169671;5776.624519406225;5814.622049566786;5814.8255552333285;5848.385919478457;5858.941410585882;5773.509251713609;5776.104703770901;5793.971030144864;5811.709414529278;5851.79518716845;5516.531094856942;5542;5776.537876969833;5787.47912687858;5809.215755872945;5223.08595995703;5229;5245.659032162897;5249.265102885599;5249.317588713481;20702.5859482811;24248.515029699483;24301;24368;24655;2716.5653495440833;2770.224337185591;2916.402137561795;2966.5550167474835;2996.056242283674;14315.42738290467;14436.350364233635;14516.05645633041;15351;15559.688806223812;2000.2099170827441;2006.1975209916004;2029.2998915374171;2063.5253891605016;2091.4980404702915;69746.30253697449;74324;77909.61045194794;79371.20628793696;79829;11046.558137674403;11202.831957520644;11280.717982050515;11432.771344573062;11456.599019034295;15666.138362390178;15680.529584112495;15767.132807695687;15781.526554203392;15790.131542765028;8029.91596134526;8065.556394398247;8296.336293096538;8304.252617264476;8350.707725229588;7703.961480192564;7727;7793.688252469951;7814.6092695365005;7846.9215307847335;6970.686319115652;6989.405900498413;7059.399951004119;7104.147502299757;7161.606111663804;2001.109506269696;2002.6495363311362;2051.7435320584927;2058.8970551472366;2120.2155202575145;980.294188184506;1064.776396956648;1098.752780624369;1148.4831825678477;1166.276908316832;19961.20155193805;20060;20240.493987650425;20298;20463.07916143777;1085.7068591480256;1094.6661268313082;1143.2683082826998;1146.2549342927164;1154.653603918821;10694.572217111385;11545;11549.13381496391;11616.767664646659;11621.53513859453;450082;451016;454874;457706;464650;79399.20600793918;79824.60087699525;80065;81373;81613.143539977;1108.1135091926426;1112.8497652816927;1114.1421105748366;1125.7241975716001;1150.5225331487507;17808.55478613045;17879.19543620566;18053.097345132428;18113.36603218881;18126.365577204735;36928.63071369252;37619;38044.007835105556;38959.80520097382;39053.21893562056;52450;53179;53421.73289133685;53632.195517066495;53999.46000539944;8907.688230911886;9104.271658267191;9314.906850931675;9364.531773411167;9367.391119577205;13669.179849209078;13806.17162970225;14073.577792666236;14143.504977325743;14182.929085354508;11024.44877756125;11273.71815704614;11385.373804440504;11471.541138354372;11504.884951150381;11082.944585277022;11141.832872506757;11971.162018658959;12012.978896793871;12032.578859739868;11393.316401015965;11424.314541127558;11445.48495317696;11454.911783380565;11873.465694043962;7477.813054673677;8176.345892328718;8347.081820999807;8425.257885635841;8572.614232359434;11308.717282068013;11387.601433949772;11439.370834604177;11442;11624.360660163773 14:27:27 INFO - PROCESS | 3459 | |3;mootools.html;1521.53593154088;1577.5188567486916;1734.9913250433747;1856.8885866847982;1874.4095609882886;8369.539675317856;8897.466152030875;8923.91076089239;9462.574184161704;9478.76303092423;8995.59519821608;9297.488638124918;9322.86015709765;9343.859842102374;9378.906210937888;2405.518896220754;2421.0315873650593;2440.9023639054503;2441.5727247731666;2442.511497700458;2420.782129608335;2421.685180926477;2424.903003879843;2438.6829712137396;2451.8528888266674;2409.0965887792077;2416.601260791976;2427.320350301918;2428.441458464554;2434.4400787818813;2335.4394945213025;2344.531093781242;2356.3991182248587;2368.857868527894;2374.501354715503;2314.0396735354807;2378.9643155352683;2395.245497668229;2410.2769169249154;2428.9514209715885;9398.859017114748;9467.337286389955;9484.668036618754;9519.095685909828;9563.665271715456;5550.500454959033;5594.412586678422;5643;5697.0599851024535;5714.828555143353;3571.2143328467696;3652.726045546568;3698.33429982603;3714.275716235335;3751.8311675974646;1212.8605210400829;1228.8525376954822;1252.0922331309728;1254.91215614907;1268.3721557828842;13069.08516403852;13078.869211307956;13105.082644214908;13206;13217.33913304331;4758.476567577563;4758.912529086631;4864.927026094611;4879.829205977774;4886.951130488721;10363.11913487347;10393.9480302598;10423.478826058667;10429.113525350278;10458.895411045944;5568.693721845257;5570.192322113271;5577.693226872561;5587.8603034923635;5605.887882242332;4578.748168850679;5025.497450254945;5180.533751962342;5195.818146364859;5207.3490813648295;3904.648581627667;4005.8798236052967;4010.458588090629;4059.6143366380147;4145.689073319513;1223.431104536377;1225.436299302313;1247.7754004279136;1258.6224132760135;1259.1437822280755;938.3712912348743;974.1135566634329;995.4823491784232;1022.3559157730582;1074.2168001118107;6064.9090263646085;6279.246490421178;6312.70465453569;6413.903791443132;6553.148090748267;498.86780003299157;506.5441103007323;513.2429666242338;515.5411683601598;523.8847453560211;4417.911641767147;4456.64346852251;4472.217361961643;4484.663650226181;4503.279475284005;11242.437878106226;11625.069994400428;11669.88330116688;11710.94144529272;11716.472758725708;11382.658520244406;11440.656780296604;11445.542178312775;11502.712432189262;11546.653600392001;8320.70877519296;8567.957160214159;8628.309735221168;8837.381383303107;8884;6371.299157092809;6565.540412171103;6636.867262654623;6714.6978385973725;6755.628440435823;10619.840702389625;10830.566777328819;10913.727156821144;10935.671929842118;11072.667819965414;10975.890241097806;11010.339379637247;11109.055730263019;11183.384913829492;11209.607663731731;7791.298783109547;8235.052968908652;8292;8428.4942903426;8551.786205344915;9054.864177037218;9114.225290850352;9168.587413566538;9226.584803683985;9261.768455788659;7744.4578879477895;7964.402669799672;8364.163583641588;8364.87452688198;8387.580620969049;7445.143808462096;7548.66031028616;7562.924370756222;7908.802279943047;8043.517388956681;7223.530470519399;7285.526440781332;7335;7335.8532829344185;7465.664045118091;5364.141737322166;5383.0579648562125;5412.052890744026;5471.863203419946;5474.945250547444;5590.440955904377;5600.271964644733;5635.718214089361;5656.377798442086;5661.46216109469 14:27:27 INFO - PROCESS | 3459 | |4;prototype.html;346.4595231438955;350.6791285973334;350.8824543777834;352.96823285904264;355.2646022732944;5610.80362187323;5729.106801065462;5740.282464691913;5756.769729210827;5770.913436298459;5634.253381451753;5642;5643.943560564393;5656.971715141429;5673.099511663598;4016.2168377166463;4101.487314085739;4328.63206627437;4369.169857727037;4403.3394990751485;4407;4408.581184787457;4419.381286619876;4421.491528474218;4425.959899423633;4405.691601587891;4415.028693687384;4416.646668266531;4424.048829501657;4425.380446737459;4152.97923510382;4349.521552629209;4377.715448495837;4402.40567523385;4452.487963884146;3839.808009599537;3840.6351396617556;3846.6922646188236;3851;3851.6533511983775;5417.4808713947805;5420.620556561043;5433.1035379162395;5441.047816632074;5469.453054694539;4993.226049962262;5025.1959686450355;5037.773300201499;5055.887704704959;5114.616403769732;5841.312996021835;5849.298084229919;5891.293044834604;5899.734511946973;5929.169916211734;4239.283090348414;4270.167317373113;4281.272183728774;4294.248506511348;4294.733053749152;5984.281886173643;6014.488768454687;6103.572749907508;6169.568130230886;6237.719302631393;4341.479022517255;4349.695521313541;4351.5848703969605;4356.433663623772;4356.782160892006;4371.803268852909;4386.956130438719;4391.890202744893;4393.450818647669;4427.690061695715;4984.40187177541;4987.202047672427;4997.2015671224235;5029.949700503022;5068.797248110108;5890.587658863924;5893.911591326134;5919.4080591940465;5920.2007728956905;5945.583809133319;1492.276246020679;1500.4148382130759;1506.49532406645;1506.5932198306396;1511.2594828533938;943.4858002388714;968.3899143539525;974.9415035097917;998.8351921932945;1000.7948370584013;5110.97444512775;5149.562287205555;5176;5181.792728290826;5205.839576575754;5362;5405.675659460445;5443.8094666686475;5480.725963701799;5516.365617953907;4965.851024469272;5112.488751124858;5150.97424512875;5184.844454666366;5240.266362709223;2869.8421586812924;2902.6081479000063;2908.258394109531;2912.402957393729;2953.586497890297;5637.520810731134;5719;5728.971355143198;5734.942650573525;5745.971270143623;5272.683638981596;5472.890542189134;5487.670739755627;5528.954286913787;5614.9157762633595;5554.50009499147;5658.773649054074;5680.318361796693;5715.457031581993;5742.511886489611;5107.650480778735;5378.838634840961;5404.459554044564;5415.945840541702;5456.372517160418;5320.866978325418;5346.091164501966;5369.523381070081;5386.245925570502;5423.620346575702;6264.530160238091;6408.455281300955;6411.935880641134;6430.710618022294;6466.224053113657;4258.446401967724;4362.956370436382;4382.014046839436;4389.934150987674;4413.801378938019;6114.816555503342;6128.325884152829;6193.783217587363;6223.657698826608;6253.874922501615;6040.516758659384;6055.182550355646;6070.453659170696;6075.635461872302;6097.237845269341;5995.850103747442;5996.67018313997;6020.2842189975645;6044.607100538451;6096.146539484387;5545.972270138624;5904.380040095728;5910.231669882888;5911.763529458945;5939.673317967553;6030.547708921761;6041.818745437644;6046.697665116814;6048.60684055535;6049.697515124314;5601.887962240651;5822.951868663681;5869.119632055226;5880.353161152356;5880.852978675567 14:27:27 INFO - PROCESS | 3459 | |5;yui.html;790.7943934577008;802.1417083720418;866.7356456280834;893.5487578772719;900.9729708108757;15291.082535047892;16371.754423683655;16685.33258669653;16937.915310423446;16963.32146714133;15321.923390383032;15583.376664933417;15604.45384411543;15616.141112238822;15725.37098516058;717.5407739047014;842.5787106446777;854.4659587757651;858.527809704663;860.0539406652695;861.2076889261895;861.2507118806647;866.7183165471215;871.6077765005741;873.2882700599023;897.8742975983367;903.9502827344494;909.0863681999581;914.3416739947261;918.531548910054;895.3508706188027;896.332232486795;902.4359775140537;908.4503875155502;908.7955210077713;663.2869665109978;666.4668265387719;669.4543946683438;670.1321788284183;672.1765836849869;15626.296816643278;15655;15694.686106277924;15720.37118515258;15757.763633545506;15894.217572056585;16320.67358652832;16502.33990640385;16504.25730842103;16752.748708769377;11979.341136237503;12146.271223726604;12456.31490268035;12890.291033993126;13364.465421383133;4008.118213992917;4028.697847661437;4055.7566546007333;4119.237940980898;4120.876373708794;81077.18922810814;82146;82241.17758822395;82968.58515707383;83233;11485.425728713531;11878.762424751456;11927.701807454883;12086.214396064228;12104;24066.7593324068;24414.389640259134;24632.87683561571;24678.876605616857;24717.752822471906;8749.300055995633;8839.911600884037;9144.771380715401;9266.860997085048;9304.488253146006;4957.355543779286;4985.376827896513;5011.6241281904;5014.07239660664;5117.155669314596;3653.488511608377;3747.8126093695205;3777.8111094445167;3778.962210377861;3791.867284645024;651.2714708295067;655.9212894452601;656.0094257670856;658.2265837640848;661.9503537234726;724.6304384763808;737.7749786315226;798.7723498802814;803.4135081390501;815.1115284339979;11031.2278140531;11240.943795280971;11352.772944541062;11489.138314626269;11580.247283926517;640.1294239833916;775.1163673412315;782.182619162976;793.484235247094;796;5117.820876269313;5120.590352771769;5148.665336753099;5160.612954028388;5399.811006614749;72644.54710905858;109521.45239273753;112157.43921280341;116764;117332.41333793447;100407;102382.48808755909;103496.48251758843;104627.47686261519;105340;90291;91285.54357228172;91303.5434822835;91451;93509;10239.48802559884;10259.179265658879;10363.32638378503;10429.478526073817;10453.425061621683;53578;54172;54377.456225437236;54451.72774136104;55060.07289744839;72573;79581.60209198917;79721.60139199266;80164;82147;13325.466981321026;13613.591592252249;13665.385057672229;13666.043376963516;13845.030847840957;14164.150150990974;14473.710525789214;14629;14641.414343426144;14900.403983840959;13206.471741130246;13225.867741322463;13281.67183281664;13516.5269215577;13688.657783555092;13322.740695217119;13739.656508587364;13904.235267060005;14172.574822755334;14318.642033949234;13398.531051413154;13537.729245415234;13676.452941882213;13727.794083088962;13993;11342.432878355885;11420.71448213768;11529.308241505536;11540.596079137189;11850;11367.943160284145;11674.533018679498;11720.589779357682;11761.942834299694;11810.881891181321 14:27:27 INFO - PROCESS | 3459 | __end_tp_report 14:27:27 INFO - PROCESS | 3459 | __start_cc_report 14:27:27 INFO - PROCESS | 3459 | _x_x_mozilla_cycle_collect,348 14:27:27 INFO - PROCESS | 3459 | __end_cc_report 14:27:27 INFO - PROCESS | 3459 | __startTimestamp1469827647805__endTimestamp 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | ------- Summary: start ------- 14:27:27 INFO - PROCESS | 3459 | Number of tests: 6 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#0] dojo.html Cycles:165 Average:5669.27 Median:5892.35 stddev:634.15 (10.8%) stddev-sans-first:609.67 14:27:27 INFO - PROCESS | 3459 | Values: 3360.1 3412.7 3432.0 3439.4 3446.9 5643.4 5653.2 5692.4 5695.4 5707.1 5714.5 5720.5 5726.0 5748.5 5771.3 5132.0 5175.5 5251.9 5289.7 5296.7 5069.3 5104.1 5278.6 5278.9 5300.2 5136.2 5143.6 5171.0 5177.4 5220.9 5157.5 5208.3 5236.2 5242.8 5267.0 5002.4 5040.9 5155.7 5207.7 5219.9 5438.6 5467.5 5468.5 5514.9 5563.1 6034.1 6079.5 6094.7 6115.8 6123.4 6000.2 6003.5 6117.9 6152.4 6189.9 5648.4 5721.6 5722.4 5731.4 5780.8 6205.1 6221.5 6230.1 6246.6 6247.9 5869.9 5871.5 5892.4 5982.6 6008.0 6091.9 6093.1 6099.5 6099.6 6125.7 5985.9 5988.5 6053.2 6054.4 6079.9 5832.9 5968.3 6038.1 6048.1 6070.4 4624.9 4641.6 4652.6 4654.1 4704.3 4192.8 4207.4 4209.1 4215.9 4240.0 5770.8 5879.5 5906.6 5949.1 6013.1 6067.3 6165.7 6168.0 6176.7 6230.3 5723.4 5902.8 5952.0 5963.1 6031.6 5097.3 5170.6 5177.7 5186.7 5222.9 6250.3 6344.7 6362.2 6404.6 6466.5 5892.4 6132.3 6145.3 6149.1 6150.3 6406.9 6421.2 6422.1 6480.7 6488.1 5995.6 6009.2 6038.2 6045.5 6076.5 5886.6 6036.9 6043.8 6182.5 6203.3 5879.9 5951.6 5985.2 6011.8 6012.2 5881.6 5891.8 5892.1 5928.3 5973.2 5662.5 5754.3 5800.6 5880.7 5902.3 5957.0 5977.3 6048.1 6048.8 6090.3 5855.3 5861.2 5908.5 5917.0 5923.2 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#1] ext.html Cycles:180 Average:62658.24 Median:43627.50 stddev:123319.55 (282.7%) stddev-sans-first:123577.47 14:27:27 INFO - PROCESS | 3459 | Values: 599.3 632.8 652.8 658.5 662.3 41345.0 44825.1 44893.6 44901.8 45289.8 45522.8 45821.5 46200.0 46333.8 46610.5 8969.3 9130.3 9167.1 9168.6 9171.1 9046.0 9050.8 9100.6 9109.8 9110.1 9155.5 9198.2 9206.6 9209.4 9211.2 9007.9 9054.9 9102.3 9120.6 9130.1 9046.2 9101.5 9113.6 9116.8 9124.4 43062.6 43249.6 43453.0 43623.0 43632.0 3958.3 3990.9 3994.9 4105.3 4238.2 33974.8 34107.7 34749.7 34778.7 34886.3 4122.2 4148.7 4170.1 4187.1 4206.5 333012.0 334771.0 336643.0 337243.0 339257.0 66546.3 66650.3 67268.0 67377.3 67412.0 38908.8 40680.0 40737.4 42252.0 42541.8 16763.4 16777.3 16893.0 16897.3 16915.8 11504.3 11512.8 11522.0 11548.5 11550.5 21235.0 21693.5 21724.5 21770.8 21824.0 7671.4 7692.6 7722.3 7790.7 7851.3 1077.8 1137.8 1162.9 1214.2 1260.3 33387.5 33795.5 33797.0 34147.0 34180.9 1187.4 1244.8 1256.7 1277.0 1309.4 17352.4 17948.9 17950.4 18143.1 18157.2 528863.0 568450.0 574795.0 576418.0 579769.0 59480.7 65508.7 66000.0 66058.0 66565.7 1500.8 1502.1 1514.5 1517.0 1533.1 33366.8 34191.0 34287.8 34289.7 34476.8 55376.2 55799.4 56352.7 56445.7 56660.7 458260.0 464825.0 464839.0 465728.0 465850.0 31340.1 31579.2 31592.0 31672.7 31728.2 49397.3 50911.2 51681.2 53376.7 54055.0 45134.0 45162.3 46843.3 47324.3 47330.0 42922.6 44347.0 44857.0 48369.8 48895.8 44010.3 44675.6 45193.3 47893.8 49549.0 37545.8 37744.8 38028.6 39526.4 39599.2 29891.4 29994.4 30307.5 30317.8 30799.5 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#2] jquery.html Cycles:180 Average:27742.15 Median:24274.76 stddev:74859.03 (308.4%) stddev-sans-first:75040.91 14:27:27 INFO - PROCESS | 3459 | Values: 414.2 420.6 422.7 424.2 432.1 18806.0 19673.1 20248.4 20976.5 21126.5 19771.8 19953.7 20082.2 20222.4 20631.9 5621.2 5883.5 5892.7 5919.1 5925.3 5776.6 5814.6 5814.8 5848.4 5858.9 5773.5 5776.1 5794.0 5811.7 5851.8 5516.5 5542.0 5776.5 5787.5 5809.2 5223.1 5229.0 5245.7 5249.3 5249.3 20702.6 24248.5 24301.0 24368.0 24655.0 2716.6 2770.2 2916.4 2966.6 2996.1 14315.4 14436.4 14516.1 15351.0 15559.7 2000.2 2006.2 2029.3 2063.5 2091.5 69746.3 74324.0 77909.6 79371.2 79829.0 11046.6 11202.8 11280.7 11432.8 11456.6 15666.1 15680.5 15767.1 15781.5 15790.1 8029.9 8065.6 8296.3 8304.3 8350.7 7704.0 7727.0 7793.7 7814.6 7846.9 6970.7 6989.4 7059.4 7104.1 7161.6 2001.1 2002.6 2051.7 2058.9 2120.2 980.3 1064.8 1098.8 1148.5 1166.3 19961.2 20060.0 20240.5 20298.0 20463.1 1085.7 1094.7 1143.3 1146.3 1154.7 10694.6 11545.0 11549.1 11616.8 11621.5 450082.0 451016.0 454874.0 457706.0 464650.0 79399.2 79824.6 80065.0 81373.0 81613.1 1108.1 1112.8 1114.1 1125.7 1150.5 17808.6 17879.2 18053.1 18113.4 18126.4 36928.6 37619.0 38044.0 38959.8 39053.2 52450.0 53179.0 53421.7 53632.2 53999.5 8907.7 9104.3 9314.9 9364.5 9367.4 13669.2 13806.2 14073.6 14143.5 14182.9 11024.4 11273.7 11385.4 11471.5 11504.9 11082.9 11141.8 11971.2 12013.0 12032.6 11393.3 11424.3 11445.5 11454.9 11873.5 7477.8 8176.3 8347.1 8425.3 8572.6 11308.7 11387.6 11439.4 11442.0 11624.4 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#3] mootools.html Cycles:180 Average:6128.02 Median:4872.38 stddev:3519.18 (72.2%) stddev-sans-first:3512.02 14:27:27 INFO - PROCESS | 3459 | Values: 1521.5 1577.5 1735.0 1856.9 1874.4 8369.5 8897.5 8923.9 9462.6 9478.8 8995.6 9297.5 9322.9 9343.9 9378.9 2405.5 2421.0 2440.9 2441.6 2442.5 2420.8 2421.7 2424.9 2438.7 2451.9 2409.1 2416.6 2427.3 2428.4 2434.4 2335.4 2344.5 2356.4 2368.9 2374.5 2314.0 2379.0 2395.2 2410.3 2429.0 9398.9 9467.3 9484.7 9519.1 9563.7 5550.5 5594.4 5643.0 5697.1 5714.8 3571.2 3652.7 3698.3 3714.3 3751.8 1212.9 1228.9 1252.1 1254.9 1268.4 13069.1 13078.9 13105.1 13206.0 13217.3 4758.5 4758.9 4864.9 4879.8 4887.0 10363.1 10393.9 10423.5 10429.1 10458.9 5568.7 5570.2 5577.7 5587.9 5605.9 4578.7 5025.5 5180.5 5195.8 5207.3 3904.6 4005.9 4010.5 4059.6 4145.7 1223.4 1225.4 1247.8 1258.6 1259.1 938.4 974.1 995.5 1022.4 1074.2 6064.9 6279.2 6312.7 6413.9 6553.1 498.9 506.5 513.2 515.5 523.9 4417.9 4456.6 4472.2 4484.7 4503.3 11242.4 11625.1 11669.9 11710.9 11716.5 11382.7 11440.7 11445.5 11502.7 11546.7 8320.7 8568.0 8628.3 8837.4 8884.0 6371.3 6565.5 6636.9 6714.7 6755.6 10619.8 10830.6 10913.7 10935.7 11072.7 10975.9 11010.3 11109.1 11183.4 11209.6 7791.3 8235.1 8292.0 8428.5 8551.8 9054.9 9114.2 9168.6 9226.6 9261.8 7744.5 7964.4 8364.2 8364.9 8387.6 7445.1 7548.7 7562.9 7908.8 8043.5 7223.5 7285.5 7335.0 7335.9 7465.7 5364.1 5383.1 5412.1 5471.9 5474.9 5590.4 5600.3 5635.7 5656.4 5661.5 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#4] prototype.html Cycles:180 Average:4857.02 Median:5410.81 stddev:1420.00 (26.2%) stddev-sans-first:1383.04 14:27:27 INFO - PROCESS | 3459 | Values: 346.5 350.7 350.9 353.0 355.3 5610.8 5729.1 5740.3 5756.8 5770.9 5634.3 5642.0 5643.9 5657.0 5673.1 4016.2 4101.5 4328.6 4369.2 4403.3 4407.0 4408.6 4419.4 4421.5 4426.0 4405.7 4415.0 4416.6 4424.0 4425.4 4153.0 4349.5 4377.7 4402.4 4452.5 3839.8 3840.6 3846.7 3851.0 3851.7 5417.5 5420.6 5433.1 5441.0 5469.5 4993.2 5025.2 5037.8 5055.9 5114.6 5841.3 5849.3 5891.3 5899.7 5929.2 4239.3 4270.2 4281.3 4294.2 4294.7 5984.3 6014.5 6103.6 6169.6 6237.7 4341.5 4349.7 4351.6 4356.4 4356.8 4371.8 4387.0 4391.9 4393.5 4427.7 4984.4 4987.2 4997.2 5029.9 5068.8 5890.6 5893.9 5919.4 5920.2 5945.6 1492.3 1500.4 1506.5 1506.6 1511.3 943.5 968.4 974.9 998.8 1000.8 5111.0 5149.6 5176.0 5181.8 5205.8 5362.0 5405.7 5443.8 5480.7 5516.4 4965.9 5112.5 5151.0 5184.8 5240.3 2869.8 2902.6 2908.3 2912.4 2953.6 5637.5 5719.0 5729.0 5734.9 5746.0 5272.7 5472.9 5487.7 5529.0 5614.9 5554.5 5658.8 5680.3 5715.5 5742.5 5107.7 5378.8 5404.5 5415.9 5456.4 5320.9 5346.1 5369.5 5386.2 5423.6 6264.5 6408.5 6411.9 6430.7 6466.2 4258.4 4363.0 4382.0 4389.9 4413.8 6114.8 6128.3 6193.8 6223.7 6253.9 6040.5 6055.2 6070.5 6075.6 6097.2 5995.9 5996.7 6020.3 6044.6 6096.1 5546.0 5904.4 5910.2 5911.8 5939.7 6030.5 6041.8 6046.7 6048.6 6049.7 5601.9 5823.0 5869.1 5880.4 5880.9 14:27:27 INFO - PROCESS | 3459 | 14:27:27 INFO - PROCESS | 3459 | [#5] yui.html Cycles:180 Average:21594.15 Median:3762.81 stddev:30467.13 (809.7%) stddev-sans-first:30512.55 14:27:27 INFO - PROCESS | 3459 | Values: 790.8 802.1 866.7 893.5 901.0 15291.1 16371.8 16685.3 16937.9 16963.3 15321.9 15583.4 15604.5 15616.1 15725.4 717.5 842.6 854.5 858.5 860.1 861.2 861.3 866.7 871.6 873.3 897.9 904.0 909.1 914.3 918.5 895.4 896.3 902.4 908.5 908.8 663.3 666.5 669.5 670.1 672.2 15626.3 15655.0 15694.7 15720.4 15757.8 15894.2 16320.7 16502.3 16504.3 16752.7 11979.3 12146.3 12456.3 12890.3 13364.5 4008.1 4028.7 4055.8 4119.2 4120.9 81077.2 82146.0 82241.2 82968.6 83233.0 11485.4 11878.8 11927.7 12086.2 12104.0 24066.8 24414.4 24632.9 24678.9 24717.8 8749.3 8839.9 9144.8 9266.9 9304.5 4957.4 4985.4 5011.6 5014.1 5117.2 3653.5 3747.8 3777.8 3779.0 3791.9 651.3 655.9 656.0 658.2 662.0 724.6 737.8 798.8 803.4 815.1 11031.2 11240.9 11352.8 11489.1 11580.2 640.1 775.1 782.2 793.5 796.0 5117.8 5120.6 5148.7 5160.6 5399.8 72644.5 109521.5 112157.4 116764.0 117332.4 100407.0 102382.5 103496.5 104627.5 105340.0 90291.0 91285.5 91303.5 91451.0 93509.0 10239.5 10259.2 10363.3 10429.5 10453.4 53578.0 54172.0 54377.5 54451.7 55060.1 72573.0 79581.6 79721.6 80164.0 82147.0 13325.5 13613.6 13665.4 13666.0 13845.0 14164.2 14473.7 14629.0 14641.4 14900.4 13206.5 13225.9 13281.7 13516.5 13688.7 13322.7 13739.7 13904.2 14172.6 14318.6 13398.5 13537.7 13676.5 13727.8 13993.0 11342.4 11420.7 11529.3 11540.6 11850.0 11367.9 11674.5 11720.6 11761.9 11810.9 14:27:27 INFO - PROCESS | 3459 | -------- Summary: end -------- 14:27:27 INFO - PROCESS | 3459 | 14:27:28 INFO - TEST-INFO | 3459: exit 0 14:27:28 INFO - TEST-OK | dromaeo_css | took 1113302ms 14:27:28 INFO - TEST-START | kraken 14:27:28 INFO - operating with platform_type : linux_ 14:27:28 INFO - Initialising browser for kraken test... 14:27:28 INFO - TEST-INFO | started process 3700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWEKcfk/profile http://localhost:44032/getInfo.html) 14:27:33 INFO - PROCESS | 3700 | __metrics Screen width/height:1600/1200 14:27:33 INFO - PROCESS | 3700 | colorDepth:24 14:27:33 INFO - PROCESS | 3700 | Browser inner width/height: 1024/697 14:27:33 INFO - PROCESS | 3700 | __metrics 14:27:33 ERROR - PROCESS | 3700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:27:34 INFO - TEST-INFO | 3700: exit 0 14:27:34 INFO - Browser initialized. 14:27:34 INFO - Running cycle 1/1 for kraken test... 14:27:34 INFO - TEST-INFO | started process 3829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWEKcfk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:46 INFO - PROCESS | 3829 | RSS: Main: 156217344 14:27:46 INFO - PROCESS | 3829 | 14:27:49 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44032/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:49 INFO - PROCESS | 3829 | RSS: Main: 161378304 14:27:49 INFO - PROCESS | 3829 | 14:27:52 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44032/tests/kraken/driver.html?testName=audio-dft) 14:27:53 INFO - PROCESS | 3829 | RSS: Main: 160714752 14:27:53 INFO - PROCESS | 3829 | 14:27:56 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44032/tests/kraken/driver.html?testName=audio-fft) 14:27:56 INFO - PROCESS | 3829 | RSS: Main: 161906688 14:27:56 INFO - PROCESS | 3829 | 14:27:58 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44032/tests/kraken/driver.html?testName=audio-oscillator) 14:27:59 INFO - PROCESS | 3829 | RSS: Main: 161091584 14:27:59 INFO - PROCESS | 3829 | 14:28:01 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:02 INFO - PROCESS | 3829 | RSS: Main: 161140736 14:28:02 INFO - PROCESS | 3829 | 14:28:05 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44032/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:06 INFO - PROCESS | 3829 | RSS: Main: 160976896 14:28:06 INFO - PROCESS | 3829 | 14:28:09 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44032/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:10 INFO - PROCESS | 3829 | RSS: Main: 161239040 14:28:10 INFO - PROCESS | 3829 | 14:28:12 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44032/tests/kraken/driver.html?testName=json-parse-financial) 14:28:13 INFO - PROCESS | 3829 | RSS: Main: 161427456 14:28:13 INFO - PROCESS | 3829 | 14:28:15 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:15 INFO - PROCESS | 3829 | RSS: Main: 161341440 14:28:15 INFO - PROCESS | 3829 | 14:28:17 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:18 INFO - PROCESS | 3829 | RSS: Main: 161562624 14:28:18 INFO - PROCESS | 3829 | 14:28:20 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:20 INFO - PROCESS | 3829 | RSS: Main: 161447936 14:28:20 INFO - PROCESS | 3829 | 14:28:23 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:23 INFO - PROCESS | 3829 | RSS: Main: 161624064 14:28:23 INFO - PROCESS | 3829 | 14:28:26 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:27 INFO - PROCESS | 3829 | RSS: Main: 161468416 14:28:27 INFO - PROCESS | 3829 | 14:28:28 INFO - PROCESS | 3829 | Cycle 1(1): loaded http://localhost:44032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44032/tests/kraken/driver.html?testName=ai-astar) 14:28:29 INFO - PROCESS | 3829 | RSS: Main: 162201600 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | __start_tp_report 14:28:29 INFO - PROCESS | 3829 | _x_x_mozilla_page_load 14:28:29 INFO - PROCESS | 3829 | _x_x_mozilla_page_load_details 14:28:29 INFO - PROCESS | 3829 | |i|pagename|runs| 14:28:29 INFO - PROCESS | 3829 | |0;ai-astar;114;106;111;111;112;115;111;111;114;112 14:28:29 INFO - PROCESS | 3829 | |1;audio-beat-detection;156;127;160;182;130;150;154;128;181;143 14:28:29 INFO - PROCESS | 3829 | |2;audio-dft;163;165;162;166;164;162;164;162;161;162 14:28:29 INFO - PROCESS | 3829 | |3;audio-fft;76;77;76;170;76;76;76;76;178;75 14:28:29 INFO - PROCESS | 3829 | |4;audio-oscillator;89;86;155;87;85;84;138;85;85;142 14:28:29 INFO - PROCESS | 3829 | |5;imaging-gaussian-blur;118;118;118;122;117;119;118;118;118;117 14:28:29 INFO - PROCESS | 3829 | |6;imaging-darkroom;147;148;147;147;151;147;149;148;148;147 14:28:29 INFO - PROCESS | 3829 | |7;imaging-desaturate;95;95;97;96;96;96;95;98;96;97 14:28:29 INFO - PROCESS | 3829 | |8;json-parse-financial;52;57;52;52;53;55;55;53;52;56 14:28:29 INFO - PROCESS | 3829 | |9;json-stringify-tinderbox;60;60;59;61;61;59;60;60;61;61 14:28:29 INFO - PROCESS | 3829 | |10;stanford-crypto-aes;77;77;83;85;85;78;78;80;102;78 14:28:29 INFO - PROCESS | 3829 | |11;stanford-crypto-ccm;125;122;130;119;117;139;124;136;127;120 14:28:29 INFO - PROCESS | 3829 | |12;stanford-crypto-pbkdf2;156;155;155;153;156;162;155;153;151;166 14:28:29 INFO - PROCESS | 3829 | |13;stanford-crypto-sha256-iterative;63;65;65;68;66;63;62;67;62;62 14:28:29 INFO - PROCESS | 3829 | __end_tp_report 14:28:29 INFO - PROCESS | 3829 | __start_cc_report 14:28:29 INFO - PROCESS | 3829 | _x_x_mozilla_cycle_collect,891 14:28:29 INFO - PROCESS | 3829 | __end_cc_report 14:28:29 INFO - PROCESS | 3829 | __startTimestamp1469827709237__endTimestamp 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | ------- Summary: start ------- 14:28:29 INFO - PROCESS | 3829 | Number of tests: 14 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:2.51 14:28:29 INFO - PROCESS | 3829 | Values: 114.0 106.0 111.0 111.0 112.0 115.0 111.0 111.0 114.0 112.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.00 stddev:19.96 (12.9%) stddev-sans-first:21.10 14:28:29 INFO - PROCESS | 3829 | Values: 156.0 127.0 160.0 182.0 130.0 150.0 154.0 128.0 181.0 143.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.60 (1.0%) stddev-sans-first:1.69 14:28:29 INFO - PROCESS | 3829 | Values: 163.0 165.0 162.0 166.0 164.0 162.0 164.0 162.0 161.0 162.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.37 (54.4%) stddev-sans-first:43.26 14:28:29 INFO - PROCESS | 3829 | Values: 76.0 77.0 76.0 170.0 76.0 76.0 76.0 76.0 178.0 75.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:28.91 (34.0%) stddev-sans-first:30.17 14:28:29 INFO - PROCESS | 3829 | Values: 89.0 86.0 155.0 87.0 85.0 84.0 138.0 85.0 85.0 142.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 14:28:29 INFO - PROCESS | 3829 | Values: 118.0 118.0 118.0 122.0 117.0 119.0 118.0 118.0 118.0 117.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 14:28:29 INFO - PROCESS | 3829 | Values: 147.0 148.0 147.0 147.0 151.0 147.0 149.0 148.0 148.0 147.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:0.97 14:28:29 INFO - PROCESS | 3829 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 95.0 98.0 96.0 97.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.89 (3.5%) stddev-sans-first:1.90 14:28:29 INFO - PROCESS | 3829 | Values: 52.0 57.0 52.0 52.0 53.0 55.0 55.0 53.0 52.0 56.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 14:28:29 INFO - PROCESS | 3829 | Values: 60.0 60.0 59.0 61.0 61.0 59.0 60.0 60.0 61.0 61.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:79.00 stddev:7.60 (9.6%) stddev-sans-first:7.82 14:28:29 INFO - PROCESS | 3829 | Values: 77.0 77.0 83.0 85.0 85.0 78.0 78.0 80.0 102.0 78.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.00 stddev:7.25 (5.8%) stddev-sans-first:7.68 14:28:29 INFO - PROCESS | 3829 | Values: 125.0 122.0 130.0 119.0 117.0 139.0 124.0 136.0 127.0 120.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:155.50 stddev:4.49 (2.9%) stddev-sans-first:4.76 14:28:29 INFO - PROCESS | 3829 | Values: 156.0 155.0 155.0 153.0 156.0 162.0 155.0 153.0 151.0 166.0 14:28:29 INFO - PROCESS | 3829 | 14:28:29 INFO - PROCESS | 3829 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:2.21 (3.4%) stddev-sans-first:2.30 14:28:29 INFO - PROCESS | 3829 | Values: 63.0 65.0 65.0 68.0 66.0 63.0 62.0 67.0 62.0 62.0 14:28:29 INFO - PROCESS | 3829 | -------- Summary: end -------- 14:28:29 INFO - PROCESS | 3829 | 14:28:30 INFO - TEST-INFO | 3829: exit 0 14:28:30 INFO - TEST-OK | kraken | took 61692ms 14:28:30 INFO - SUITE-END | took 1174s 14:28:30 INFO - Completed test suite (00:19:35) 14:28:30 INFO - javascript benchmark 14:28:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7603.193997798616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.1263671445427, 3412.744044196683, 3432.0218737659757, 3439.380911435942, 3446.896593102206, 5643.379228284891, 5653.208550802891, 5692.402297758737, 5695.373508914021, 5707.115397113444, 5714.542836573075, 5720.485156335929, 5725.971370143144, 5748.453896879801, 5771.307443106823, 5131.974340128303, 5175.456577059392, 5251.86870328241, 5289.735513224343, 5296.655717378358, 5069.340985671876, 5104.106781313274, 5278.577713782907, 5278.947210527884, 5300.231466437364, 5136.152534831748, 5143.639945203819, 5171.0, 5177.378714554259, 5220.92168617471, 5157.48425157485, 5208.2968799212, 5236.240745091978, 5242.7640756166065, 5266.973665131688, 5002.449730529639, 5040.949590504085, 5155.742212889378, 5207.6615020023955, 5219.921701174486, 5438.640339915021, 5467.4532546745, 5468.507834294933, 5514.944850551483, 5563.054280772279, 6034.125051867499, 6079.544034197453, 6094.725737341831, 6115.755369785204, 6123.4488895999575, 6000.219971403733, 6003.459688628044, 6117.908231376488, 6152.3540028297275, 6189.938100619026, 5648.406917273668, 5721.628094173949, 5722.399148089432, 5731.398203188647, 5780.7687692492245, 6205.100260462208, 6221.471174950089, 6230.065490176419, 6246.625202487774, 6247.875042499125, 5869.911951320733, 5871.500922421556, 5892.381299963527, 5982.551308651869, 6007.969960150259, 6091.908621370683, 6093.146959425684, 6099.451049405486, 6099.634021958696, 6125.663088530085, 5985.9401405986255, 5988.461038506555, 6053.182820319289, 6054.424829641177, 6079.905616988985, 5832.912506312408, 5968.313643930916, 6038.064100064497, 6048.092786082035, 6070.423309785563, 4624.861254162381, 4641.559051890065, 4652.604528615038, 4654.115718013567, 4704.341392205094, 4192.790360481964, 4207.410962465257, 4209.095044565433, 4215.852445164404, 4239.97880010598, 5770.826875193751, 5879.470847623735, 5906.5570082244, 5949.137375080676, 6013.067974463877, 6067.332593414721, 6165.691715414301, 6168.0439531872635, 6176.722047507873, 6230.345813689588, 5723.399043100415, 5902.763889444374, 5952.007645328415, 5963.135345374896, 6031.577789554689, 5097.286379906816, 5170.638055336166, 5177.7152256625495, 5186.662866913714, 5222.92165617516, 6250.281217659936, 6344.714487848058, 6362.204724409449, 6404.647744374011, 6466.482681385478, 5892.351841297368, 6132.324915438508, 6145.293291271561, 6149.108379285068, 6150.261968563801, 6406.942854428967, 6421.197350331208, 6422.100905873088, 6480.708368123352, 6488.124103246001, 5995.5803093783015, 6009.2188015557695, 6038.215032045806, 6045.455908968214, 6076.54425918049, 5886.646801191942, 6036.879262414815, 6043.7884674036195, 6182.505399568114, 6203.348648392034, 5879.911801323069, 5951.583389162717, 5985.191999080069, 6011.819645410645, 6012.218411606638, 5881.617694849821, 5891.764329426775, 5892.1161825726485, 5928.34788173292, 5973.223480947449, 5662.490375866192, 5754.280714910637, 5800.622959507618, 5880.735366908585, 5902.2622172228475, 5956.970215148896, 5977.3424923257535, 6048.123022161674, 6048.788292409745, 6090.299615544269, 5855.268091488564, 5861.179434879035, 5908.497777688773, 5917.0, 5923.170756094237], "value": 5628.019328246747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.3257585216631, 632.7722020072775, 652.8302641313257, 658.5028303630758, 662.2516556291391, 41345.0, 44825.10349793006, 44893.551064489344, 44901.7754911225, 45289.77355113224, 45522.77238613811, 45821.54178458214, 46200.0, 46333.768331158295, 46610.53389466104, 8969.282457403424, 9130.26957843371, 9167.12912273333, 9168.633254669838, 9171.128742769459, 9045.954770226173, 9050.818983620356, 9100.590473428712, 9109.772255693628, 9110.088991100904, 9155.496447695374, 9198.218151457135, 9206.585703643352, 9209.355345125843, 9211.217046551052, 9007.909920900773, 9054.868141482282, 9102.271818254523, 9120.635174593042, 9130.086991300883, 9046.185843274072, 9101.544922753903, 9113.589888455035, 9116.772080697969, 9124.361294709373, 43062.56937430617, 43249.56750432487, 43453.0, 43623.0, 43632.0, 3958.3072962231495, 3990.86031988879, 3994.900127496836, 4105.3020986432375, 4238.237117318881, 33974.830125849214, 34107.658923410694, 34749.65250347515, 34778.65221347779, 34886.30227395438, 4122.175564887035, 4148.730332528376, 4170.082581831992, 4187.120704652027, 4206.47419072616, 333012.0, 334771.0, 336643.0, 337242.99999999756, 339257.0, 66546.33453665498, 66650.33349666442, 67268.0, 67377.32622673809, 67412.0, 38908.8054559731, 40680.0, 40737.38893916594, 42252.0, 42541.787291063345, 16763.413280535122, 16777.328906843835, 16893.0, 16897.32410703558, 16915.830841691673, 11504.309741415542, 11512.76974460506, 11522.0, 11548.480318385693, 11550.480228389742, 21235.0, 21693.457663558223, 21724.45688857791, 21770.78229217719, 21824.0, 7671.3862890968585, 7692.615369231516, 7722.266384693445, 7790.688372465038, 7851.332636725828, 1077.7736675298274, 1137.8350139229765, 1162.9476673549711, 1214.2107630040543, 1260.294235228275, 33387.49918751221, 33795.493067604, 33797.0, 34147.0, 34180.92278364086, 1187.3588262338412, 1244.7510497900457, 1256.654420034498, 1276.974460510803, 1309.4238535044549, 17352.392666256874, 17948.910255448638, 17950.371736989404, 18143.092845357678, 18157.182926768328, 528863.0, 568450.0, 574795.0, 576418.0, 579769.0, 59480.70259648674, 65508.672456638364, 66000.0, 66058.0, 66565.66717166384, 1500.8123984501938, 1502.1212590634602, 1514.5002149290708, 1517.0278637770855, 1533.1337794146273, 33366.83316583402, 34191.0, 34287.82856085704, 34289.657103428646, 34476.82761586276, 55376.169357458864, 55799.442005579425, 56352.74589016393, 56445.71777141088, 56660.71669641625, 458260.0, 464825.0, 464839.0, 465728.0, 465850.0, 31340.05979820609, 31579.21051973719, 31592.0, 31672.683273166975, 31728.206794830316, 49397.25904111369, 50911.236331455795, 51681.224781629055, 53376.73311633417, 54055.0, 45134.0, 45162.322565162205, 46843.29735053909, 47324.2901356473, 47330.0, 42922.570774293104, 44347.0, 44857.0, 48369.75815120902, 48895.75552122216, 44010.33984490171, 44675.55324446714, 45193.32210016918, 47893.76053119712, 49549.0, 37545.81227093847, 37744.811275943444, 38028.61971380251, 39526.40710389404, 39599.2080158401, 29891.402171956874, 29994.400111998075, 30307.545386818776, 30317.848410757804, 30799.538006929466], "value": 21155.974939378575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.2440046914382, 420.5626148805243, 422.6555357383732, 424.15169660678635, 432.1357285429142, 18806.0, 19673.11470983804, 20248.392548223557, 20976.475588110305, 21126.471838204052, 19771.802281977176, 19953.700694489595, 20082.196712131532, 20222.39332820014, 20631.896840515776, 5621.156826476031, 5883.47048765611, 5892.705364731746, 5919.052951527757, 5925.34821169671, 5776.624519406225, 5814.622049566786, 5814.8255552333285, 5848.385919478457, 5858.941410585882, 5773.509251713609, 5776.104703770901, 5793.971030144864, 5811.709414529278, 5851.79518716845, 5516.531094856942, 5542.0, 5776.537876969833, 5787.47912687858, 5809.215755872945, 5223.08595995703, 5229.0, 5245.659032162897, 5249.265102885599, 5249.317588713481, 20702.5859482811, 24248.515029699483, 24301.0, 24368.0, 24655.0, 2716.5653495440833, 2770.224337185591, 2916.402137561795, 2966.5550167474835, 2996.056242283674, 14315.42738290467, 14436.350364233635, 14516.05645633041, 15351.0, 15559.688806223812, 2000.2099170827441, 2006.1975209916004, 2029.2998915374171, 2063.5253891605016, 2091.4980404702915, 69746.30253697449, 74324.0, 77909.61045194794, 79371.20628793696, 79829.0, 11046.558137674403, 11202.831957520644, 11280.717982050515, 11432.771344573062, 11456.599019034295, 15666.138362390178, 15680.529584112495, 15767.132807695687, 15781.526554203392, 15790.131542765028, 8029.91596134526, 8065.556394398247, 8296.336293096538, 8304.252617264476, 8350.707725229588, 7703.961480192564, 7727.0, 7793.688252469951, 7814.6092695365005, 7846.9215307847335, 6970.686319115652, 6989.405900498413, 7059.399951004119, 7104.147502299757, 7161.606111663804, 2001.109506269696, 2002.6495363311362, 2051.7435320584927, 2058.8970551472366, 2120.2155202575145, 980.294188184506, 1064.776396956648, 1098.752780624369, 1148.4831825678477, 1166.276908316832, 19961.20155193805, 20060.0, 20240.493987650425, 20298.0, 20463.07916143777, 1085.7068591480256, 1094.6661268313082, 1143.2683082826998, 1146.2549342927164, 1154.653603918821, 10694.572217111385, 11545.0, 11549.13381496391, 11616.767664646659, 11621.53513859453, 450082.0, 451016.0, 454874.0, 457706.0, 464650.0, 79399.20600793918, 79824.60087699525, 80065.0, 81373.0, 81613.143539977, 1108.1135091926426, 1112.8497652816927, 1114.1421105748366, 1125.7241975716001, 1150.5225331487507, 17808.55478613045, 17879.19543620566, 18053.097345132428, 18113.36603218881, 18126.365577204735, 36928.63071369252, 37619.0, 38044.007835105556, 38959.80520097382, 39053.21893562056, 52450.0, 53179.0, 53421.73289133685, 53632.195517066495, 53999.46000539944, 8907.688230911886, 9104.271658267191, 9314.906850931675, 9364.531773411167, 9367.391119577205, 13669.179849209078, 13806.17162970225, 14073.577792666236, 14143.504977325743, 14182.929085354508, 11024.44877756125, 11273.71815704614, 11385.373804440504, 11471.541138354372, 11504.884951150381, 11082.944585277022, 11141.832872506757, 11971.162018658959, 12012.978896793871, 12032.578859739868, 11393.316401015965, 11424.314541127558, 11445.48495317696, 11454.911783380565, 11873.465694043962, 7477.813054673677, 8176.345892328718, 8347.081820999807, 8425.257885635841, 8572.614232359434, 11308.717282068013, 11387.601433949772, 11439.370834604177, 11442.0, 11624.360660163773], "value": 9567.791816881658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.53593154088, 1577.5188567486916, 1734.9913250433747, 1856.8885866847982, 1874.4095609882886, 8369.539675317856, 8897.466152030875, 8923.91076089239, 9462.574184161704, 9478.76303092423, 8995.59519821608, 9297.488638124918, 9322.86015709765, 9343.859842102374, 9378.906210937888, 2405.518896220754, 2421.0315873650593, 2440.9023639054503, 2441.5727247731666, 2442.511497700458, 2420.782129608335, 2421.685180926477, 2424.903003879843, 2438.6829712137396, 2451.8528888266674, 2409.0965887792077, 2416.601260791976, 2427.320350301918, 2428.441458464554, 2434.4400787818813, 2335.4394945213025, 2344.531093781242, 2356.3991182248587, 2368.857868527894, 2374.501354715503, 2314.0396735354807, 2378.9643155352683, 2395.245497668229, 2410.2769169249154, 2428.9514209715885, 9398.859017114748, 9467.337286389955, 9484.668036618754, 9519.095685909828, 9563.665271715456, 5550.500454959033, 5594.412586678422, 5643.0, 5697.0599851024535, 5714.828555143353, 3571.2143328467696, 3652.726045546568, 3698.33429982603, 3714.275716235335, 3751.8311675974646, 1212.8605210400829, 1228.8525376954822, 1252.0922331309728, 1254.91215614907, 1268.3721557828842, 13069.08516403852, 13078.869211307956, 13105.082644214908, 13206.0, 13217.33913304331, 4758.476567577563, 4758.912529086631, 4864.927026094611, 4879.829205977774, 4886.951130488721, 10363.11913487347, 10393.9480302598, 10423.478826058667, 10429.113525350278, 10458.895411045944, 5568.693721845257, 5570.192322113271, 5577.693226872561, 5587.8603034923635, 5605.887882242332, 4578.748168850679, 5025.497450254945, 5180.533751962342, 5195.818146364859, 5207.3490813648295, 3904.648581627667, 4005.8798236052967, 4010.458588090629, 4059.6143366380147, 4145.689073319513, 1223.431104536377, 1225.436299302313, 1247.7754004279136, 1258.6224132760135, 1259.1437822280755, 938.3712912348743, 974.1135566634329, 995.4823491784232, 1022.3559157730582, 1074.2168001118107, 6064.9090263646085, 6279.246490421178, 6312.70465453569, 6413.903791443132, 6553.148090748267, 498.86780003299157, 506.5441103007323, 513.2429666242338, 515.5411683601598, 523.8847453560211, 4417.911641767147, 4456.64346852251, 4472.217361961643, 4484.663650226181, 4503.279475284005, 11242.437878106226, 11625.069994400428, 11669.88330116688, 11710.94144529272, 11716.472758725708, 11382.658520244406, 11440.656780296604, 11445.542178312775, 11502.712432189262, 11546.653600392001, 8320.70877519296, 8567.957160214159, 8628.309735221168, 8837.381383303107, 8884.0, 6371.299157092809, 6565.540412171103, 6636.867262654623, 6714.6978385973725, 6755.628440435823, 10619.840702389625, 10830.566777328819, 10913.727156821144, 10935.671929842118, 11072.667819965414, 10975.890241097806, 11010.339379637247, 11109.055730263019, 11183.384913829492, 11209.607663731731, 7791.298783109547, 8235.052968908652, 8292.0, 8428.4942903426, 8551.786205344915, 9054.864177037218, 9114.225290850352, 9168.587413566538, 9226.584803683985, 9261.768455788659, 7744.4578879477895, 7964.402669799672, 8364.163583641588, 8364.87452688198, 8387.580620969049, 7445.143808462096, 7548.66031028616, 7562.924370756222, 7908.802279943047, 8043.517388956681, 7223.530470519399, 7285.526440781332, 7335.0, 7335.8532829344185, 7465.664045118091, 5364.141737322166, 5383.0579648562125, 5412.052890744026, 5471.863203419946, 5474.945250547444, 5590.440955904377, 5600.271964644733, 5635.718214089361, 5656.377798442086, 5661.46216109469], "value": 4813.954902595617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4595231438955, 350.6791285973334, 350.8824543777834, 352.96823285904264, 355.2646022732944, 5610.80362187323, 5729.106801065462, 5740.282464691913, 5756.769729210827, 5770.913436298459, 5634.253381451753, 5642.0, 5643.943560564393, 5656.971715141429, 5673.099511663598, 4016.2168377166463, 4101.487314085739, 4328.63206627437, 4369.169857727037, 4403.3394990751485, 4407.0, 4408.581184787457, 4419.381286619876, 4421.491528474218, 4425.959899423633, 4405.691601587891, 4415.028693687384, 4416.646668266531, 4424.048829501657, 4425.380446737459, 4152.97923510382, 4349.521552629209, 4377.715448495837, 4402.40567523385, 4452.487963884146, 3839.808009599537, 3840.6351396617556, 3846.6922646188236, 3851.0, 3851.6533511983775, 5417.4808713947805, 5420.620556561043, 5433.1035379162395, 5441.047816632074, 5469.453054694539, 4993.226049962262, 5025.1959686450355, 5037.773300201499, 5055.887704704959, 5114.616403769732, 5841.312996021835, 5849.298084229919, 5891.293044834604, 5899.734511946973, 5929.169916211734, 4239.283090348414, 4270.167317373113, 4281.272183728774, 4294.248506511348, 4294.733053749152, 5984.281886173643, 6014.488768454687, 6103.572749907508, 6169.568130230886, 6237.719302631393, 4341.479022517255, 4349.695521313541, 4351.5848703969605, 4356.433663623772, 4356.782160892006, 4371.803268852909, 4386.956130438719, 4391.890202744893, 4393.450818647669, 4427.690061695715, 4984.40187177541, 4987.202047672427, 4997.2015671224235, 5029.949700503022, 5068.797248110108, 5890.587658863924, 5893.911591326134, 5919.4080591940465, 5920.2007728956905, 5945.583809133319, 1492.276246020679, 1500.4148382130759, 1506.49532406645, 1506.5932198306396, 1511.2594828533938, 943.4858002388714, 968.3899143539525, 974.9415035097917, 998.8351921932945, 1000.7948370584013, 5110.97444512775, 5149.562287205555, 5176.0, 5181.792728290826, 5205.839576575754, 5362.0, 5405.675659460445, 5443.8094666686475, 5480.725963701799, 5516.365617953907, 4965.851024469272, 5112.488751124858, 5150.97424512875, 5184.844454666366, 5240.266362709223, 2869.8421586812924, 2902.6081479000063, 2908.258394109531, 2912.402957393729, 2953.586497890297, 5637.520810731134, 5719.0, 5728.971355143198, 5734.942650573525, 5745.971270143623, 5272.683638981596, 5472.890542189134, 5487.670739755627, 5528.954286913787, 5614.9157762633595, 5554.50009499147, 5658.773649054074, 5680.318361796693, 5715.457031581993, 5742.511886489611, 5107.650480778735, 5378.838634840961, 5404.459554044564, 5415.945840541702, 5456.372517160418, 5320.866978325418, 5346.091164501966, 5369.523381070081, 5386.245925570502, 5423.620346575702, 6264.530160238091, 6408.455281300955, 6411.935880641134, 6430.710618022294, 6466.224053113657, 4258.446401967724, 4362.956370436382, 4382.014046839436, 4389.934150987674, 4413.801378938019, 6114.816555503342, 6128.325884152829, 6193.783217587363, 6223.657698826608, 6253.874922501615, 6040.516758659384, 6055.182550355646, 6070.453659170696, 6075.635461872302, 6097.237845269341, 5995.850103747442, 5996.67018313997, 6020.2842189975645, 6044.607100538451, 6096.146539484387, 5545.972270138624, 5904.380040095728, 5910.231669882888, 5911.763529458945, 5939.673317967553, 6030.547708921761, 6041.818745437644, 6046.697665116814, 6048.60684055535, 6049.697515124314, 5601.887962240651, 5822.951868663681, 5869.119632055226, 5880.353161152356, 5880.852978675567], "value": 4405.812585560527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.7943934577008, 802.1417083720418, 866.7356456280834, 893.5487578772719, 900.9729708108757, 15291.082535047892, 16371.754423683655, 16685.33258669653, 16937.915310423446, 16963.32146714133, 15321.923390383032, 15583.376664933417, 15604.45384411543, 15616.141112238822, 15725.37098516058, 717.5407739047014, 842.5787106446777, 854.4659587757651, 858.527809704663, 860.0539406652695, 861.2076889261895, 861.2507118806647, 866.7183165471215, 871.6077765005741, 873.2882700599023, 897.8742975983367, 903.9502827344494, 909.0863681999581, 914.3416739947261, 918.531548910054, 895.3508706188027, 896.332232486795, 902.4359775140537, 908.4503875155502, 908.7955210077713, 663.2869665109978, 666.4668265387719, 669.4543946683438, 670.1321788284183, 672.1765836849869, 15626.296816643278, 15655.0, 15694.686106277924, 15720.37118515258, 15757.763633545506, 15894.217572056585, 16320.67358652832, 16502.33990640385, 16504.25730842103, 16752.748708769377, 11979.341136237503, 12146.271223726604, 12456.31490268035, 12890.291033993126, 13364.465421383133, 4008.118213992917, 4028.697847661437, 4055.7566546007333, 4119.237940980898, 4120.876373708794, 81077.18922810814, 82146.0, 82241.17758822395, 82968.58515707383, 83233.0, 11485.425728713531, 11878.762424751456, 11927.701807454883, 12086.214396064228, 12104.0, 24066.7593324068, 24414.389640259134, 24632.87683561571, 24678.876605616857, 24717.752822471906, 8749.300055995633, 8839.911600884037, 9144.771380715401, 9266.860997085048, 9304.488253146006, 4957.355543779286, 4985.376827896513, 5011.6241281904, 5014.07239660664, 5117.155669314596, 3653.488511608377, 3747.8126093695205, 3777.8111094445167, 3778.962210377861, 3791.867284645024, 651.2714708295067, 655.9212894452601, 656.0094257670856, 658.2265837640848, 661.9503537234726, 724.6304384763808, 737.7749786315226, 798.7723498802814, 803.4135081390501, 815.1115284339979, 11031.2278140531, 11240.943795280971, 11352.772944541062, 11489.138314626269, 11580.247283926517, 640.1294239833916, 775.1163673412315, 782.182619162976, 793.484235247094, 796.0, 5117.820876269313, 5120.590352771769, 5148.665336753099, 5160.612954028388, 5399.811006614749, 72644.54710905858, 109521.45239273753, 112157.43921280341, 116764.0, 117332.41333793447, 100407.0, 102382.48808755909, 103496.48251758843, 104627.47686261519, 105340.0, 90291.0, 91285.54357228172, 91303.5434822835, 91451.0, 93509.0, 10239.48802559884, 10259.179265658879, 10363.32638378503, 10429.478526073817, 10453.425061621683, 53578.0, 54172.0, 54377.456225437236, 54451.72774136104, 55060.07289744839, 72573.0, 79581.60209198917, 79721.60139199266, 80164.0, 82147.0, 13325.466981321026, 13613.591592252249, 13665.385057672229, 13666.043376963516, 13845.030847840957, 14164.150150990974, 14473.710525789214, 14629.0, 14641.414343426144, 14900.403983840959, 13206.471741130246, 13225.867741322463, 13281.67183281664, 13516.5269215577, 13688.657783555092, 13322.740695217119, 13739.656508587364, 13904.235267060005, 14172.574822755334, 14318.642033949234, 13398.531051413154, 13537.729245415234, 13676.452941882213, 13727.794083088962, 13993.0, 11342.432878355885, 11420.71448213768, 11529.308241505536, 11540.596079137189, 11850.0, 11367.943160284145, 11674.533018679498, 11720.589779357682, 11761.942834299694, 11810.881891181321], "value": 7994.744459347689, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 111.0, 111.0, 112.0, 115.0, 111.0, 111.0, 114.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 160.0, 182.0, 130.0, 150.0, 154.0, 128.0, 181.0, 143.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 166.0, 164.0, 162.0, 164.0, 162.0, 161.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 170.0, 76.0, 76.0, 76.0, 76.0, 178.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 155.0, 87.0, 85.0, 84.0, 138.0, 85.0, 85.0, 142.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 122.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 151.0, 147.0, 149.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 98.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 52.0, 52.0, 53.0, 55.0, 55.0, 53.0, 52.0, 56.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 61.0, 59.0, 60.0, 60.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 83.0, 85.0, 85.0, 78.0, 78.0, 80.0, 102.0, 78.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 130.0, 119.0, 117.0, 139.0, 124.0, 136.0, 127.0, 120.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 155.0, 153.0, 156.0, 162.0, 155.0, 153.0, 151.0, 166.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 68.0, 66.0, 63.0, 62.0, 67.0, 62.0, 62.0], "value": 64.3, "unit": "score"}]}]} 14:28:30 INFO - Return code: 0 14:28:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:30 ERROR - # TBPL SUCCESS # 14:28:30 INFO - Running post-action listener: _resource_record_post_action 14:28:30 INFO - ##### 14:28:30 INFO - ##### Finished run-tests step (success) 14:28:30 INFO - ##### 14:28:30 INFO - Running post-run listener: _resource_record_post_run 14:28:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7995392; Write bytes: 492306432; Read time: 1676; Write time: 429484 14:28:30 INFO - TinderboxPrint: CPU usage
13.5% 14:28:30 INFO - TinderboxPrint: I/O read bytes / time
7,995,392 / 1,676 14:28:30 INFO - TinderboxPrint: I/O write bytes / time
492,306,432 / 429,484 14:28:30 INFO - TinderboxPrint: CPU idle
8,234.6 (86.5%) 14:28:30 INFO - TinderboxPrint: CPU user
1,218.3 (12.8%) 14:28:30 INFO - TinderboxPrint: Swap in / out
0 / 0 14:28:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84463616; Read time: 0; Write time: 81336 14:28:30 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6234112; Write bytes: 407842816; Read time: 1632; Write time: 348148 14:28:31 INFO - Running post-run listener: _upload_blobber_files 14:28:31 INFO - Blob upload gear active. 14:28:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:31 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 14:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:28:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:28:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:32 INFO - (blobuploader) - INFO - Done attempting. 14:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:36 INFO - (blobuploader) - INFO - Done attempting. 14:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:36 INFO - (blobuploader) - INFO - Done attempting. 14:28:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:36 INFO - Return code: 0 14:28:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa07cfacb96cd4fd09358f01986423f0c22d9d68691143dcaa6de050c885e65e9956bffc4d8888cc7bd91fa306039d1d7823fb903b0f5feec3a60ac84f9e490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf243491b9b3ddcbd751818bdf2b9d31f7ca35546bd07d2b4108ce6b5a0375d4713ad3c32fb6fb6fa9aabed5b19b224aa10d809aeda8e4a23712c63d03d7b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f9e7a758f3f52536c1b376bc84f972eea8f0544ff86688959067ef30fc6f411cc0c3c61047104f6389b11df2d9ee298174d801b28f61dd809da2b263681a0e"} 14:28:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:36 INFO - Contents: 14:28:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa07cfacb96cd4fd09358f01986423f0c22d9d68691143dcaa6de050c885e65e9956bffc4d8888cc7bd91fa306039d1d7823fb903b0f5feec3a60ac84f9e490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf243491b9b3ddcbd751818bdf2b9d31f7ca35546bd07d2b4108ce6b5a0375d4713ad3c32fb6fb6fa9aabed5b19b224aa10d809aeda8e4a23712c63d03d7b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f9e7a758f3f52536c1b376bc84f972eea8f0544ff86688959067ef30fc6f411cc0c3c61047104f6389b11df2d9ee298174d801b28f61dd809da2b263681a0e"} 14:28:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:36 INFO - Copying logs to upload dir... 14:28:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.133124 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-29 14:28:37.144557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 14:28:37.147722) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 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/Mozilla-Aurora/sha512/caa07cfacb96cd4fd09358f01986423f0c22d9d68691143dcaa6de050c885e65e9956bffc4d8888cc7bd91fa306039d1d7823fb903b0f5feec3a60ac84f9e490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf243491b9b3ddcbd751818bdf2b9d31f7ca35546bd07d2b4108ce6b5a0375d4713ad3c32fb6fb6fa9aabed5b19b224aa10d809aeda8e4a23712c63d03d7b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f9e7a758f3f52536c1b376bc84f972eea8f0544ff86688959067ef30fc6f411cc0c3c61047104f6389b11df2d9ee298174d801b28f61dd809da2b263681a0e"} build_url:https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/I2-ZRzh2SKux3BrCl_U8Wg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caa07cfacb96cd4fd09358f01986423f0c22d9d68691143dcaa6de050c885e65e9956bffc4d8888cc7bd91fa306039d1d7823fb903b0f5feec3a60ac84f9e490", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5bf243491b9b3ddcbd751818bdf2b9d31f7ca35546bd07d2b4108ce6b5a0375d4713ad3c32fb6fb6fa9aabed5b19b224aa10d809aeda8e4a23712c63d03d7b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00f9e7a758f3f52536c1b376bc84f972eea8f0544ff86688959067ef30fc6f411cc0c3c61047104f6389b11df2d9ee298174d801b28f61dd809da2b263681a0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 14:28:37.172211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:28:37.172596) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469826472.133113-1132534966 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 14:28:37.222207) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 14:28:37.222597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 14:28:37.222891) ========= ========= Total master_lag: 0.30 =========