builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1462963446.88 results: success (0) buildid: 20160510170209 builduid: 8ec55d59aa8b4e91b360aca0ab4b190b revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:06.884851) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:06.885571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:06.885918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:06.903730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:06.904300) ========= 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=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 03:44:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-05-11 03:44:07 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099828 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.018791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.019140) ========= 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=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018824 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.069832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.070348) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --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=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 03:44:07,141 truncating revision to first 12 chars 2016-05-11 03:44:07,141 Setting DEBUG logging. 2016-05-11 03:44:07,141 attempt 1/10 2016-05-11 03:44:07,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f6940851d82d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 03:44:07,400 unpacking tar archive at: mozilla-beta-f6940851d82d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.638043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.638517) ========= script_repo_revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.639160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.639641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:44:07.652307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-11 03:44:07.652911) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:07 INFO - MultiFileLogger online at 20160511 03:44:07 in /builds/slave/test 03:44:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:44:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:07 INFO - {'append_to_log': False, 03:44:07 INFO - 'base_work_dir': '/builds/slave/test', 03:44:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:44:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:07 INFO - 'branch': 'Mozilla-Beta', 03:44:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:07 INFO - 'config_files': ('talos/linux_config.py',), 03:44:07 INFO - 'default_actions': ('clobber', 03:44:07 INFO - 'read-buildbot-config', 03:44:07 INFO - 'download-and-extract', 03:44:07 INFO - 'populate-webroot', 03:44:07 INFO - 'create-virtualenv', 03:44:07 INFO - 'install', 03:44:07 INFO - 'run-tests'), 03:44:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:07 INFO - 'download_minidump_stackwalk': True, 03:44:07 INFO - 'download_symbols': 'ondemand', 03:44:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:07 INFO - 'installer_path': 'installer.exe', 03:44:07 INFO - 'log_level': 'info', 03:44:07 INFO - 'log_name': 'talos', 03:44:07 INFO - 'log_to_console': True, 03:44:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:07 INFO - 'opt_config_files': (), 03:44:07 INFO - 'pip_index': False, 03:44:07 INFO - 'sps_profile': False, 03:44:07 INFO - 'sps_profile_interval': 0, 03:44:07 INFO - 'suite': 'dromaeojs', 03:44:07 INFO - 'system_bits': '32', 03:44:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:07 INFO - 'title': 'talos-linux64-ix-016', 03:44:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:07 INFO - 'use_talos_json': True, 03:44:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:07 INFO - 'work_dir': 'build'} 03:44:07 INFO - ##### 03:44:07 INFO - ##### Running clobber step. 03:44:07 INFO - ##### 03:44:07 INFO - Running pre-action listener: _resource_record_pre_action 03:44:07 INFO - Running main action method: clobber 03:44:07 INFO - rmtree: /builds/slave/test/build 03:44:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:08 INFO - Running post-action listener: _resource_record_post_action 03:44:08 INFO - ##### 03:44:08 INFO - ##### Running read-buildbot-config step. 03:44:08 INFO - ##### 03:44:08 INFO - Running pre-action listener: _resource_record_pre_action 03:44:08 INFO - Running main action method: read_buildbot_config 03:44:08 INFO - Using buildbot properties: 03:44:08 INFO - { 03:44:08 INFO - "project": "", 03:44:08 INFO - "product": "firefox", 03:44:08 INFO - "script_repo_revision": "production", 03:44:08 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 03:44:08 INFO - "repository": "", 03:44:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 03:44:08 INFO - "buildid": "20160510170209", 03:44:08 INFO - "pgo_build": "True", 03:44:08 INFO - "basedir": "/builds/slave/test", 03:44:08 INFO - "buildnumber": 86, 03:44:08 INFO - "slavename": "talos-linux64-ix-016", 03:44:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:44:08 INFO - "platform": "ubuntu64_hw", 03:44:08 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:44:08 INFO - "branch": "mozilla-beta", 03:44:08 INFO - "repo_path": "releases/mozilla-beta", 03:44:08 INFO - "revision": "f6940851d82da2fb15ab510cff1a8e0c9ce6a49b", 03:44:08 INFO - "stage_platform": "linux64-pgo", 03:44:08 INFO - "builduid": "8ec55d59aa8b4e91b360aca0ab4b190b", 03:44:08 INFO - "slavebuilddir": "test" 03:44:08 INFO - } 03:44:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 03:44:08 INFO - Running post-action listener: _resource_record_post_action 03:44:08 INFO - ##### 03:44:08 INFO - ##### Running download-and-extract step. 03:44:08 INFO - ##### 03:44:08 INFO - Running pre-action listener: _resource_record_pre_action 03:44:08 INFO - Running main action method: download_and_extract 03:44:08 INFO - mkdir: /builds/slave/test/build/tests 03:44: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')]} 03:44:08 INFO - https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:44:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:44:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:09 INFO - Downloaded 1412 bytes. 03:44:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 03:44:09 INFO - Using the following test package requirements: 03:44:09 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:44:09 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:09 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 03:44:09 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'jsshell-linux-x86_64.zip'], 03:44:09 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:09 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:44:09 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 03:44:09 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 03:44:09 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:09 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 03:44:09 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 03:44:09 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:09 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:09 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')]} 03:44:09 INFO - https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:10 INFO - Downloaded 23365081 bytes. 03:44:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:11 INFO - Return code: 0 03:44:11 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:11 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')]} 03:44:11 INFO - https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 03:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:13 INFO - Downloaded 23365081 bytes. 03:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:14 INFO - Return code: 0 03:44: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')]} 03:44:14 INFO - https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 03:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:15 INFO - Downloaded 10845194 bytes. 03:44:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:15 INFO - Return code: 0 03:44:15 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')]} 03:44:15 INFO - https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:44:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:44:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:44:16 INFO - Downloaded 53798485 bytes. 03:44:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:44:16 INFO - mkdir: /builds/slave/test/properties 03:44:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:16 INFO - Contents: 03:44:16 INFO - build_url:https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 03:44:17 INFO - Running post-action listener: _resource_record_post_action 03:44:17 INFO - Running post-action listener: set_extra_try_arguments 03:44:17 INFO - ##### 03:44:17 INFO - ##### Running populate-webroot step. 03:44:17 INFO - ##### 03:44:17 INFO - Running pre-action listener: _resource_record_pre_action 03:44:17 INFO - Running main action method: populate_webroot 03:44:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:17 INFO - '--tppagecycles', 03:44:17 INFO - '7'], 03:44:17 INFO - 'tests': ['tsvgm']}}, 03:44:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:44:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:44:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'tests': ['damp', 'tps']}, 03:44:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['damp', 'tps']}, 03:44:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:44:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:17 INFO - 'other': {'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'other_l64': {'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'other_nol64': {'tests': ['a11yr', 03:44:17 INFO - 'ts_paint', 03:44:17 INFO - 'tpaint', 03:44:17 INFO - 'sessionrestore', 03:44:17 INFO - 'sessionrestore_no_auto_restore', 03:44:17 INFO - 'tabpaint']}, 03:44:17 INFO - 'svgr': {'tests': ['tsvgx', 03:44:17 INFO - 'tsvgr_opacity', 03:44:17 INFO - 'tart', 03:44:17 INFO - 'tscrollx', 03:44:17 INFO - 'cart']}, 03:44:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['tsvgx', 03:44:17 INFO - 'tsvgr_opacity', 03:44:17 INFO - 'tart', 03:44:17 INFO - 'tscrollx', 03:44:17 INFO - 'cart']}, 03:44:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'tests': ['tp5o']}, 03:44:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'talos_options': ['--e10s'], 03:44:17 INFO - 'tests': ['tp5o']}, 03:44:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'talos_options': ['--xperf_path', 03:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:17 INFO - 'tests': ['tp5n']}, 03:44:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:17 INFO - 'talos_options': ['--e10s', 03:44:17 INFO - '--xperf_path', 03:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:17 INFO - 'tests': ['tp5n']}}, 03:44:17 INFO - 'talos.zip': {'path': '', 03:44:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:17 INFO - Running post-action listener: _resource_record_post_action 03:44:17 INFO - ##### 03:44:17 INFO - ##### Running create-virtualenv step. 03:44:17 INFO - ##### 03:44:17 INFO - Running pre-action listener: _resource_record_pre_action 03:44:17 INFO - Running main action method: create_virtualenv 03:44:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:17 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 03:44:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:17 INFO - Using real prefix '/usr' 03:44:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:20 INFO - Installing pip.................done. 03:44:20 INFO - Return code: 0 03:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44: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', 'pip>=1.5'] in /builds/slave/test/build 03:44: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 pip>=1.5 03:44:20 INFO - Using env: {'DISPLAY': ':0', 03:44:20 INFO - 'HOME': '/home/cltbld', 03:44:20 INFO - 'LANG': 'en_US.UTF-8', 03:44:20 INFO - 'LANGUAGE': 'en_US:en', 03:44:20 INFO - 'LOGNAME': 'cltbld', 03:44:20 INFO - 'MAIL': '/var/mail/cltbld', 03:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:20 INFO - 'MOZ_NO_REMOTE': '1', 03:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:20 INFO - 'NO_EM_RESTART': '1', 03:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:20 INFO - 'PWD': '/builds/slave/test', 03:44:20 INFO - 'SHELL': '/bin/bash', 03:44:20 INFO - 'SHLVL': '1', 03:44:20 INFO - 'TERM': 'linux', 03:44:20 INFO - 'TMOUT': '86400', 03:44:20 INFO - 'USER': 'cltbld', 03:44:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:20 INFO - '_': '/tools/buildbot/bin/python'} 03:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:20 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 03:44:20 INFO - Cleaning up... 03:44:20 INFO - Return code: 0 03:44:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:44: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 psutil>=0.7.1 03:44:20 INFO - Using env: {'DISPLAY': ':0', 03:44:20 INFO - 'HOME': '/home/cltbld', 03:44:20 INFO - 'LANG': 'en_US.UTF-8', 03:44:20 INFO - 'LANGUAGE': 'en_US:en', 03:44:20 INFO - 'LOGNAME': 'cltbld', 03:44:20 INFO - 'MAIL': '/var/mail/cltbld', 03:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:20 INFO - 'MOZ_NO_REMOTE': '1', 03:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:20 INFO - 'NO_EM_RESTART': '1', 03:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:20 INFO - 'PWD': '/builds/slave/test', 03:44:20 INFO - 'SHELL': '/bin/bash', 03:44:20 INFO - 'SHLVL': '1', 03:44:20 INFO - 'TERM': 'linux', 03:44:20 INFO - 'TMOUT': '86400', 03:44:20 INFO - 'USER': 'cltbld', 03:44:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:20 INFO - '_': '/tools/buildbot/bin/python'} 03:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:20 INFO - Downloading/unpacking psutil>=0.7.1 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:22 INFO - Installing collected packages: psutil 03:44:22 INFO - Running setup.py install for psutil 03:44:22 INFO - building 'psutil._psutil_linux' extension 03:44:22 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 03:44:22 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 03:44:22 INFO - building 'psutil._psutil_posix' extension 03:44:22 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 03:44:23 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 03:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:23 INFO - Successfully installed psutil 03:44:23 INFO - Cleaning up... 03:44:23 INFO - Return code: 0 03:44:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:44: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 mozsystemmonitor==0.0.0 03:44:23 INFO - Using env: {'DISPLAY': ':0', 03:44:23 INFO - 'HOME': '/home/cltbld', 03:44:23 INFO - 'LANG': 'en_US.UTF-8', 03:44:23 INFO - 'LANGUAGE': 'en_US:en', 03:44:23 INFO - 'LOGNAME': 'cltbld', 03:44:23 INFO - 'MAIL': '/var/mail/cltbld', 03:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:23 INFO - 'MOZ_NO_REMOTE': '1', 03:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:23 INFO - 'NO_EM_RESTART': '1', 03:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:23 INFO - 'PWD': '/builds/slave/test', 03:44:23 INFO - 'SHELL': '/bin/bash', 03:44:23 INFO - 'SHLVL': '1', 03:44:23 INFO - 'TERM': 'linux', 03:44:23 INFO - 'TMOUT': '86400', 03:44:23 INFO - 'USER': 'cltbld', 03:44:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:23 INFO - '_': '/tools/buildbot/bin/python'} 03:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:44:25 INFO - Installing collected packages: mozsystemmonitor 03:44:25 INFO - Running setup.py install for mozsystemmonitor 03:44:25 INFO - Successfully installed mozsystemmonitor 03:44:25 INFO - Cleaning up... 03:44:25 INFO - Return code: 0 03:44:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:25 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')]} 03:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 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')]} 03:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:25 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:25 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 03:44:25 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 03:44:25 INFO - Using env: {'DISPLAY': ':0', 03:44:25 INFO - 'HOME': '/home/cltbld', 03:44:25 INFO - 'LANG': 'en_US.UTF-8', 03:44:25 INFO - 'LANGUAGE': 'en_US:en', 03:44:25 INFO - 'LOGNAME': 'cltbld', 03:44:25 INFO - 'MAIL': '/var/mail/cltbld', 03:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:25 INFO - 'MOZ_NO_REMOTE': '1', 03:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:25 INFO - 'NO_EM_RESTART': '1', 03:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:25 INFO - 'PWD': '/builds/slave/test', 03:44:25 INFO - 'SHELL': '/bin/bash', 03:44:25 INFO - 'SHLVL': '1', 03:44:25 INFO - 'TERM': 'linux', 03:44:25 INFO - 'TMOUT': '86400', 03:44:25 INFO - 'USER': 'cltbld', 03:44:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:25 INFO - '_': '/tools/buildbot/bin/python'} 03:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:27 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 03:44:27 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 03:44:27 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 03:44:27 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 03:44:27 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 03:44:27 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 03:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:28 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 03:44:28 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 03:44:28 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 03:44:28 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 03:44:28 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 03:44:28 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 03:44:28 INFO - Downloading docopt-0.6.1.tar.gz 03:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:28 INFO - Running setup.py install for blobuploader 03:44:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:28 INFO - Running setup.py install for requests 03:44:28 INFO - Running setup.py install for docopt 03:44:28 INFO - Successfully installed blobuploader requests docopt 03:44:28 INFO - Cleaning up... 03:44:28 INFO - Return code: 0 03:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:28 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')]} 03:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:28 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')]} 03:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:28 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:28 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 03:44:28 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 03:44:28 INFO - Using env: {'DISPLAY': ':0', 03:44:28 INFO - 'HOME': '/home/cltbld', 03:44:28 INFO - 'LANG': 'en_US.UTF-8', 03:44:28 INFO - 'LANGUAGE': 'en_US:en', 03:44:28 INFO - 'LOGNAME': 'cltbld', 03:44:28 INFO - 'MAIL': '/var/mail/cltbld', 03:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:28 INFO - 'MOZ_NO_REMOTE': '1', 03:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:28 INFO - 'NO_EM_RESTART': '1', 03:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:28 INFO - 'PWD': '/builds/slave/test', 03:44:28 INFO - 'SHELL': '/bin/bash', 03:44:28 INFO - 'SHLVL': '1', 03:44:28 INFO - 'TERM': 'linux', 03:44:28 INFO - 'TMOUT': '86400', 03:44:28 INFO - 'USER': 'cltbld', 03:44:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:28 INFO - '_': '/tools/buildbot/bin/python'} 03:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:29 INFO - Running setup.py (path:/tmp/pip-X7E7IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:29 INFO - Running setup.py (path:/tmp/pip-7BmQdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:29 INFO - Running setup.py (path:/tmp/pip-C0Tcs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:29 INFO - Running setup.py (path:/tmp/pip-svuYIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:29 INFO - Running setup.py (path:/tmp/pip-AGgqwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:29 INFO - Running setup.py (path:/tmp/pip-o_jx5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:29 INFO - Running setup.py (path:/tmp/pip-aA1AID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:29 INFO - Running setup.py (path:/tmp/pip-82eOHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:29 INFO - Running setup.py (path:/tmp/pip-lRQjce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:29 INFO - Running setup.py (path:/tmp/pip-J0k7uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:29 INFO - Running setup.py (path:/tmp/pip-ON3WC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:29 INFO - Running setup.py (path:/tmp/pip-Hf10Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:30 INFO - Running setup.py (path:/tmp/pip-LnLxN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:30 INFO - Running setup.py (path:/tmp/pip-0KEjR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:30 INFO - Running setup.py (path:/tmp/pip-w2VIN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:30 INFO - Running setup.py (path:/tmp/pip-dHrX_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:30 INFO - Running setup.py (path:/tmp/pip-djLt0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:30 INFO - Running setup.py install for manifestparser 03:44:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:30 INFO - Running setup.py install for mozcrash 03:44:30 INFO - Running setup.py install for mozdebug 03:44:30 INFO - Running setup.py install for mozdevice 03:44:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:44:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:30 INFO - Running setup.py install for mozfile 03:44:30 INFO - Running setup.py install for mozhttpd 03:44:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozinfo 03:44:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozInstall 03:44:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozleak 03:44:31 INFO - Running setup.py install for mozlog 03:44:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for moznetwork 03:44:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozprocess 03:44:31 INFO - Running setup.py install for mozprofile 03:44:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozrunner 03:44:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:31 INFO - Running setup.py install for mozscreenshot 03:44:31 INFO - Running setup.py install for moztest 03:44:32 INFO - Running setup.py install for mozversion 03:44:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:32 INFO - Cleaning up... 03:44:32 INFO - Return code: 0 03:44:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:32 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:32 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 03:44:32 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 03:44:32 INFO - Using env: {'DISPLAY': ':0', 03:44:32 INFO - 'HOME': '/home/cltbld', 03:44:32 INFO - 'LANG': 'en_US.UTF-8', 03:44:32 INFO - 'LANGUAGE': 'en_US:en', 03:44:32 INFO - 'LOGNAME': 'cltbld', 03:44:32 INFO - 'MAIL': '/var/mail/cltbld', 03:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:32 INFO - 'MOZ_NO_REMOTE': '1', 03:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:32 INFO - 'NO_EM_RESTART': '1', 03:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:32 INFO - 'PWD': '/builds/slave/test', 03:44:32 INFO - 'SHELL': '/bin/bash', 03:44:32 INFO - 'SHLVL': '1', 03:44:32 INFO - 'TERM': 'linux', 03:44:32 INFO - 'TMOUT': '86400', 03:44:32 INFO - 'USER': 'cltbld', 03:44:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:32 INFO - '_': '/tools/buildbot/bin/python'} 03:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:32 INFO - Running setup.py (path:/tmp/pip-erp9CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:32 INFO - Running setup.py (path:/tmp/pip-Ku_5W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:32 INFO - Running setup.py (path:/tmp/pip-ZvEltX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:32 INFO - Running setup.py (path:/tmp/pip-pbkZK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:32 INFO - Running setup.py (path:/tmp/pip-wFN2fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:32 INFO - Running setup.py (path:/tmp/pip-IPq9DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:32 INFO - Running setup.py (path:/tmp/pip-Jh4tXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:32 INFO - Running setup.py (path:/tmp/pip-xORL3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:32 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)) 03:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:32 INFO - Running setup.py (path:/tmp/pip-5sHlfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:33 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:33 INFO - Running setup.py (path:/tmp/pip-o9YphE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:33 INFO - Running setup.py (path:/tmp/pip-hI3L7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:33 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:33 INFO - Running setup.py (path:/tmp/pip-ACNf8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:33 INFO - Running setup.py (path:/tmp/pip-lOWFlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:33 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:33 INFO - Running setup.py (path:/tmp/pip-iOHMBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:33 INFO - Running setup.py (path:/tmp/pip-EAIRg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:33 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:33 INFO - Running setup.py (path:/tmp/pip-CV52z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:33 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)) 03:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:33 INFO - Running setup.py (path:/tmp/pip-GKzb0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:33 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)) 03:44:33 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)) 03:44:33 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)) 03:44:33 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)) 03:44:33 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)) 03:44:33 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)) 03:44:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:33 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 03:44:35 INFO - Downloading blessings-1.6.tar.gz 03:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:35 INFO - Installing collected packages: blessings 03:44:35 INFO - Running setup.py install for blessings 03:44:35 INFO - Successfully installed blessings 03:44:35 INFO - Cleaning up... 03:44:35 INFO - Return code: 0 03:44:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:35 INFO - Reading from file tmpfile_stdout 03:44:35 INFO - Current package versions: 03:44:35 INFO - argparse == 1.2.1 03:44:35 INFO - blessings == 1.6 03:44:35 INFO - blobuploader == 1.2.4 03:44:35 INFO - docopt == 0.6.1 03:44:35 INFO - manifestparser == 1.1 03:44:35 INFO - mozInstall == 1.12 03:44:35 INFO - mozcrash == 0.17 03:44:35 INFO - mozdebug == 0.1 03:44:35 INFO - mozdevice == 0.48 03:44:35 INFO - mozfile == 1.2 03:44:35 INFO - mozhttpd == 0.7 03:44:35 INFO - mozinfo == 0.9 03:44:35 INFO - mozleak == 0.1 03:44:35 INFO - mozlog == 3.1 03:44:35 INFO - moznetwork == 0.27 03:44:35 INFO - mozprocess == 0.22 03:44:35 INFO - mozprofile == 0.28 03:44:35 INFO - mozrunner == 6.11 03:44:35 INFO - mozscreenshot == 0.1 03:44:35 INFO - mozsystemmonitor == 0.0 03:44:35 INFO - moztest == 0.7 03:44:35 INFO - mozversion == 1.4 03:44:35 INFO - psutil == 3.1.1 03:44:35 INFO - requests == 1.2.3 03:44:35 INFO - wsgiref == 0.1.2 03:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:35 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')]} 03:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:35 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')]} 03:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:35 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:35 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 03:44:35 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 03:44:35 INFO - Using env: {'DISPLAY': ':0', 03:44:35 INFO - 'HOME': '/home/cltbld', 03:44:35 INFO - 'LANG': 'en_US.UTF-8', 03:44:35 INFO - 'LANGUAGE': 'en_US:en', 03:44:35 INFO - 'LOGNAME': 'cltbld', 03:44:35 INFO - 'MAIL': '/var/mail/cltbld', 03:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:35 INFO - 'MOZ_NO_REMOTE': '1', 03:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:35 INFO - 'NO_EM_RESTART': '1', 03:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:35 INFO - 'PWD': '/builds/slave/test', 03:44:35 INFO - 'SHELL': '/bin/bash', 03:44:35 INFO - 'SHLVL': '1', 03:44:35 INFO - 'TERM': 'linux', 03:44:35 INFO - 'TMOUT': '86400', 03:44:35 INFO - 'USER': 'cltbld', 03:44:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:35 INFO - '_': '/tools/buildbot/bin/python'} 03:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 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)) 03:44:36 INFO - Cleaning up... 03:44:36 INFO - Return code: 0 03:44:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:36 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')]} 03:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:36 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')]} 03:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:36 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:36 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 03:44:36 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 03:44:36 INFO - Using env: {'DISPLAY': ':0', 03:44:36 INFO - 'HOME': '/home/cltbld', 03:44:36 INFO - 'LANG': 'en_US.UTF-8', 03:44:36 INFO - 'LANGUAGE': 'en_US:en', 03:44:36 INFO - 'LOGNAME': 'cltbld', 03:44:36 INFO - 'MAIL': '/var/mail/cltbld', 03:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:36 INFO - 'MOZ_NO_REMOTE': '1', 03:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:36 INFO - 'NO_EM_RESTART': '1', 03:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:36 INFO - 'PWD': '/builds/slave/test', 03:44:36 INFO - 'SHELL': '/bin/bash', 03:44:36 INFO - 'SHLVL': '1', 03:44:36 INFO - 'TERM': 'linux', 03:44:36 INFO - 'TMOUT': '86400', 03:44:36 INFO - 'USER': 'cltbld', 03:44:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:36 INFO - '_': '/tools/buildbot/bin/python'} 03:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:36 INFO - Downloading/unpacking jsonschema 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:38 INFO - Downloading/unpacking functools32 (from jsonschema) 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:38 INFO - warning: no files found matching '*.txt' 03:44:38 INFO - no previously-included directories found matching 'build' 03:44:38 INFO - no previously-included directories found matching 'dist' 03:44:38 INFO - no previously-included directories found matching '.git*' 03:44:38 INFO - Installing collected packages: jsonschema, functools32 03:44:38 INFO - Running setup.py install for functools32 03:44:38 INFO - warning: no files found matching '*.txt' 03:44:38 INFO - no previously-included directories found matching 'build' 03:44:38 INFO - no previously-included directories found matching 'dist' 03:44:38 INFO - no previously-included directories found matching '.git*' 03:44:38 INFO - Successfully installed jsonschema functools32 03:44:38 INFO - Cleaning up... 03:44:38 INFO - Return code: 0 03:44:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:38 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 0x7f20971c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe95410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, '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': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', '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 03:44:38 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 03:44:38 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 03:44:38 INFO - Using env: {'DISPLAY': ':0', 03:44:38 INFO - 'HOME': '/home/cltbld', 03:44:38 INFO - 'LANG': 'en_US.UTF-8', 03:44:38 INFO - 'LANGUAGE': 'en_US:en', 03:44:38 INFO - 'LOGNAME': 'cltbld', 03:44:38 INFO - 'MAIL': '/var/mail/cltbld', 03:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:38 INFO - 'MOZ_NO_REMOTE': '1', 03:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:38 INFO - 'NO_EM_RESTART': '1', 03:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:38 INFO - 'PWD': '/builds/slave/test', 03:44:38 INFO - 'SHELL': '/bin/bash', 03:44:38 INFO - 'SHLVL': '1', 03:44:38 INFO - 'TERM': 'linux', 03:44:38 INFO - 'TMOUT': '86400', 03:44:38 INFO - 'USER': 'cltbld', 03:44:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:38 INFO - '_': '/tools/buildbot/bin/python'} 03:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:38 INFO - Downloading/unpacking flake8 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:38 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 03:44:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:44:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:44:40 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 03:44:40 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 03:44:40 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 03:44:40 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 03:44:40 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 03:44:40 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 03:44:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:44:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 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 03:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:41 INFO - no previously-included directories found matching 'docs/_build' 03:44:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:44:41 INFO - Running setup.py install for pep8 03:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:44:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:44:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:44:41 INFO - no previously-included directories found matching 'docs/_build' 03:44:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:44:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:44:41 INFO - Cleaning up... 03:44:41 INFO - Return code: 0 03:44:41 INFO - Running post-action listener: _resource_record_post_action 03:44:41 INFO - Running post-action listener: _start_resource_monitoring 03:44:41 INFO - Starting resource monitoring. 03:44:41 INFO - ##### 03:44:41 INFO - ##### Running install step. 03:44:41 INFO - ##### 03:44:41 INFO - Running pre-action listener: _resource_record_pre_action 03:44:41 INFO - Running main action method: install 03:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:42 INFO - Reading from file tmpfile_stdout 03:44:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:42 INFO - Reading from file tmpfile_stdout 03:44:42 INFO - Output received: 03:44:42 INFO - Usage: mozinstall [options] installer 03:44:42 INFO - Options: 03:44:42 INFO - -h, --help show this help message and exit 03:44:42 INFO - -d DEST, --destination=DEST 03:44:42 INFO - Directory to install application into. [default: 03:44:42 INFO - "/builds/slave/test"] 03:44:42 INFO - --app=APP Application being installed. [default: firefox] 03:44:42 INFO - mkdir: /builds/slave/test/build/application 03:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:44:54 INFO - Reading from file tmpfile_stdout 03:44:54 INFO - Output received: 03:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:54 INFO - Running post-action listener: _resource_record_post_action 03:44:54 INFO - ##### 03:44:54 INFO - ##### Running run-tests step. 03:44:54 INFO - ##### 03:44:54 INFO - Running pre-action listener: _resource_record_pre_action 03:44:54 INFO - Running main action method: run_tests 03:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:54 INFO - Python 2.7.3 03:44:54 INFO - Return code: 0 03:44:54 INFO - grabbing minidump binary from tooltool 03:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:44:54 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf24160>, '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 0xf25060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf254f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:54 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 03:44:54 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 03:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:54 INFO - Return code: 0 03:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:44:55 INFO - Return code: 0 03:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:44:55 INFO - Using env: {'DISPLAY': ':0', 03:44:55 INFO - 'HOME': '/home/cltbld', 03:44:55 INFO - 'LANG': 'en_US.UTF-8', 03:44:55 INFO - 'LANGUAGE': 'en_US:en', 03:44:55 INFO - 'LOGNAME': 'cltbld', 03:44:55 INFO - 'MAIL': '/var/mail/cltbld', 03:44:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:55 INFO - 'MOZ_NO_REMOTE': '1', 03:44:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:55 INFO - 'NO_EM_RESTART': '1', 03:44:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:55 INFO - 'PWD': '/builds/slave/test', 03:44:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:55 INFO - 'SHELL': '/bin/bash', 03:44:55 INFO - 'SHLVL': '1', 03:44:55 INFO - 'TERM': 'linux', 03:44:55 INFO - 'TMOUT': '86400', 03:44:55 INFO - 'USER': 'cltbld', 03:44:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462963445.830103-876461673', 03:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:55 INFO - '_': '/tools/buildbot/bin/python'} 03:44:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:44:56 INFO - mozversion application_buildid: 20160510170209 03:44:56 INFO - mozversion application_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:44:56 INFO - mozversion application_display_name: Firefox 03:44:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:56 INFO - mozversion application_name: Firefox 03:44:56 INFO - mozversion application_remotingname: firefox 03:44:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:56 INFO - mozversion application_vendor: Mozilla 03:44:56 INFO - mozversion application_version: 47.0 03:44:56 INFO - mozversion platform_buildid: 20160510170209 03:44:56 INFO - mozversion platform_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:44:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:44:56 INFO - mozversion platform_version: 47.0 03:44:56 INFO - using testdate: 1462963496 03:44:56 INFO - actual date: 1462963496 03:44:56 INFO - starting webserver on 'localhost:52810' 03:44:56 INFO - SUITE-START | Running 2 tests 03:44:56 INFO - TEST-START | dromaeo_css 03:44:56 INFO - operating with platform_type : linux_ 03:44:56 INFO - Initialising browser for dromaeo_css test... 03:44:56 INFO - TEST-INFO | started process 16642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXhMHZ/profile http://localhost:52810/getInfo.html) 03:45:00 INFO - PROCESS | 16642 | __metrics Screen width/height:1600/1200 03:45:00 INFO - PROCESS | 16642 | colorDepth:24 03:45:00 INFO - PROCESS | 16642 | Browser inner width/height: 1024/697 03:45:00 INFO - PROCESS | 16642 | __metrics 03:45:01 INFO - PROCESS | 16642 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:02 INFO - TEST-INFO | 16642: exit 0 03:45:02 INFO - Browser initialized. 03:45:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:02 INFO - TEST-INFO | started process 16732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXhMHZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:14 INFO - PROCESS | 16732 | RSS: Main: 139091968 03:45:14 INFO - PROCESS | 16732 | 03:46:04 INFO - PROCESS | 16732 | 1462963564796 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] 03:48:12 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52810/tests/dromaeo/cssquery-ext.html) 03:48:13 INFO - PROCESS | 16732 | RSS: Main: 240119808 03:48:13 INFO - PROCESS | 16732 | 03:51:15 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-ext.html (next: http://localhost:52810/tests/dromaeo/cssquery-jquery.html) 03:51:16 INFO - PROCESS | 16732 | RSS: Main: 216772608 03:51:16 INFO - PROCESS | 16732 | 03:54:17 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52810/tests/dromaeo/cssquery-mootools.html) 03:54:18 INFO - PROCESS | 16732 | RSS: Main: 220921856 03:54:18 INFO - PROCESS | 16732 | 03:57:20 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52810/tests/dromaeo/cssquery-prototype.html) 03:57:20 INFO - PROCESS | 16732 | RSS: Main: 205115392 03:57:20 INFO - PROCESS | 16732 | 04:00:23 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52810/tests/dromaeo/cssquery-yui.html) 04:00:23 INFO - PROCESS | 16732 | RSS: Main: 204554240 04:00:23 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | Cycle 1(1): loaded http://localhost:52810/tests/dromaeo/cssquery-yui.html (next: http://localhost:52810/tests/dromaeo/cssquery-dojo.html) 04:03:26 INFO - PROCESS | 16732 | RSS: Main: 252932096 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | __start_tp_report 04:03:26 INFO - PROCESS | 16732 | _x_x_mozilla_page_load 04:03:26 INFO - PROCESS | 16732 | _x_x_mozilla_page_load_details 04:03:26 INFO - PROCESS | 16732 | |i|pagename|runs| 04:03:26 INFO - PROCESS | 16732 | |0;dojo.html;3271.656476070013;3339;3353.3460975109865;3361.5461912641786;3388.271521622851;5331.386890507592;5333.546648534874;5336.386315573705;5383.62314637975;5418.972905135469;5373.301470808789;5374.435684253156;5393.6763794172375;5394.8921021579545;5395.352557693072;4783.402074740658;4917.385326834145;4917.778699958501;4964.106460837048;5008.6744361616375;4866.902661946759;4887.462379138292;4957.677750946195;4959.355283813099;4960.826371077013;4920.60635149189;4964.925526117093;4969.776360063805;4991.625628077891;5006.799728010875;4935.481774413706;4980.526849949249;4997.675151115166;5009.824656137018;5018.673786203885;4771.33201351811;4836.879078023042;4897.632677549198;4925.088858561177;4935.876603084916;5108.463611320795;5112.795488180468;5131.358580177478;5135.3067335909545;5140.7172605506685;5740.56945729072;5743.684097374643;5766.913496297517;5767.423257674241;5779.162021506858;5694.743736531825;5716.542676585863;5729.369769325371;5756.136579513065;5791.102379131242;5355.919661205085;5360.249565060894;5363.061464243703;5363.812266570651;5364.222187782789;5771.942280577225;5826.970865145647;5829.09649004405;5829.417058294137;5830.4461076197695;5591.496765291144;5621.662700237999;5671.546276297886;5693.800716974969;5705.5435565154685;5773.74018169175;5795.362510123883;5796.420357964254;5798.072308430631;5806.21616081832;5671.801486947937;5744.684042377709;5772.249607551075;5777.653340799481;5782.074868021181;5653.038983372837;5721.456461636221;5731.684757338303;5731.684757338303;5735.541156707453;4362.062156636339;4385.079133381962;4395.077033822869;4395.956040439554;4424;3913.0608653922855;3944.073142811437;3982.522097348337;3986.063275130342;4004.6796256299426;5412.161115027177;5431.103867861838;5433.239346491494;5455.454454554513;5468.945310546844;5742.196092547047;5745.396733343023;5745.85635359111;5756.942430575725;5757.971210143923;5365.892682146336;5404.135338345845;5407.513323800798;5441.782328706887;5461.481159289861;4944.678595891328;4950.2079667253065;4950.6782059166035;4961.8511444656715;4973.676711013773;5877.500412464903;5881.029630111069;5883.735231914574;5886.352501224862;5893.2044174035955;5717.7712891485535;5725.59920805548;5729.570282228933;5768.221290125947;5776.046952252999;5901.911471327848;5918.467337939606;5921.822345329647;5924.437178468039;5945.078512830518;5671.291088613923;5673.971630141823;5678.488935995781;5681.204631351531;5687.374388817144;5693.259876216065;5776.133579963039;5782.10377391505;5833.562482813721;5845.386234445322;5580;5603.887922241451;5621.634593751393;5625.493705566519;5629.437056294501;5565.554755619622;5568.331800184003;5573.247611572548;5590;5592.888142237214;5475.315585551806;5555.694436805853;5585.860353491195;5610.074337734228;5629.155626655871;5587.273654424899;5592.273004509388;5603.831885043455;5606.971965140148;5617.297837770278;5357.116075847597;5492.038893193595;5498.560115190695;5501.889962200814;5504.4770746778995 04:03:26 INFO - PROCESS | 16732 | |1;ext.html;519.607696189377;542.8995635807375;552.3151292397425;559.8880223955209;569.3452529590967;30571.541426878586;39195.60804391955;39277.607223927786;39533.80233098838;39616.80191599038;43004.784976075156;43690;43710.781446092726;43736.343954840624;43787.56212437875;8821.779455513599;9151;9151.176394124528;9155.313351498631;9170.587323570422;8931.464112153259;9107.089291070874;9108.271338292921;9109.3168012399;9376.906230937706;9332.440053596772;9422.811543769121;9425.057494250588;9425.245980321557;9427.622895084189;9265.166135047844;9353.438793672402;9357.906420935806;9363.485008324573;9368.39105458143;9207;9345.859812102824;9348.439093654335;9351.251899847995;9358.15776580111;43641;44172.779136104116;44175.558244417785;44187.337189942176;44292.778536107435;3764.2847858906994;3874.748141370802;4059.3505039193883;4143.357779544175;4490.7530085845265;32682.509762353584;32870;32887.506687399706;32937.6706232937;33529.497057544155;3828.157805282833;3860.073582340246;3906.433567132778;3980.223856348013;4006.419069234974;203256;203498;203892;203980;204039;45650.54349456463;64351.67824160849;64933.35066649273;65173.674131629035;65374.346256536825;43925.56074439279;44055.559444405786;44144.3378349325;44266.77866610711;44323;16384.098874561776;16892.577685557713;16907.408240711517;16908;16928.661426771396;12776.74446511083;12905.483780648856;12914.354282286036;12957.805632915513;12990.350482475838;15652.68694626101;15712.450064247696;15756.212189390484;15786;15793.68412631741;5994.190784244071;6149.200603921461;6181.598196117238;6197.411245931629;6351.936480635227;1005.1556692378291;1044.556063672936;1055.0030221440666;1088.515610553312;1148.5176225985106;29863.552046719316;29964.250893727833;30225.848870755504;30798;30824.229394265323;1078.7788503356794;1119.1829964126234;1126.4592995362273;1181.3679681370597;1195.8445402097673;15717.214139293219;15814.209289535478;16032.438864639682;16161.595960100856;16380.918095409446;309110;615792;616429;618250;618733;60342.69828650829;60485.39514604797;60975.695121524994;61016.38983610196;61046.694766525885;1284.8522419921828;1440.3806363263898;1467.185711929889;1471.3893734100443;1486.3385793322084;30058.549121762753;30928.69071309348;31189;31599.526007109453;32072.198195045312;47938.5206147948;48693.26960095672;48735.75632121958;48822.75588622176;48856.2671559934;213196;214366;214580;214822;215192;34573.827130864185;34783;35334.29331413409;35359;35526.64473355233;46656.7667161662;47497;47545.286820698406;48614.27078593895;48926.26610600773;38157.80921095377;38534.6146538531;38812.6118738809;39287.803560982014;39633;37735.62264377321;38595;39083.80458097691;39336.03319834054;39747;38759.61240387673;39415;39497.80251098726;40203.59796402116;40777.184456311305;33206.501902471;34972.47541286832;35089.13857677903;35493.29013419769;35502.644973549934;27041.459170816866;27368.863155684096;27395.589066163626;27429.17712468629;27458.725412745618 04:03:26 INFO - PROCESS | 16732 | |2;jquery.html;377.07804418197503;379.87843889955207;380.1124374585343;382.46645928929144;385.06621443000716;18150.546236344097;18392.540186495346;19014.52463688405;19161.52096197596;19184.71222931657;17783.37758178464;18256.81743182568;18443.53891152722;18453.7231941521;18470.16884240209;5177.223416487519;5377.354717433914;5411.053065713504;5413.64811287267;5420.566354691615;4010.739301945379;5520.834374968737;5736.3403208631125;5754.482096611304;5763.366029736726;5685;5733.340665823442;5735.4551317624755;5758.712064396764;5763.337216220147;5448.155535891943;5649.915251271234;5654.9717251413895;5656.179853921159;5659.886802263953;5333.866653333659;5394.056040192951;5437.728113594305;5451.236826844205;5469.589780766459;14041.78937315941;14230.075045122034;14320.570382888425;17647;22076;2280.5096904165684;2298.689676893615;2385.6540801583674;2463.408781892351;3092.4897391930303;10366.429846358447;10524.579016839318;10535.578576856917;10849.620263290746;14035.85964140366;1916.281394477071;1938.2925232290254;2002.4192984034612;2003.9799602003939;2006.618742438932;59447.70276148635;63928;64761.67619161921;64925.350746492404;65238.347616524174;10814.188935829845;10858.945705271422;10978.505967231495;11016.669499914855;11400.657980260605;15029.699406011818;15168.620784480476;15232.162231077396;15263;15283.541493755205;8147.185281471924;8309.626066827008;8326.791830204293;8439.789005274795;8493.447925884797;8246.546439945741;8248.752537423767;8290.626921788535;8383.622736976851;8508.787280317918;4483.955160448354;4593.104344652827;4781.258904869751;4827.300041493963;4845.916256009879;1737.713277309255;1892.4322703188989;1948.707693845906;1964.7936966618586;1990.7611086669403;988.945607991553;989.3569180032893;1028.1928685981618;1053.131166787388;1090.2150451674781;16182.919085404734;16401.42595009193;16474.58813529671;16894.324227031026;17180.22688978974;963.6819849449665;972.7616733900239;999.7450650084182;1011.5650270383805;1050.9842352364722;10010.299279050541;10140.797184056277;10169.644062457779;10173.33873298248;10364.792704145875;419209;433605;433614;434512;435314;74648;75030.99999999891;75280;76396.61801690956;76650.2334976643;1035.8756949166147;1043.1654676259113;1045.163868904873;1102.691246450979;1105.2760441910561;15837.445689400816;15967.361305547647;16009.599760005627;16085.919570402073;16095.356185752438;34096;35030.29939401147;35425.1143721409;35670.464943026396;36345.454818178274;48432;49910.50089499204;50259;50261.24608130954;50388;8775.385722999585;8828.911710882809;8844.778880528038;8919.286457083288;9040.41237319572;7947.8807817883935;9230.861537076815;10360.792784144425;13071.607851764462;13288.202707837561;10715.196360273167;10751.441041048847;11031.669049928194;11137.777244455228;11459.19785614999;11201.327920324806;11324.830127548259;11376.374299413612;11395.430228488709;11678.6496405108;11512.424378781196;11585.478653460446;11748;11794.292342459137;11936.701582460508;8662.566871656518;11040.944795275973;11381.829272560753;11430.657080287605;11567.5951341706;11546.884531154918;12277;12326.198797078161;12371.13402061847;12540.561080362144 04:03:26 INFO - PROCESS | 16732 | |3;mootools.html;1457.2276693352526;1556.914369709666;1560.8048993875761;1778.5998150416158;1921.2027008791345;8098.271155596002;8284.13016633254;8294.668213271478;8302;8306.54314012729;8011.9599402002905;8211.09677935428;8211.589420528979;8218.876716849252;8219.424640275183;2352.7882490575844;2375.0143690368564;2376.025829409942;2378.797802186816;2380.2264264114146;2380.761923807614;2412.07135252928;2466.1615050882697;2493.1772515069983;2501.7873480754156;2399.928002159938;2425.151197081025;2425.927222183337;2444.64552639868;2463.0763463701114;2410.4937963027787;2433.2821817563863;2446.1438496526252;2450.215930902103;2460.6432067350133;2449.3141920262356;2449.3876530867283;2461.237016524883;2468.8642124683133;2478.702555693328;8235.547044912528;8269.255766980941;8288.875666864942;8317.459365141247;8320.625571849221;5111.309973153651;5256.421793602701;5271.182966640138;5278.287431196778;5278.445763194848;3211.245357341023;3217.790843595182;3288.325893191914;3297.7032067113837;3336.6830151135605;973.8539219117118;991.5587563534231;999.2755252441995;1005.5424781724298;1036.4282782730802;11809.23239989398;11861.347625880573;11895.405229738479;11899.405029748477;11901.285922844658;4545.636349092065;4644;4661.044485880387;4685.156671799109;4718.7168769873915;9995.750106247402;10024.649137280161;10050.547725352377;10052.849207261897;10067.597296108073;5231.921521177185;5232.686038837682;5238.449962753933;5273.920891186635;5282.841514754564;4186.979065104716;4573.862784116482;4608.101420223092;4651.441826980784;4788.95211047892;3888.6889048876023;3902.161035377351;3963.583823698528;3968.265870813851;3976.826836083362;1315.5527120778981;1341.584108926236;1345.3609535470573;1345.5828693105168;1357.3552562532718;1087.3584585094832;1173.4250217393417;1235.6663700800734;1473.2265560580781;1486.717523670499;7943.682252709942;7992.880106798402;8030.759077227693;8036;8036.196380361917;1173.20808454293;1179.5812486567318;1212.5452955141823;1231.901447884167;1239.132607174981;6145.9692701536205;6150.108234306001;6187.907181392283;6199.938000620026;6200.596961197508;10057.647982320585;10341.121004714683;10692.518836652369;10713.571457141627;10715.303505272288;10315.1747860171;10430.426326552113;10480.842787358195;10514.631987880388;10548.367097974146;7798.532088074734;8113.269805717514;8212.17878212174;8220.136885627162;8225.259726624632;7614.238576142341;7690.423218258541;7726.497777644435;7739.187385324685;7762.7671169865;8880.644774208959;9111.17999380059;9163.221126204347;9318.068193180628;9353.812923741623;9174.954125229331;9242.907570924204;9251.398659087137;9302.395344302598;9347.205487533636;6516.152900122954;6870.244273130052;7002.544834585736;7023.297670232936;7145.535540189871;8014.799630009064;8031.919680803351;8049.154838741848;8071.475354102199;8100.594970251582;7204.423646108404;7367.963160184165;7373.225811289952;7500.774976750707;7508.511946723445;7022.227554969051;7076.752313668997;7086.751963681247;7179.964100179465;7191.137063552407;7501.174870764103;7528.473006889465;7581.355584775356;7595.164531901597;7606.353459955744;6847.623380714109;6912.585244885323;6951.200611929693;6952.130983627047;6971.581705097507;6679.265280819203;6786.151731033621;6812.829679258059;6818.113645226089;6827 04:03:26 INFO - PROCESS | 16732 | |4;prototype.html;373.10268803527515;376.1893120325699;376.3583090830133;378.37001392681185;385.08542212245914;6058.818235452944;6062.939370606304;6067.908981365277;6076.361981991888;6085.78699745509;6011.5491338149595;6014.969925150379;6030.638161710301;6031.6381017139;6046.304674962381;4550.158220729176;4619.676622636417;4720.881977950561;4748.9525104748855;4773.832915847946;4732.550407711262;4752.35843161174;4755.215389460752;4758.310045043467;4762.857114286577;4709.411323584552;4709.599684026862;4714.787834547454;4716.434027916637;4727.5036121207295;4524.45706515217;4592;4602.6087782538525;4641.164590373732;4644.698094623838;4113.732607380511;4114.732542384735;4115.9176816463805;4128.483939507561;4132.235536425771;5732.22614946981;5742.339630942453;5745.109508026263;5747.166660834156;5764.596478246524;5430.782768689248;5432.293801805779;5433.701146436944;5435.266239057716;5444.564434845203;6347.936520634827;6348.460380867586;6352;6356.491480681534;6364.363563643645;4349;4527.615152712024;4537.183307004738;4561.7262964222255;4578.908421831578;6613.636250006248;6639.601623902581;6648.700808463631;6665.366790154928;6674.799756007327;4660;4664.3469914211355;4666.253399456071;4666.323383109498;4670.042641258534;4718.646101542329;4719.882002949954;4720.551547602972;4723.0789995951145;4723.456802467692;5405.891882162335;5407.648502847303;5410.053240682865;5411.621186516906;5414.07960646691;6262.718177682015;6416.679166041679;6428.325025872309;6430.7106180222;6468.870622587616;1624.3015503333443;1659.0875018739646;1659.626584018586;1661.7839680841414;1665.5086749408954;1017.196414832289;1047.863777708893;1065.2436769893307;1080.5947769586405;1084.5553323137476;6159.5688301818445;6166.753329866755;6168.814935551941;6193.752249910043;6199.659018754011;6497.18785151856;6546.869062618721;6575;6589.7364105435245;6599.076129341896;6213.96893015532;6214.782482613087;6215.65813880241;6216.347283535164;6220.657863817443;3530.2586456843837;3563.55455568054;3564.180238545149;3564.554430696163;3571.464280357915;6539.934600653933;6741.292164322774;6744.190697116279;6745.5952642841585;6751.628660423626;6675.699593518303;6709.7651582194385;6713.69788359525;6715.395614394728;6727.865442691119;6718.66406679664;6719.496037797185;6719.529632925648;6724.293949135368;6727.562708423937;6560.507961902781;6566.6388348641285;6567.540272180901;6569.638669873203;6569.901451478136;6317.368263173646;6465.321141280097;6476.12572302752;6523.64119973406;6560.245571759118;6817.727290908507;6843.0419741237265;6843.349881761224;6845.794626161223;6858.108445902001;4625.814967401401;4642.907141857211;4650.5814476695905;4650.790714417792;4664.277037059262;6548.377904099103;6552.312007239171;6561.40947314744;6562.212534495891;6567;6181.907271390843;6344.1118243445035;6371.936280637135;6373.8725225496155;6377.362263773771;6410.1987251593555;6432.067350234283;6453.548251622341;6454.386833250834;6458.289588145206;6232.345603711727;6234.719437625408;6251.906221406592;6261.592996455216;6264.780732674334;6415.8716825662295;6419.35806419373;6419.743210271537;6422.2614399344675;6457.773977910751;6166.81499555014;6219.875602487835;6228.190335256388;6272.435480806749;6320.431161195331 04:03:26 INFO - PROCESS | 16732 | |5;yui.html;778.6106946526737;779.9610019499023;866.7096522664905;880.1594477274208;881.2113158722939;13258.801117983227;13404.195748255112;14075.4369825207;14287.285635718225;14301.213433261166;12921.870781292184;12979.805302920464;12998.870011299885;13003.284819334933;13004.154729942547;746.3432179681886;913.4336711239008;927.6845872403381;927.7541451515353;928.1090153452693;931.9534023298842;933.7712260496188;938.6151677812098;941.270515350602;947.8009617980198;818.5825229133126;981.018981018981;984.6159997600942;986.6990567876795;991.4745185051934;822.7161629237903;979.9363041402322;985.6648739428557;985.7239972807589;987.8567607696843;727.9844616759591;731.9451041171933;732.209214048826;736.4182295986164;745.5489428895548;13375.598732037957;13407.128536645185;13426.664333391645;13460.259685717281;13475.66310842227;13729.244891530961;14149.434022639081;14284.785728214085;14307.070040447441;14395.496157634538;11013.449327533592;11313.717157071056;11499.482523286471;11896.524139034429;11985.820212696817;3896.7856767877756;3910.276598829197;3936.2324346752393;4012.3580227163516;4037.5356833964174;47747.76126119382;48037.51962480365;48315.27527087097;48385.27422088671;48483.75758121222;10326.173906087644;10563.735906602242;10604.94697526523;10716.035556799925;10804.621838235624;19649.80350196508;19654.70517942232;19655.606887862163;19691;19699.21203151858;6954.23503414624;6971.5468494547695;7484;7810.297073263434;7896.68413263463;4219.936700949488;4270.167317373082;4313.50394704613;4356.4336636237085;4356.869293921188;3419.0597585663645;3440.2259491614686;3461.0655123116617;3471.652834716508;3471.9132021699156;610.1914962674385;654.3031671270177;665.374547924949;669.5982410553629;681.9940587633201;621.4469122480996;658.5357323087212;661.9071447327341;697.8046147078826;710.9715611375591;8957.686480973265;9039.548022598843;9098.499582522893;9205.907940920639;9439.90560094404;534.7620308962474;634.0679201573679;652.807421810567;738.5347231244389;740.4085700049826;3907.47249121365;4103.528094269138;4138.461999940048;4149.315362965137;4264.189803937242;52360.21459678108;53519.732401337744;53817.1927421089;53851;54287;49264.261036084485;49461.50538494569;49800.50199498031;51947.74026129845;52201.47798522042;43966.780166099605;45441;46184.07631847344;46361.30458043132;46377.768111159225;7984.20157984197;8189.344852411674;8216.424850260424;8303.958480207802;8329.875051874105;34955;35298.47052294269;35550.82224588861;36474.635253647124;36509.817450912575;40309.798451007555;42250.36624450697;42470.78764606157;42632.36051459169;43153.56846431496;11130.833037504282;11166;12128.332941688292;12277.38613069325;12541.686457838627;13207.801882971571;13433.865661343652;13476.124051936986;13496.595102146952;13568.52510162179;12573.371331433575;12660.303683297507;12906;13243.536476223286;13573.660658483617;12081.093917956012;12143.81784273219;12729.427175776927;12973.935130324287;13168.802467962796;12071.456784444897;12518.561850335194;12562.309073000708;12858.485660573473;12897.806532902201;10745.140388769036;10821.080208182393;11099.389533575732;11176.944115279372;11524.250923689933;10598.152147828001;10621.575136994434;10694.19793515505;10747.355158690503;10869.967353101443 04:03:26 INFO - PROCESS | 16732 | __end_tp_report 04:03:26 INFO - PROCESS | 16732 | __start_cc_report 04:03:26 INFO - PROCESS | 16732 | _x_x_mozilla_cycle_collect,817 04:03:26 INFO - PROCESS | 16732 | __end_cc_report 04:03:26 INFO - PROCESS | 16732 | __startTimestamp1462964606255__endTimestamp 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | ------- Summary: start ------- 04:03:26 INFO - PROCESS | 16732 | Number of tests: 6 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#0] dojo.html Cycles:165 Average:5341.01 Median:5565.55 stddev:567.82 (10.2%) stddev-sans-first:545.86 04:03:26 INFO - PROCESS | 16732 | Values: 3271.7 3339.0 3353.3 3361.5 3388.3 5331.4 5333.5 5336.4 5383.6 5419.0 5373.3 5374.4 5393.7 5394.9 5395.4 4783.4 4917.4 4917.8 4964.1 5008.7 4866.9 4887.5 4957.7 4959.4 4960.8 4920.6 4964.9 4969.8 4991.6 5006.8 4935.5 4980.5 4997.7 5009.8 5018.7 4771.3 4836.9 4897.6 4925.1 4935.9 5108.5 5112.8 5131.4 5135.3 5140.7 5740.6 5743.7 5766.9 5767.4 5779.2 5694.7 5716.5 5729.4 5756.1 5791.1 5355.9 5360.2 5363.1 5363.8 5364.2 5771.9 5827.0 5829.1 5829.4 5830.4 5591.5 5621.7 5671.5 5693.8 5705.5 5773.7 5795.4 5796.4 5798.1 5806.2 5671.8 5744.7 5772.2 5777.7 5782.1 5653.0 5721.5 5731.7 5731.7 5735.5 4362.1 4385.1 4395.1 4396.0 4424.0 3913.1 3944.1 3982.5 3986.1 4004.7 5412.2 5431.1 5433.2 5455.5 5468.9 5742.2 5745.4 5745.9 5756.9 5758.0 5365.9 5404.1 5407.5 5441.8 5461.5 4944.7 4950.2 4950.7 4961.9 4973.7 5877.5 5881.0 5883.7 5886.4 5893.2 5717.8 5725.6 5729.6 5768.2 5776.0 5901.9 5918.5 5921.8 5924.4 5945.1 5671.3 5674.0 5678.5 5681.2 5687.4 5693.3 5776.1 5782.1 5833.6 5845.4 5580.0 5603.9 5621.6 5625.5 5629.4 5565.6 5568.3 5573.2 5590.0 5592.9 5475.3 5555.7 5585.9 5610.1 5629.2 5587.3 5592.3 5603.8 5607.0 5617.3 5357.1 5492.0 5498.6 5501.9 5504.5 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#1] ext.html Cycles:180 Average:49917.54 Median:39282.71 stddev:99347.59 (252.9%) stddev-sans-first:99557.06 04:03:26 INFO - PROCESS | 16732 | Values: 519.6 542.9 552.3 559.9 569.3 30571.5 39195.6 39277.6 39533.8 39616.8 43004.8 43690.0 43710.8 43736.3 43787.6 8821.8 9151.0 9151.2 9155.3 9170.6 8931.5 9107.1 9108.3 9109.3 9376.9 9332.4 9422.8 9425.1 9425.2 9427.6 9265.2 9353.4 9357.9 9363.5 9368.4 9207.0 9345.9 9348.4 9351.3 9358.2 43641.0 44172.8 44175.6 44187.3 44292.8 3764.3 3874.7 4059.4 4143.4 4490.8 32682.5 32870.0 32887.5 32937.7 33529.5 3828.2 3860.1 3906.4 3980.2 4006.4 203256.0 203498.0 203892.0 203980.0 204039.0 45650.5 64351.7 64933.4 65173.7 65374.3 43925.6 44055.6 44144.3 44266.8 44323.0 16384.1 16892.6 16907.4 16908.0 16928.7 12776.7 12905.5 12914.4 12957.8 12990.4 15652.7 15712.5 15756.2 15786.0 15793.7 5994.2 6149.2 6181.6 6197.4 6351.9 1005.2 1044.6 1055.0 1088.5 1148.5 29863.6 29964.3 30225.8 30798.0 30824.2 1078.8 1119.2 1126.5 1181.4 1195.8 15717.2 15814.2 16032.4 16161.6 16380.9 309110.0 615792.0 616429.0 618250.0 618733.0 60342.7 60485.4 60975.7 61016.4 61046.7 1284.9 1440.4 1467.2 1471.4 1486.3 30058.5 30928.7 31189.0 31599.5 32072.2 47938.5 48693.3 48735.8 48822.8 48856.3 213196.0 214366.0 214580.0 214822.0 215192.0 34573.8 34783.0 35334.3 35359.0 35526.6 46656.8 47497.0 47545.3 48614.3 48926.3 38157.8 38534.6 38812.6 39287.8 39633.0 37735.6 38595.0 39083.8 39336.0 39747.0 38759.6 39415.0 39497.8 40203.6 40777.2 33206.5 34972.5 35089.1 35493.3 35502.6 27041.5 27368.9 27395.6 27429.2 27458.7 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#2] jquery.html Cycles:180 Average:25695.03 Median:12041.31 stddev:70715.18 (587.3%) stddev-sans-first:70888.00 04:03:26 INFO - PROCESS | 16732 | Values: 377.1 379.9 380.1 382.5 385.1 18150.5 18392.5 19014.5 19161.5 19184.7 17783.4 18256.8 18443.5 18453.7 18470.2 5177.2 5377.4 5411.1 5413.6 5420.6 4010.7 5520.8 5736.3 5754.5 5763.4 5685.0 5733.3 5735.5 5758.7 5763.3 5448.2 5649.9 5655.0 5656.2 5659.9 5333.9 5394.1 5437.7 5451.2 5469.6 14041.8 14230.1 14320.6 17647.0 22076.0 2280.5 2298.7 2385.7 2463.4 3092.5 10366.4 10524.6 10535.6 10849.6 14035.9 1916.3 1938.3 2002.4 2004.0 2006.6 59447.7 63928.0 64761.7 64925.4 65238.3 10814.2 10858.9 10978.5 11016.7 11400.7 15029.7 15168.6 15232.2 15263.0 15283.5 8147.2 8309.6 8326.8 8439.8 8493.4 8246.5 8248.8 8290.6 8383.6 8508.8 4484.0 4593.1 4781.3 4827.3 4845.9 1737.7 1892.4 1948.7 1964.8 1990.8 988.9 989.4 1028.2 1053.1 1090.2 16182.9 16401.4 16474.6 16894.3 17180.2 963.7 972.8 999.7 1011.6 1051.0 10010.3 10140.8 10169.6 10173.3 10364.8 419209.0 433605.0 433614.0 434512.0 435314.0 74648.0 75031.0 75280.0 76396.6 76650.2 1035.9 1043.2 1045.2 1102.7 1105.3 15837.4 15967.4 16009.6 16085.9 16095.4 34096.0 35030.3 35425.1 35670.5 36345.5 48432.0 49910.5 50259.0 50261.2 50388.0 8775.4 8828.9 8844.8 8919.3 9040.4 7947.9 9230.9 10360.8 13071.6 13288.2 10715.2 10751.4 11031.7 11137.8 11459.2 11201.3 11324.8 11376.4 11395.4 11678.6 11512.4 11585.5 11748.0 11794.3 11936.7 8662.6 11040.9 11381.8 11430.7 11567.6 11546.9 12277.0 12326.2 12371.1 12540.6 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#3] mootools.html Cycles:180 Average:5898.18 Median:5263.80 stddev:3087.84 (58.7%) stddev-sans-first:3078.46 04:03:26 INFO - PROCESS | 16732 | Values: 1457.2 1556.9 1560.8 1778.6 1921.2 8098.3 8284.1 8294.7 8302.0 8306.5 8012.0 8211.1 8211.6 8218.9 8219.4 2352.8 2375.0 2376.0 2378.8 2380.2 2380.8 2412.1 2466.2 2493.2 2501.8 2399.9 2425.2 2425.9 2444.6 2463.1 2410.5 2433.3 2446.1 2450.2 2460.6 2449.3 2449.4 2461.2 2468.9 2478.7 8235.5 8269.3 8288.9 8317.5 8320.6 5111.3 5256.4 5271.2 5278.3 5278.4 3211.2 3217.8 3288.3 3297.7 3336.7 973.9 991.6 999.3 1005.5 1036.4 11809.2 11861.3 11895.4 11899.4 11901.3 4545.6 4644.0 4661.0 4685.2 4718.7 9995.8 10024.6 10050.5 10052.8 10067.6 5231.9 5232.7 5238.4 5273.9 5282.8 4187.0 4573.9 4608.1 4651.4 4789.0 3888.7 3902.2 3963.6 3968.3 3976.8 1315.6 1341.6 1345.4 1345.6 1357.4 1087.4 1173.4 1235.7 1473.2 1486.7 7943.7 7992.9 8030.8 8036.0 8036.2 1173.2 1179.6 1212.5 1231.9 1239.1 6146.0 6150.1 6187.9 6199.9 6200.6 10057.6 10341.1 10692.5 10713.6 10715.3 10315.2 10430.4 10480.8 10514.6 10548.4 7798.5 8113.3 8212.2 8220.1 8225.3 7614.2 7690.4 7726.5 7739.2 7762.8 8880.6 9111.2 9163.2 9318.1 9353.8 9175.0 9242.9 9251.4 9302.4 9347.2 6516.2 6870.2 7002.5 7023.3 7145.5 8014.8 8031.9 8049.2 8071.5 8100.6 7204.4 7368.0 7373.2 7500.8 7508.5 7022.2 7076.8 7086.8 7180.0 7191.1 7501.2 7528.5 7581.4 7595.2 7606.4 6847.6 6912.6 6951.2 6952.1 6971.6 6679.3 6786.2 6812.8 6818.1 6827.0 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#4] prototype.html Cycles:180 Average:5371.50 Median:6163.16 stddev:1586.57 (25.7%) stddev-sans-first:1546.02 04:03:26 INFO - PROCESS | 16732 | Values: 373.1 376.2 376.4 378.4 385.1 6058.8 6062.9 6067.9 6076.4 6085.8 6011.5 6015.0 6030.6 6031.6 6046.3 4550.2 4619.7 4720.9 4749.0 4773.8 4732.6 4752.4 4755.2 4758.3 4762.9 4709.4 4709.6 4714.8 4716.4 4727.5 4524.5 4592.0 4602.6 4641.2 4644.7 4113.7 4114.7 4115.9 4128.5 4132.2 5732.2 5742.3 5745.1 5747.2 5764.6 5430.8 5432.3 5433.7 5435.3 5444.6 6347.9 6348.5 6352.0 6356.5 6364.4 4349.0 4527.6 4537.2 4561.7 4578.9 6613.6 6639.6 6648.7 6665.4 6674.8 4660.0 4664.3 4666.3 4666.3 4670.0 4718.6 4719.9 4720.6 4723.1 4723.5 5405.9 5407.6 5410.1 5411.6 5414.1 6262.7 6416.7 6428.3 6430.7 6468.9 1624.3 1659.1 1659.6 1661.8 1665.5 1017.2 1047.9 1065.2 1080.6 1084.6 6159.6 6166.8 6168.8 6193.8 6199.7 6497.2 6546.9 6575.0 6589.7 6599.1 6214.0 6214.8 6215.7 6216.3 6220.7 3530.3 3563.6 3564.2 3564.6 3571.5 6539.9 6741.3 6744.2 6745.6 6751.6 6675.7 6709.8 6713.7 6715.4 6727.9 6718.7 6719.5 6719.5 6724.3 6727.6 6560.5 6566.6 6567.5 6569.6 6569.9 6317.4 6465.3 6476.1 6523.6 6560.2 6817.7 6843.0 6843.3 6845.8 6858.1 4625.8 4642.9 4650.6 4650.8 4664.3 6548.4 6552.3 6561.4 6562.2 6567.0 6181.9 6344.1 6371.9 6373.9 6377.4 6410.2 6432.1 6453.5 6454.4 6458.3 6232.3 6234.7 6251.9 6261.6 6264.8 6415.9 6419.4 6419.7 6422.3 6457.8 6166.8 6219.9 6228.2 6272.4 6320.4 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - PROCESS | 16732 | [#5] yui.html Cycles:180 Average:14036.11 Median:23235.15 stddev:15404.46 (66.3%) stddev-sans-first:15415.50 04:03:26 INFO - PROCESS | 16732 | Values: 778.6 780.0 866.7 880.2 881.2 13258.8 13404.2 14075.4 14287.3 14301.2 12921.9 12979.8 12998.9 13003.3 13004.2 746.3 913.4 927.7 927.8 928.1 932.0 933.8 938.6 941.3 947.8 818.6 981.0 984.6 986.7 991.5 822.7 979.9 985.7 985.7 987.9 728.0 731.9 732.2 736.4 745.5 13375.6 13407.1 13426.7 13460.3 13475.7 13729.2 14149.4 14284.8 14307.1 14395.5 11013.4 11313.7 11499.5 11896.5 11985.8 3896.8 3910.3 3936.2 4012.4 4037.5 47747.8 48037.5 48315.3 48385.3 48483.8 10326.2 10563.7 10604.9 10716.0 10804.6 19649.8 19654.7 19655.6 19691.0 19699.2 6954.2 6971.5 7484.0 7810.3 7896.7 4219.9 4270.2 4313.5 4356.4 4356.9 3419.1 3440.2 3461.1 3471.7 3471.9 610.2 654.3 665.4 669.6 682.0 621.4 658.5 661.9 697.8 711.0 8957.7 9039.5 9098.5 9205.9 9439.9 534.8 634.1 652.8 738.5 740.4 3907.5 4103.5 4138.5 4149.3 4264.2 52360.2 53519.7 53817.2 53851.0 54287.0 49264.3 49461.5 49800.5 51947.7 52201.5 43966.8 45441.0 46184.1 46361.3 46377.8 7984.2 8189.3 8216.4 8304.0 8329.9 34955.0 35298.5 35550.8 36474.6 36509.8 40309.8 42250.4 42470.8 42632.4 43153.6 11130.8 11166.0 12128.3 12277.4 12541.7 13207.8 13433.9 13476.1 13496.6 13568.5 12573.4 12660.3 12906.0 13243.5 13573.7 12081.1 12143.8 12729.4 12973.9 13168.8 12071.5 12518.6 12562.3 12858.5 12897.8 10745.1 10821.1 11099.4 11176.9 11524.3 10598.2 10621.6 10694.2 10747.4 10870.0 04:03:26 INFO - PROCESS | 16732 | -------- Summary: end -------- 04:03:26 INFO - PROCESS | 16732 | 04:03:26 INFO - TEST-INFO | 16732: exit 0 04:03:26 INFO - TEST-OK | dromaeo_css | took 1110839ms 04:03:26 INFO - TEST-START | kraken 04:03:26 INFO - operating with platform_type : linux_ 04:03:26 INFO - Initialising browser for kraken test... 04:03:26 INFO - TEST-INFO | started process 16933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE8WQP/profile http://localhost:52810/getInfo.html) 04:03:31 INFO - PROCESS | 16933 | __metrics Screen width/height:1600/1200 04:03:31 INFO - PROCESS | 16933 | colorDepth:24 04:03:31 INFO - PROCESS | 16933 | Browser inner width/height: 1024/697 04:03:31 INFO - PROCESS | 16933 | __metrics 04:03:32 INFO - PROCESS | 16933 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:32 INFO - TEST-INFO | 16933: exit 0 04:03:32 INFO - Browser initialized. 04:03:32 INFO - Running cycle 1/1 for kraken test... 04:03:32 INFO - TEST-INFO | started process 17023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCE8WQP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:44 INFO - PROCESS | 17023 | RSS: Main: 139747328 04:03:44 INFO - PROCESS | 17023 | 04:03:47 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:47 INFO - PROCESS | 17023 | RSS: Main: 175304704 04:03:47 INFO - PROCESS | 17023 | 04:03:50 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-dft) 04:03:51 INFO - PROCESS | 17023 | RSS: Main: 173522944 04:03:51 INFO - PROCESS | 17023 | 04:03:53 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-fft) 04:03:54 INFO - PROCESS | 17023 | RSS: Main: 169406464 04:03:54 INFO - PROCESS | 17023 | 04:03:56 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52810/tests/kraken/driver.html?testName=audio-oscillator) 04:03:57 INFO - PROCESS | 17023 | RSS: Main: 170270720 04:03:57 INFO - PROCESS | 17023 | 04:03:59 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:59 INFO - PROCESS | 17023 | RSS: Main: 167985152 04:03:59 INFO - PROCESS | 17023 | 04:04:02 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:03 INFO - PROCESS | 17023 | RSS: Main: 168861696 04:04:03 INFO - PROCESS | 17023 | 04:04:06 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52810/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:07 INFO - PROCESS | 17023 | RSS: Main: 168837120 04:04:07 INFO - PROCESS | 17023 | 04:04:10 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52810/tests/kraken/driver.html?testName=json-parse-financial) 04:04:10 INFO - PROCESS | 17023 | RSS: Main: 168804352 04:04:10 INFO - PROCESS | 17023 | 04:04:12 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:12 INFO - PROCESS | 17023 | RSS: Main: 172363776 04:04:12 INFO - PROCESS | 17023 | 04:04:14 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:15 INFO - PROCESS | 17023 | RSS: Main: 171450368 04:04:15 INFO - PROCESS | 17023 | 04:04:17 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:17 INFO - PROCESS | 17023 | RSS: Main: 176627712 04:04:17 INFO - PROCESS | 17023 | 04:04:20 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:20 INFO - PROCESS | 17023 | RSS: Main: 179949568 04:04:20 INFO - PROCESS | 17023 | 04:04:23 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:23 INFO - PROCESS | 17023 | RSS: Main: 180191232 04:04:23 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | Cycle 1(1): loaded http://localhost:52810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52810/tests/kraken/driver.html?testName=ai-astar) 04:04:25 INFO - PROCESS | 17023 | RSS: Main: 241963008 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | __start_tp_report 04:04:25 INFO - PROCESS | 17023 | _x_x_mozilla_page_load 04:04:25 INFO - PROCESS | 17023 | _x_x_mozilla_page_load_details 04:04:25 INFO - PROCESS | 17023 | |i|pagename|runs| 04:04:25 INFO - PROCESS | 17023 | |0;ai-astar;109;111;106;111;112;112;99;110;110;110 04:04:25 INFO - PROCESS | 17023 | |1;audio-beat-detection;160;127;156;168;127;154;155;129;181;130 04:04:25 INFO - PROCESS | 17023 | |2;audio-dft;161;161;159;161;159;159;160;166;161;160 04:04:25 INFO - PROCESS | 17023 | |3;audio-fft;77;77;77;161;74;76;77;76;165;76 04:04:25 INFO - PROCESS | 17023 | |4;audio-oscillator;93;93;141;93;93;92;143;93;93;140 04:04:25 INFO - PROCESS | 17023 | |5;imaging-gaussian-blur;116;117;116;116;116;117;116;117;116;116 04:04:25 INFO - PROCESS | 17023 | |6;imaging-darkroom;145;146;145;145;146;145;147;145;146;146 04:04:25 INFO - PROCESS | 17023 | |7;imaging-desaturate;95;96;96;96;96;95;95;95;95;96 04:04:25 INFO - PROCESS | 17023 | |8;json-parse-financial;56;57;58;57;57;60;57;57;56;57 04:04:25 INFO - PROCESS | 17023 | |9;json-stringify-tinderbox;64;66;64;65;65;64;65;65;64;66 04:04:25 INFO - PROCESS | 17023 | |10;stanford-crypto-aes;78;81;81;80;79;79;80;79;80;80 04:04:25 INFO - PROCESS | 17023 | |11;stanford-crypto-ccm;119;114;120;125;116;113;111;114;118;119 04:04:25 INFO - PROCESS | 17023 | |12;stanford-crypto-pbkdf2;140;142;153;153;150;142;153;154;149;143 04:04:25 INFO - PROCESS | 17023 | |13;stanford-crypto-sha256-iterative;72;68;69;68;70;67;66;70;68;66 04:04:25 INFO - PROCESS | 17023 | __end_tp_report 04:04:25 INFO - PROCESS | 17023 | __start_cc_report 04:04:25 INFO - PROCESS | 17023 | _x_x_mozilla_cycle_collect,1099 04:04:25 INFO - PROCESS | 17023 | __end_cc_report 04:04:25 INFO - PROCESS | 17023 | __startTimestamp1462964665888__endTimestamp 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | ------- Summary: start ------- 04:04:25 INFO - PROCESS | 17023 | Number of tests: 14 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 04:04:25 INFO - PROCESS | 17023 | Values: 109.0 111.0 106.0 111.0 112.0 112.0 99.0 110.0 110.0 110.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:155.50 stddev:19.28 (12.4%) stddev-sans-first:20.01 04:04:25 INFO - PROCESS | 17023 | Values: 160.0 127.0 156.0 168.0 127.0 154.0 155.0 129.0 181.0 130.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 04:04:25 INFO - PROCESS | 17023 | Values: 161.0 161.0 159.0 161.0 159.0 159.0 160.0 166.0 161.0 160.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.50 stddev:36.60 (47.8%) stddev-sans-first:38.32 04:04:25 INFO - PROCESS | 17023 | Values: 77.0 77.0 77.0 161.0 74.0 76.0 77.0 76.0 165.0 76.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:23.43 (25.2%) stddev-sans-first:24.26 04:04:25 INFO - PROCESS | 17023 | Values: 93.0 93.0 141.0 93.0 93.0 92.0 143.0 93.0 93.0 140.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:04:25 INFO - PROCESS | 17023 | Values: 116.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 116.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:04:25 INFO - PROCESS | 17023 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 147.0 145.0 146.0 146.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:04:25 INFO - PROCESS | 17023 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.12 04:04:25 INFO - PROCESS | 17023 | Values: 56.0 57.0 58.0 57.0 57.0 60.0 57.0 57.0 56.0 57.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 04:04:25 INFO - PROCESS | 17023 | Values: 64.0 66.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 66.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.95 (1.2%) stddev-sans-first:0.78 04:04:25 INFO - PROCESS | 17023 | Values: 78.0 81.0 81.0 80.0 79.0 79.0 80.0 79.0 80.0 80.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:118.50 stddev:4.12 (3.5%) stddev-sans-first:4.30 04:04:25 INFO - PROCESS | 17023 | Values: 119.0 114.0 120.0 125.0 116.0 113.0 111.0 114.0 118.0 119.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:151.50 stddev:5.55 (3.7%) stddev-sans-first:5.09 04:04:25 INFO - PROCESS | 17023 | Values: 140.0 142.0 153.0 153.0 150.0 142.0 153.0 154.0 149.0 143.0 04:04:25 INFO - PROCESS | 17023 | 04:04:25 INFO - PROCESS | 17023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.90 (2.8%) stddev-sans-first:1.50 04:04:25 INFO - PROCESS | 17023 | Values: 72.0 68.0 69.0 68.0 70.0 67.0 66.0 70.0 68.0 66.0 04:04:25 INFO - PROCESS | 17023 | -------- Summary: end -------- 04:04:25 INFO - PROCESS | 17023 | 04:04:26 INFO - TEST-INFO | 17023: exit 0 04:04:26 INFO - TEST-OK | kraken | took 59865ms 04:04:26 INFO - SUITE-END | took 1170s 04:04:27 INFO - Completed test suite (00:19:30) 04:04:27 INFO - javascript benchmark 04:04:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.656476070013, 3339.0, 3353.3460975109865, 3361.5461912641786, 3388.271521622851, 5331.386890507592, 5333.546648534874, 5336.386315573705, 5383.62314637975, 5418.972905135469, 5373.301470808789, 5374.435684253156, 5393.6763794172375, 5394.8921021579545, 5395.352557693072, 4783.402074740658, 4917.385326834145, 4917.778699958501, 4964.106460837048, 5008.6744361616375, 4866.902661946759, 4887.462379138292, 4957.677750946195, 4959.355283813099, 4960.826371077013, 4920.60635149189, 4964.925526117093, 4969.776360063805, 4991.625628077891, 5006.799728010875, 4935.481774413706, 4980.526849949249, 4997.675151115166, 5009.824656137018, 5018.673786203885, 4771.33201351811, 4836.879078023042, 4897.632677549198, 4925.088858561177, 4935.876603084916, 5108.463611320795, 5112.795488180468, 5131.358580177478, 5135.3067335909545, 5140.7172605506685, 5740.56945729072, 5743.684097374643, 5766.913496297517, 5767.423257674241, 5779.162021506858, 5694.743736531825, 5716.542676585863, 5729.369769325371, 5756.136579513065, 5791.102379131242, 5355.919661205085, 5360.249565060894, 5363.061464243703, 5363.812266570651, 5364.222187782789, 5771.942280577225, 5826.970865145647, 5829.09649004405, 5829.417058294137, 5830.4461076197695, 5591.496765291144, 5621.662700237999, 5671.546276297886, 5693.800716974969, 5705.5435565154685, 5773.74018169175, 5795.362510123883, 5796.420357964254, 5798.072308430631, 5806.21616081832, 5671.801486947937, 5744.684042377709, 5772.249607551075, 5777.653340799481, 5782.074868021181, 5653.038983372837, 5721.456461636221, 5731.684757338303, 5731.684757338303, 5735.541156707453, 4362.062156636339, 4385.079133381962, 4395.077033822869, 4395.956040439554, 4424.0, 3913.0608653922855, 3944.073142811437, 3982.522097348337, 3986.063275130342, 4004.6796256299426, 5412.161115027177, 5431.103867861838, 5433.239346491494, 5455.454454554513, 5468.945310546844, 5742.196092547047, 5745.396733343023, 5745.85635359111, 5756.942430575725, 5757.971210143923, 5365.892682146336, 5404.135338345845, 5407.513323800798, 5441.782328706887, 5461.481159289861, 4944.678595891328, 4950.2079667253065, 4950.6782059166035, 4961.8511444656715, 4973.676711013773, 5877.500412464903, 5881.029630111069, 5883.735231914574, 5886.352501224862, 5893.2044174035955, 5717.7712891485535, 5725.59920805548, 5729.570282228933, 5768.221290125947, 5776.046952252999, 5901.911471327848, 5918.467337939606, 5921.822345329647, 5924.437178468039, 5945.078512830518, 5671.291088613923, 5673.971630141823, 5678.488935995781, 5681.204631351531, 5687.374388817144, 5693.259876216065, 5776.133579963039, 5782.10377391505, 5833.562482813721, 5845.386234445322, 5580.0, 5603.887922241451, 5621.634593751393, 5625.493705566519, 5629.437056294501, 5565.554755619622, 5568.331800184003, 5573.247611572548, 5590.0, 5592.888142237214, 5475.315585551806, 5555.694436805853, 5585.860353491195, 5610.074337734228, 5629.155626655871, 5587.273654424899, 5592.273004509388, 5603.831885043455, 5606.971965140148, 5617.297837770278, 5357.116075847597, 5492.038893193595, 5498.560115190695, 5501.889962200814, 5504.4770746778995], "unit": "score", "name": "dojo.html", "value": 5306.011279759687}, {"lowerIsBetter": false, "replicates": [519.607696189377, 542.8995635807375, 552.3151292397425, 559.8880223955209, 569.3452529590967, 30571.541426878586, 39195.60804391955, 39277.607223927786, 39533.80233098838, 39616.80191599038, 43004.784976075156, 43690.0, 43710.781446092726, 43736.343954840624, 43787.56212437875, 8821.779455513599, 9151.0, 9151.176394124528, 9155.313351498631, 9170.587323570422, 8931.464112153259, 9107.089291070874, 9108.271338292921, 9109.3168012399, 9376.906230937706, 9332.440053596772, 9422.811543769121, 9425.057494250588, 9425.245980321557, 9427.622895084189, 9265.166135047844, 9353.438793672402, 9357.906420935806, 9363.485008324573, 9368.39105458143, 9207.0, 9345.859812102824, 9348.439093654335, 9351.251899847995, 9358.15776580111, 43641.0, 44172.779136104116, 44175.558244417785, 44187.337189942176, 44292.778536107435, 3764.2847858906994, 3874.748141370802, 4059.3505039193883, 4143.357779544175, 4490.7530085845265, 32682.509762353584, 32870.0, 32887.506687399706, 32937.6706232937, 33529.497057544155, 3828.157805282833, 3860.073582340246, 3906.433567132778, 3980.223856348013, 4006.419069234974, 203256.0, 203498.0, 203892.0, 203980.0, 204039.0, 45650.54349456463, 64351.67824160849, 64933.35066649273, 65173.674131629035, 65374.346256536825, 43925.56074439279, 44055.559444405786, 44144.3378349325, 44266.77866610711, 44323.0, 16384.098874561776, 16892.577685557713, 16907.408240711517, 16908.0, 16928.661426771396, 12776.74446511083, 12905.483780648856, 12914.354282286036, 12957.805632915513, 12990.350482475838, 15652.68694626101, 15712.450064247696, 15756.212189390484, 15786.0, 15793.68412631741, 5994.190784244071, 6149.200603921461, 6181.598196117238, 6197.411245931629, 6351.936480635227, 1005.1556692378291, 1044.556063672936, 1055.0030221440666, 1088.515610553312, 1148.5176225985106, 29863.552046719316, 29964.250893727833, 30225.848870755504, 30798.0, 30824.229394265323, 1078.7788503356794, 1119.1829964126234, 1126.4592995362273, 1181.3679681370597, 1195.8445402097673, 15717.214139293219, 15814.209289535478, 16032.438864639682, 16161.595960100856, 16380.918095409446, 309110.0, 615792.0, 616429.0, 618250.0, 618733.0, 60342.69828650829, 60485.39514604797, 60975.695121524994, 61016.38983610196, 61046.694766525885, 1284.8522419921828, 1440.3806363263898, 1467.185711929889, 1471.3893734100443, 1486.3385793322084, 30058.549121762753, 30928.69071309348, 31189.0, 31599.526007109453, 32072.198195045312, 47938.5206147948, 48693.26960095672, 48735.75632121958, 48822.75588622176, 48856.2671559934, 213196.0, 214366.0, 214580.0, 214822.0, 215192.0, 34573.827130864185, 34783.0, 35334.29331413409, 35359.0, 35526.64473355233, 46656.7667161662, 47497.0, 47545.286820698406, 48614.27078593895, 48926.26610600773, 38157.80921095377, 38534.6146538531, 38812.6118738809, 39287.803560982014, 39633.0, 37735.62264377321, 38595.0, 39083.80458097691, 39336.03319834054, 39747.0, 38759.61240387673, 39415.0, 39497.80251098726, 40203.59796402116, 40777.184456311305, 33206.501902471, 34972.47541286832, 35089.13857677903, 35493.29013419769, 35502.644973549934, 27041.459170816866, 27368.863155684096, 27395.589066163626, 27429.17712468629, 27458.725412745618], "unit": "score", "name": "ext.html", "value": 19162.65270577287}, {"lowerIsBetter": false, "replicates": [377.07804418197503, 379.87843889955207, 380.1124374585343, 382.46645928929144, 385.06621443000716, 18150.546236344097, 18392.540186495346, 19014.52463688405, 19161.52096197596, 19184.71222931657, 17783.37758178464, 18256.81743182568, 18443.53891152722, 18453.7231941521, 18470.16884240209, 5177.223416487519, 5377.354717433914, 5411.053065713504, 5413.64811287267, 5420.566354691615, 4010.739301945379, 5520.834374968737, 5736.3403208631125, 5754.482096611304, 5763.366029736726, 5685.0, 5733.340665823442, 5735.4551317624755, 5758.712064396764, 5763.337216220147, 5448.155535891943, 5649.915251271234, 5654.9717251413895, 5656.179853921159, 5659.886802263953, 5333.866653333659, 5394.056040192951, 5437.728113594305, 5451.236826844205, 5469.589780766459, 14041.78937315941, 14230.075045122034, 14320.570382888425, 17647.0, 22076.0, 2280.5096904165684, 2298.689676893615, 2385.6540801583674, 2463.408781892351, 3092.4897391930303, 10366.429846358447, 10524.579016839318, 10535.578576856917, 10849.620263290746, 14035.85964140366, 1916.281394477071, 1938.2925232290254, 2002.4192984034612, 2003.9799602003939, 2006.618742438932, 59447.70276148635, 63928.0, 64761.67619161921, 64925.350746492404, 65238.347616524174, 10814.188935829845, 10858.945705271422, 10978.505967231495, 11016.669499914855, 11400.657980260605, 15029.699406011818, 15168.620784480476, 15232.162231077396, 15263.0, 15283.541493755205, 8147.185281471924, 8309.626066827008, 8326.791830204293, 8439.789005274795, 8493.447925884797, 8246.546439945741, 8248.752537423767, 8290.626921788535, 8383.622736976851, 8508.787280317918, 4483.955160448354, 4593.104344652827, 4781.258904869751, 4827.300041493963, 4845.916256009879, 1737.713277309255, 1892.4322703188989, 1948.707693845906, 1964.7936966618586, 1990.7611086669403, 988.945607991553, 989.3569180032893, 1028.1928685981618, 1053.131166787388, 1090.2150451674781, 16182.919085404734, 16401.42595009193, 16474.58813529671, 16894.324227031026, 17180.22688978974, 963.6819849449665, 972.7616733900239, 999.7450650084182, 1011.5650270383805, 1050.9842352364722, 10010.299279050541, 10140.797184056277, 10169.644062457779, 10173.33873298248, 10364.792704145875, 419209.0, 433605.0, 433614.0, 434512.0, 435314.0, 74648.0, 75030.99999999891, 75280.0, 76396.61801690956, 76650.2334976643, 1035.8756949166147, 1043.1654676259113, 1045.163868904873, 1102.691246450979, 1105.2760441910561, 15837.445689400816, 15967.361305547647, 16009.599760005627, 16085.919570402073, 16095.356185752438, 34096.0, 35030.29939401147, 35425.1143721409, 35670.464943026396, 36345.454818178274, 48432.0, 49910.50089499204, 50259.0, 50261.24608130954, 50388.0, 8775.385722999585, 8828.911710882809, 8844.778880528038, 8919.286457083288, 9040.41237319572, 7947.8807817883935, 9230.861537076815, 10360.792784144425, 13071.607851764462, 13288.202707837561, 10715.196360273167, 10751.441041048847, 11031.669049928194, 11137.777244455228, 11459.19785614999, 11201.327920324806, 11324.830127548259, 11376.374299413612, 11395.430228488709, 11678.6496405108, 11512.424378781196, 11585.478653460446, 11748.0, 11794.292342459137, 11936.701582460508, 8662.566871656518, 11040.944795275973, 11381.829272560753, 11430.657080287605, 11567.5951341706, 11546.884531154918, 12277.0, 12326.198797078161, 12371.13402061847, 12540.561080362144], "unit": "score", "name": "jquery.html", "value": 8858.506145544306}, {"lowerIsBetter": false, "replicates": [1457.2276693352526, 1556.914369709666, 1560.8048993875761, 1778.5998150416158, 1921.2027008791345, 8098.271155596002, 8284.13016633254, 8294.668213271478, 8302.0, 8306.54314012729, 8011.9599402002905, 8211.09677935428, 8211.589420528979, 8218.876716849252, 8219.424640275183, 2352.7882490575844, 2375.0143690368564, 2376.025829409942, 2378.797802186816, 2380.2264264114146, 2380.761923807614, 2412.07135252928, 2466.1615050882697, 2493.1772515069983, 2501.7873480754156, 2399.928002159938, 2425.151197081025, 2425.927222183337, 2444.64552639868, 2463.0763463701114, 2410.4937963027787, 2433.2821817563863, 2446.1438496526252, 2450.215930902103, 2460.6432067350133, 2449.3141920262356, 2449.3876530867283, 2461.237016524883, 2468.8642124683133, 2478.702555693328, 8235.547044912528, 8269.255766980941, 8288.875666864942, 8317.459365141247, 8320.625571849221, 5111.309973153651, 5256.421793602701, 5271.182966640138, 5278.287431196778, 5278.445763194848, 3211.245357341023, 3217.790843595182, 3288.325893191914, 3297.7032067113837, 3336.6830151135605, 973.8539219117118, 991.5587563534231, 999.2755252441995, 1005.5424781724298, 1036.4282782730802, 11809.23239989398, 11861.347625880573, 11895.405229738479, 11899.405029748477, 11901.285922844658, 4545.636349092065, 4644.0, 4661.044485880387, 4685.156671799109, 4718.7168769873915, 9995.750106247402, 10024.649137280161, 10050.547725352377, 10052.849207261897, 10067.597296108073, 5231.921521177185, 5232.686038837682, 5238.449962753933, 5273.920891186635, 5282.841514754564, 4186.979065104716, 4573.862784116482, 4608.101420223092, 4651.441826980784, 4788.95211047892, 3888.6889048876023, 3902.161035377351, 3963.583823698528, 3968.265870813851, 3976.826836083362, 1315.5527120778981, 1341.584108926236, 1345.3609535470573, 1345.5828693105168, 1357.3552562532718, 1087.3584585094832, 1173.4250217393417, 1235.6663700800734, 1473.2265560580781, 1486.717523670499, 7943.682252709942, 7992.880106798402, 8030.759077227693, 8036.0, 8036.196380361917, 1173.20808454293, 1179.5812486567318, 1212.5452955141823, 1231.901447884167, 1239.132607174981, 6145.9692701536205, 6150.108234306001, 6187.907181392283, 6199.938000620026, 6200.596961197508, 10057.647982320585, 10341.121004714683, 10692.518836652369, 10713.571457141627, 10715.303505272288, 10315.1747860171, 10430.426326552113, 10480.842787358195, 10514.631987880388, 10548.367097974146, 7798.532088074734, 8113.269805717514, 8212.17878212174, 8220.136885627162, 8225.259726624632, 7614.238576142341, 7690.423218258541, 7726.497777644435, 7739.187385324685, 7762.7671169865, 8880.644774208959, 9111.17999380059, 9163.221126204347, 9318.068193180628, 9353.812923741623, 9174.954125229331, 9242.907570924204, 9251.398659087137, 9302.395344302598, 9347.205487533636, 6516.152900122954, 6870.244273130052, 7002.544834585736, 7023.297670232936, 7145.535540189871, 8014.799630009064, 8031.919680803351, 8049.154838741848, 8071.475354102199, 8100.594970251582, 7204.423646108404, 7367.963160184165, 7373.225811289952, 7500.774976750707, 7508.511946723445, 7022.227554969051, 7076.752313668997, 7086.751963681247, 7179.964100179465, 7191.137063552407, 7501.174870764103, 7528.473006889465, 7581.355584775356, 7595.164531901597, 7606.353459955744, 6847.623380714109, 6912.585244885323, 6951.200611929693, 6952.130983627047, 6971.581705097507, 6679.265280819203, 6786.151731033621, 6812.829679258059, 6818.113645226089, 6827.0], "unit": "score", "name": "mootools.html", "value": 4837.719660266964}, {"lowerIsBetter": false, "replicates": [373.10268803527515, 376.1893120325699, 376.3583090830133, 378.37001392681185, 385.08542212245914, 6058.818235452944, 6062.939370606304, 6067.908981365277, 6076.361981991888, 6085.78699745509, 6011.5491338149595, 6014.969925150379, 6030.638161710301, 6031.6381017139, 6046.304674962381, 4550.158220729176, 4619.676622636417, 4720.881977950561, 4748.9525104748855, 4773.832915847946, 4732.550407711262, 4752.35843161174, 4755.215389460752, 4758.310045043467, 4762.857114286577, 4709.411323584552, 4709.599684026862, 4714.787834547454, 4716.434027916637, 4727.5036121207295, 4524.45706515217, 4592.0, 4602.6087782538525, 4641.164590373732, 4644.698094623838, 4113.732607380511, 4114.732542384735, 4115.9176816463805, 4128.483939507561, 4132.235536425771, 5732.22614946981, 5742.339630942453, 5745.109508026263, 5747.166660834156, 5764.596478246524, 5430.782768689248, 5432.293801805779, 5433.701146436944, 5435.266239057716, 5444.564434845203, 6347.936520634827, 6348.460380867586, 6352.0, 6356.491480681534, 6364.363563643645, 4349.0, 4527.615152712024, 4537.183307004738, 4561.7262964222255, 4578.908421831578, 6613.636250006248, 6639.601623902581, 6648.700808463631, 6665.366790154928, 6674.799756007327, 4660.0, 4664.3469914211355, 4666.253399456071, 4666.323383109498, 4670.042641258534, 4718.646101542329, 4719.882002949954, 4720.551547602972, 4723.0789995951145, 4723.456802467692, 5405.891882162335, 5407.648502847303, 5410.053240682865, 5411.621186516906, 5414.07960646691, 6262.718177682015, 6416.679166041679, 6428.325025872309, 6430.7106180222, 6468.870622587616, 1624.3015503333443, 1659.0875018739646, 1659.626584018586, 1661.7839680841414, 1665.5086749408954, 1017.196414832289, 1047.863777708893, 1065.2436769893307, 1080.5947769586405, 1084.5553323137476, 6159.5688301818445, 6166.753329866755, 6168.814935551941, 6193.752249910043, 6199.659018754011, 6497.18785151856, 6546.869062618721, 6575.0, 6589.7364105435245, 6599.076129341896, 6213.96893015532, 6214.782482613087, 6215.65813880241, 6216.347283535164, 6220.657863817443, 3530.2586456843837, 3563.55455568054, 3564.180238545149, 3564.554430696163, 3571.464280357915, 6539.934600653933, 6741.292164322774, 6744.190697116279, 6745.5952642841585, 6751.628660423626, 6675.699593518303, 6709.7651582194385, 6713.69788359525, 6715.395614394728, 6727.865442691119, 6718.66406679664, 6719.496037797185, 6719.529632925648, 6724.293949135368, 6727.562708423937, 6560.507961902781, 6566.6388348641285, 6567.540272180901, 6569.638669873203, 6569.901451478136, 6317.368263173646, 6465.321141280097, 6476.12572302752, 6523.64119973406, 6560.245571759118, 6817.727290908507, 6843.0419741237265, 6843.349881761224, 6845.794626161223, 6858.108445902001, 4625.814967401401, 4642.907141857211, 4650.5814476695905, 4650.790714417792, 4664.277037059262, 6548.377904099103, 6552.312007239171, 6561.40947314744, 6562.212534495891, 6567.0, 6181.907271390843, 6344.1118243445035, 6371.936280637135, 6373.8725225496155, 6377.362263773771, 6410.1987251593555, 6432.067350234283, 6453.548251622341, 6454.386833250834, 6458.289588145206, 6232.345603711727, 6234.719437625408, 6251.906221406592, 6261.592996455216, 6264.780732674334, 6415.8716825662295, 6419.35806419373, 6419.743210271537, 6422.2614399344675, 6457.773977910751, 6166.81499555014, 6219.875602487835, 6228.190335256388, 6272.435480806749, 6320.431161195331], "unit": "score", "name": "prototype.html", "value": 4863.761696954607}, {"lowerIsBetter": false, "replicates": [778.6106946526737, 779.9610019499023, 866.7096522664905, 880.1594477274208, 881.2113158722939, 13258.801117983227, 13404.195748255112, 14075.4369825207, 14287.285635718225, 14301.213433261166, 12921.870781292184, 12979.805302920464, 12998.870011299885, 13003.284819334933, 13004.154729942547, 746.3432179681886, 913.4336711239008, 927.6845872403381, 927.7541451515353, 928.1090153452693, 931.9534023298842, 933.7712260496188, 938.6151677812098, 941.270515350602, 947.8009617980198, 818.5825229133126, 981.018981018981, 984.6159997600942, 986.6990567876795, 991.4745185051934, 822.7161629237903, 979.9363041402322, 985.6648739428557, 985.7239972807589, 987.8567607696843, 727.9844616759591, 731.9451041171933, 732.209214048826, 736.4182295986164, 745.5489428895548, 13375.598732037957, 13407.128536645185, 13426.664333391645, 13460.259685717281, 13475.66310842227, 13729.244891530961, 14149.434022639081, 14284.785728214085, 14307.070040447441, 14395.496157634538, 11013.449327533592, 11313.717157071056, 11499.482523286471, 11896.524139034429, 11985.820212696817, 3896.7856767877756, 3910.276598829197, 3936.2324346752393, 4012.3580227163516, 4037.5356833964174, 47747.76126119382, 48037.51962480365, 48315.27527087097, 48385.27422088671, 48483.75758121222, 10326.173906087644, 10563.735906602242, 10604.94697526523, 10716.035556799925, 10804.621838235624, 19649.80350196508, 19654.70517942232, 19655.606887862163, 19691.0, 19699.21203151858, 6954.23503414624, 6971.5468494547695, 7484.0, 7810.297073263434, 7896.68413263463, 4219.936700949488, 4270.167317373082, 4313.50394704613, 4356.4336636237085, 4356.869293921188, 3419.0597585663645, 3440.2259491614686, 3461.0655123116617, 3471.652834716508, 3471.9132021699156, 610.1914962674385, 654.3031671270177, 665.374547924949, 669.5982410553629, 681.9940587633201, 621.4469122480996, 658.5357323087212, 661.9071447327341, 697.8046147078826, 710.9715611375591, 8957.686480973265, 9039.548022598843, 9098.499582522893, 9205.907940920639, 9439.90560094404, 534.7620308962474, 634.0679201573679, 652.807421810567, 738.5347231244389, 740.4085700049826, 3907.47249121365, 4103.528094269138, 4138.461999940048, 4149.315362965137, 4264.189803937242, 52360.21459678108, 53519.732401337744, 53817.1927421089, 53851.0, 54287.0, 49264.261036084485, 49461.50538494569, 49800.50199498031, 51947.74026129845, 52201.47798522042, 43966.780166099605, 45441.0, 46184.07631847344, 46361.30458043132, 46377.768111159225, 7984.20157984197, 8189.344852411674, 8216.424850260424, 8303.958480207802, 8329.875051874105, 34955.0, 35298.47052294269, 35550.82224588861, 36474.635253647124, 36509.817450912575, 40309.798451007555, 42250.36624450697, 42470.78764606157, 42632.36051459169, 43153.56846431496, 11130.833037504282, 11166.0, 12128.332941688292, 12277.38613069325, 12541.686457838627, 13207.801882971571, 13433.865661343652, 13476.124051936986, 13496.595102146952, 13568.52510162179, 12573.371331433575, 12660.303683297507, 12906.0, 13243.536476223286, 13573.660658483617, 12081.093917956012, 12143.81784273219, 12729.427175776927, 12973.935130324287, 13168.802467962796, 12071.456784444897, 12518.561850335194, 12562.309073000708, 12858.485660573473, 12897.806532902201, 10745.140388769036, 10821.080208182393, 11099.389533575732, 11176.944115279372, 11524.250923689933, 10598.152147828001, 10621.575136994434, 10694.19793515505, 10747.355158690503, 10869.967353101443], "unit": "score", "name": "yui.html", "value": 6693.814622738442}], "name": "dromaeo_css", "value": 7221.896650038542}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 111.0, 112.0, 112.0, 99.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [160.0, 127.0, 156.0, 168.0, 127.0, 154.0, 155.0, 129.0, 181.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 161.0, 159.0, 159.0, 160.0, 166.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 77.0, 161.0, 74.0, 76.0, 77.0, 76.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 92.0, 143.0, 93.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 57.0, 57.0, 60.0, 57.0, 57.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [78.0, 81.0, 81.0, 80.0, 79.0, 79.0, 80.0, 79.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 120.0, 125.0, 116.0, 113.0, 111.0, 114.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 153.0, 153.0, 150.0, 142.0, 153.0, 154.0, 149.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 69.0, 68.0, 70.0, 67.0, 66.0, 70.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1511.7000000000003}]} 04:04:27 INFO - Return code: 0 04:04:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:04:27 INFO - # TBPL SUCCESS # 04:04:27 INFO - Running post-action listener: _resource_record_post_action 04:04:27 INFO - Running post-run listener: _resource_record_post_run 04:04:28 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 20480; Write bytes: 460148736; Read time: 52; Write time: 286108 04:04:28 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 237461504; Read time: 0; Write time: 174772 04:04:28 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 20480; Write bytes: 222281728; Read time: 52; Write time: 111312 04:04:28 INFO - Running post-run listener: _upload_blobber_files 04:04:28 INFO - Blob upload gear active. 04:04:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:28 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 04:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:29 INFO - (blobuploader) - INFO - Done attempting. 04:04:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:30 INFO - (blobuploader) - INFO - Done attempting. 04:04:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:30 INFO - Return code: 0 04:04:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92006b6e55462044c3834b53153bfd98bebf625f8f4465c49715719e9abceb0026ad3a7361fd70108dfcadbc43ed9608178fd94289adbf458c3c055ac0d2f3cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14761f5a963fdbcb8142ecccda8c4f0443ddebc5790f975557aa7fa7f4b3940d780083a91f34dab891dbdfc295e9977db0fd97de530595d66e84089ac43a7118"} 04:04:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:30 INFO - Contents: 04:04:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92006b6e55462044c3834b53153bfd98bebf625f8f4465c49715719e9abceb0026ad3a7361fd70108dfcadbc43ed9608178fd94289adbf458c3c055ac0d2f3cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14761f5a963fdbcb8142ecccda8c4f0443ddebc5790f975557aa7fa7f4b3940d780083a91f34dab891dbdfc295e9977db0fd97de530595d66e84089ac43a7118"} 04:04:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:30 INFO - Copying logs to upload dir... 04:04:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.637397 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-11 04:04:30.326820) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:30.330199) ========= 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=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92006b6e55462044c3834b53153bfd98bebf625f8f4465c49715719e9abceb0026ad3a7361fd70108dfcadbc43ed9608178fd94289adbf458c3c055ac0d2f3cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14761f5a963fdbcb8142ecccda8c4f0443ddebc5790f975557aa7fa7f4b3940d780083a91f34dab891dbdfc295e9977db0fd97de530595d66e84089ac43a7118"} build_url:https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/c6mxxdgbSpS8UwSynyWwcA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92006b6e55462044c3834b53153bfd98bebf625f8f4465c49715719e9abceb0026ad3a7361fd70108dfcadbc43ed9608178fd94289adbf458c3c055ac0d2f3cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14761f5a963fdbcb8142ecccda8c4f0443ddebc5790f975557aa7fa7f4b3940d780083a91f34dab891dbdfc295e9977db0fd97de530595d66e84089ac43a7118"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:30.356758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:30.357327) ========= 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=00204705a9daa57ed339a427000001b9-1462963445.830103-876461673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 04:04:30.443137) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:04:30.443465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 04:04:30.443779) ========= ========= Total master_lag: 0.19 =========