builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1465250005.5 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.504645) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.505098) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.505669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.544060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.544315) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 14:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.0M=0s 2016-06-06 14:53:25 (70.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139916 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.698759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.699034) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022932 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.748211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:25.748557) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 14:53:25,798 truncating revision to first 12 chars 2016-06-06 14:53:25,798 Setting DEBUG logging. 2016-06-06 14:53:25,798 attempt 1/10 2016-06-06 14:53:25,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:53:26,164 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:26.452695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:26.452998) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:26.453384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:26.453665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:53:26.463510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-06 14:53:26.463820) ========= /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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:53:26 INFO - MultiFileLogger online at 20160606 14:53:26 in /builds/slave/test 14:53:26 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 14:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:26 INFO - {'append_to_log': False, 14:53:26 INFO - 'base_work_dir': '/builds/slave/test', 14:53:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:26 INFO - 'branch': 'Mozilla-Beta', 14:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:26 INFO - 'config_files': ('talos/linux_config.py',), 14:53:26 INFO - 'default_actions': ('clobber', 14:53:26 INFO - 'read-buildbot-config', 14:53:26 INFO - 'download-and-extract', 14:53:26 INFO - 'populate-webroot', 14:53:26 INFO - 'create-virtualenv', 14:53:26 INFO - 'install', 14:53:26 INFO - 'run-tests'), 14:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:26 INFO - 'download_minidump_stackwalk': True, 14:53:26 INFO - 'download_symbols': 'ondemand', 14:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:26 INFO - 'installer_path': 'installer.exe', 14:53:26 INFO - 'log_level': 'info', 14:53:26 INFO - 'log_name': 'talos', 14:53:26 INFO - 'log_to_console': True, 14:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:53:26 INFO - 'opt_config_files': (), 14:53:26 INFO - 'pip_index': False, 14:53:26 INFO - 'sps_profile': False, 14:53:26 INFO - 'sps_profile_interval': 0, 14:53:26 INFO - 'suite': 'dromaeojs', 14:53:26 INFO - 'system_bits': '32', 14:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:26 INFO - 'title': 'talos-linux64-ix-036', 14:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:26 INFO - 'use_talos_json': True, 14:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:26 INFO - 'work_dir': 'build'} 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running clobber step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: clobber 14:53:26 INFO - rmtree: /builds/slave/test/build 14:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running read-buildbot-config step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: read_buildbot_config 14:53:27 INFO - Using buildbot properties: 14:53:27 INFO - { 14:53:27 INFO - "project": "", 14:53:27 INFO - "product": "firefox", 14:53:27 INFO - "script_repo_revision": "production", 14:53:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:53:27 INFO - "repository": "", 14:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:53:27 INFO - "buildid": "20160606120332", 14:53:27 INFO - "pgo_build": "True", 14:53:27 INFO - "basedir": "/builds/slave/test", 14:53:27 INFO - "buildnumber": 33, 14:53:27 INFO - "slavename": "talos-linux64-ix-036", 14:53:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:53:27 INFO - "platform": "ubuntu64_hw", 14:53:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:53:27 INFO - "branch": "mozilla-beta", 14:53:27 INFO - "repo_path": "releases/mozilla-beta", 14:53:27 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 14:53:27 INFO - "stage_platform": "linux64-pgo", 14:53:27 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 14:53:27 INFO - "slavebuilddir": "test" 14:53:27 INFO - } 14:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 14:53:27 INFO - Running post-action listener: _resource_record_post_action 14:53:27 INFO - ##### 14:53:27 INFO - ##### Running download-and-extract step. 14:53:27 INFO - ##### 14:53:27 INFO - Running pre-action listener: _resource_record_pre_action 14:53:27 INFO - Running main action method: download_and_extract 14:53:27 INFO - mkdir: /builds/slave/test/build/tests 14:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:27 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:53:27 INFO - Downloaded 1327 bytes. 14:53:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - Using the following test package requirements: 14:53:27 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:53:27 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:53:27 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 14:53:27 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'jsshell-linux-x86_64.zip'], 14:53:27 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:53:27 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 14:53:27 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 14:53:27 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 14:53:27 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:53:27 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:53:27 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:27 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:28 INFO - Downloaded 24177984 bytes. 14:53:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:30 INFO - Return code: 0 14:53:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:30 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 14:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:36 INFO - Downloaded 24177984 bytes. 14:53:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:37 INFO - Return code: 0 14:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:37 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 14:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:53:39 INFO - Downloaded 10840145 bytes. 14:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:53:39 INFO - Return code: 0 14:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:39 INFO - https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:53:40 INFO - Downloaded 56008216 bytes. 14:53:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:53:40 INFO - mkdir: /builds/slave/test/properties 14:53:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:40 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:40 INFO - Contents: 14:53:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 14:53:41 INFO - Running post-action listener: _resource_record_post_action 14:53:41 INFO - Running post-action listener: set_extra_try_arguments 14:53:41 INFO - ##### 14:53:41 INFO - ##### Running populate-webroot step. 14:53:41 INFO - ##### 14:53:41 INFO - Running pre-action listener: _resource_record_pre_action 14:53:41 INFO - Running main action method: populate_webroot 14:53:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:41 INFO - '--tppagecycles', 14:53:41 INFO - '7'], 14:53:41 INFO - 'tests': ['tsvgm']}}, 14:53:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['damp', 'tps']}, 14:53:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'tests': ['damp', 'tps']}, 14:53:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['dromaeo_dom']}, 14:53:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['a11yr', 14:53:41 INFO - 'ts_paint', 14:53:41 INFO - 'tpaint', 14:53:41 INFO - 'sessionrestore', 14:53:41 INFO - 'sessionrestore_no_auto_restore', 14:53:41 INFO - 'tabpaint']}, 14:53:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['tsvgx', 14:53:41 INFO - 'tsvgr_opacity', 14:53:41 INFO - 'tart', 14:53:41 INFO - 'tscrollx', 14:53:41 INFO - 'cart']}, 14:53:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:41 INFO - 'tsvgr_opacity', 14:53:41 INFO - 'tart', 14:53:41 INFO - 'tscrollx', 14:53:41 INFO - 'cart']}, 14:53:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'talos_options': ['--disable-e10s'], 14:53:41 INFO - 'tests': ['tp5o']}, 14:53:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'tests': ['tp5o']}, 14:53:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'talos_options': ['--disable-e10s', 14:53:41 INFO - '--xperf_path', 14:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:41 INFO - 'tests': ['tp5n']}, 14:53:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:41 INFO - 'talos_options': ['--xperf_path', 14:53:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:41 INFO - 'tests': ['tp5n']}}, 14:53:41 INFO - 'talos.zip': {'path': '', 14:53:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:41 INFO - Running post-action listener: _resource_record_post_action 14:53:41 INFO - ##### 14:53:41 INFO - ##### Running create-virtualenv step. 14:53:41 INFO - ##### 14:53:41 INFO - Running pre-action listener: _resource_record_pre_action 14:53:41 INFO - Running main action method: create_virtualenv 14:53:41 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:53:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:41 INFO - Using real prefix '/usr' 14:53:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:44 INFO - Installing pip.................done. 14:53:44 INFO - Return code: 0 14:53:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:44 INFO - Using env: {'DISPLAY': ':0', 14:53:44 INFO - 'HOME': '/home/cltbld', 14:53:44 INFO - 'LANG': 'en_US.UTF-8', 14:53:44 INFO - 'LANGUAGE': 'en_US:en', 14:53:44 INFO - 'LOGNAME': 'cltbld', 14:53:44 INFO - 'MAIL': '/var/mail/cltbld', 14:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:44 INFO - 'MOZ_NO_REMOTE': '1', 14:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:44 INFO - 'NO_EM_RESTART': '1', 14:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:44 INFO - 'PWD': '/builds/slave/test', 14:53:44 INFO - 'SHELL': '/bin/bash', 14:53:44 INFO - 'SHLVL': '1', 14:53:44 INFO - 'TERM': 'linux', 14:53:44 INFO - 'TMOUT': '86400', 14:53:44 INFO - 'USER': 'cltbld', 14:53:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:44 INFO - '_': '/tools/buildbot/bin/python'} 14:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:53:44 INFO - Cleaning up... 14:53:44 INFO - Return code: 0 14:53:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:53:44 INFO - Using env: {'DISPLAY': ':0', 14:53:44 INFO - 'HOME': '/home/cltbld', 14:53:44 INFO - 'LANG': 'en_US.UTF-8', 14:53:44 INFO - 'LANGUAGE': 'en_US:en', 14:53:44 INFO - 'LOGNAME': 'cltbld', 14:53:44 INFO - 'MAIL': '/var/mail/cltbld', 14:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:44 INFO - 'MOZ_NO_REMOTE': '1', 14:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:44 INFO - 'NO_EM_RESTART': '1', 14:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:44 INFO - 'PWD': '/builds/slave/test', 14:53:44 INFO - 'SHELL': '/bin/bash', 14:53:44 INFO - 'SHLVL': '1', 14:53:44 INFO - 'TERM': 'linux', 14:53:44 INFO - 'TMOUT': '86400', 14:53:44 INFO - 'USER': 'cltbld', 14:53:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:44 INFO - '_': '/tools/buildbot/bin/python'} 14:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:44 INFO - Downloading/unpacking psutil>=0.7.1 14:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:46 INFO - Installing collected packages: psutil 14:53:46 INFO - Running setup.py install for psutil 14:53:46 INFO - building 'psutil._psutil_linux' extension 14:53:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:53:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:53:46 INFO - building 'psutil._psutil_posix' extension 14:53:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:53:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:47 INFO - Successfully installed psutil 14:53:47 INFO - Cleaning up... 14:53:47 INFO - Return code: 0 14:53:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:53:47 INFO - Using env: {'DISPLAY': ':0', 14:53:47 INFO - 'HOME': '/home/cltbld', 14:53:47 INFO - 'LANG': 'en_US.UTF-8', 14:53:47 INFO - 'LANGUAGE': 'en_US:en', 14:53:47 INFO - 'LOGNAME': 'cltbld', 14:53:47 INFO - 'MAIL': '/var/mail/cltbld', 14:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:47 INFO - 'MOZ_NO_REMOTE': '1', 14:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:47 INFO - 'NO_EM_RESTART': '1', 14:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:47 INFO - 'PWD': '/builds/slave/test', 14:53:47 INFO - 'SHELL': '/bin/bash', 14:53:47 INFO - 'SHLVL': '1', 14:53:47 INFO - 'TERM': 'linux', 14:53:47 INFO - 'TMOUT': '86400', 14:53:47 INFO - 'USER': 'cltbld', 14:53:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:47 INFO - '_': '/tools/buildbot/bin/python'} 14:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:53:49 INFO - Installing collected packages: mozsystemmonitor 14:53:49 INFO - Running setup.py install for mozsystemmonitor 14:53:49 INFO - Successfully installed mozsystemmonitor 14:53:49 INFO - Cleaning up... 14:53:49 INFO - Return code: 0 14:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:53:49 INFO - Using env: {'DISPLAY': ':0', 14:53:49 INFO - 'HOME': '/home/cltbld', 14:53:49 INFO - 'LANG': 'en_US.UTF-8', 14:53:49 INFO - 'LANGUAGE': 'en_US:en', 14:53:49 INFO - 'LOGNAME': 'cltbld', 14:53:49 INFO - 'MAIL': '/var/mail/cltbld', 14:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:49 INFO - 'MOZ_NO_REMOTE': '1', 14:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:49 INFO - 'NO_EM_RESTART': '1', 14:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:49 INFO - 'PWD': '/builds/slave/test', 14:53:49 INFO - 'SHELL': '/bin/bash', 14:53:49 INFO - 'SHLVL': '1', 14:53:49 INFO - 'TERM': 'linux', 14:53:49 INFO - 'TMOUT': '86400', 14:53:49 INFO - 'USER': 'cltbld', 14:53:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:49 INFO - '_': '/tools/buildbot/bin/python'} 14:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:49 INFO - Downloading/unpacking blobuploader==1.2.4 14:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:53:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:53:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:52 INFO - Downloading docopt-0.6.1.tar.gz 14:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:53:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:53:52 INFO - Running setup.py install for blobuploader 14:53:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:53:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:53:52 INFO - Running setup.py install for requests 14:53:52 INFO - Running setup.py install for docopt 14:53:53 INFO - Successfully installed blobuploader requests docopt 14:53:53 INFO - Cleaning up... 14:53:53 INFO - Return code: 0 14:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:53 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 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:53:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:53 INFO - Using env: {'DISPLAY': ':0', 14:53:53 INFO - 'HOME': '/home/cltbld', 14:53:53 INFO - 'LANG': 'en_US.UTF-8', 14:53:53 INFO - 'LANGUAGE': 'en_US:en', 14:53:53 INFO - 'LOGNAME': 'cltbld', 14:53:53 INFO - 'MAIL': '/var/mail/cltbld', 14:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:53 INFO - 'MOZ_NO_REMOTE': '1', 14:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:53 INFO - 'NO_EM_RESTART': '1', 14:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:53 INFO - 'PWD': '/builds/slave/test', 14:53:53 INFO - 'SHELL': '/bin/bash', 14:53:53 INFO - 'SHLVL': '1', 14:53:53 INFO - 'TERM': 'linux', 14:53:53 INFO - 'TMOUT': '86400', 14:53:53 INFO - 'USER': 'cltbld', 14:53:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:53 INFO - '_': '/tools/buildbot/bin/python'} 14:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:53 INFO - Running setup.py (path:/tmp/pip-GKk6t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:53 INFO - Running setup.py (path:/tmp/pip-HaJnsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:53 INFO - Running setup.py (path:/tmp/pip-mpP7jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:53 INFO - Running setup.py (path:/tmp/pip-LOrY4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:53 INFO - Running setup.py (path:/tmp/pip-J6DnZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:53 INFO - Running setup.py (path:/tmp/pip-G9Rvy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:53 INFO - Running setup.py (path:/tmp/pip-Mlm9RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:53 INFO - Running setup.py (path:/tmp/pip-fCkYis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:53 INFO - Running setup.py (path:/tmp/pip-tP4qcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:53 INFO - Running setup.py (path:/tmp/pip-ppALU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:54 INFO - Running setup.py (path:/tmp/pip-smaBn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:54 INFO - Running setup.py (path:/tmp/pip-iQYNO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:54 INFO - Running setup.py (path:/tmp/pip-5uoLep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:54 INFO - Running setup.py (path:/tmp/pip-uXyf2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:54 INFO - Running setup.py (path:/tmp/pip-W4DApu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:54 INFO - Running setup.py (path:/tmp/pip-mee_6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:54 INFO - Running setup.py (path:/tmp/pip-rfFoVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:54 INFO - Running setup.py install for manifestparser 14:53:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:53:54 INFO - Running setup.py install for mozcrash 14:53:54 INFO - Running setup.py install for mozdebug 14:53:54 INFO - Running setup.py install for mozdevice 14:53:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:53:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:53:54 INFO - Running setup.py install for mozfile 14:53:55 INFO - Running setup.py install for mozhttpd 14:53:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for mozinfo 14:53:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for mozInstall 14:53:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for mozleak 14:53:55 INFO - Running setup.py install for mozlog 14:53:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for moznetwork 14:53:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for mozprocess 14:53:55 INFO - Running setup.py install for mozprofile 14:53:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:53:55 INFO - Running setup.py install for mozrunner 14:53:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:53:56 INFO - Running setup.py install for mozscreenshot 14:53:56 INFO - Running setup.py install for moztest 14:53:56 INFO - Running setup.py install for mozversion 14:53:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:53:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:56 INFO - Cleaning up... 14:53:56 INFO - Return code: 0 14:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:56 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 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:56 INFO - Using env: {'DISPLAY': ':0', 14:53:56 INFO - 'HOME': '/home/cltbld', 14:53:56 INFO - 'LANG': 'en_US.UTF-8', 14:53:56 INFO - 'LANGUAGE': 'en_US:en', 14:53:56 INFO - 'LOGNAME': 'cltbld', 14:53:56 INFO - 'MAIL': '/var/mail/cltbld', 14:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:56 INFO - 'MOZ_NO_REMOTE': '1', 14:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:56 INFO - 'NO_EM_RESTART': '1', 14:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:56 INFO - 'PWD': '/builds/slave/test', 14:53:56 INFO - 'SHELL': '/bin/bash', 14:53:56 INFO - 'SHLVL': '1', 14:53:56 INFO - 'TERM': 'linux', 14:53:56 INFO - 'TMOUT': '86400', 14:53:56 INFO - 'USER': 'cltbld', 14:53:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:56 INFO - '_': '/tools/buildbot/bin/python'} 14:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:56 INFO - Running setup.py (path:/tmp/pip-EGoOWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:56 INFO - Running setup.py (path:/tmp/pip-g1OkL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:56 INFO - Running setup.py (path:/tmp/pip-8O6Xwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:56 INFO - Running setup.py (path:/tmp/pip-HCGW3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:56 INFO - Running setup.py (path:/tmp/pip-HiFL3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:56 INFO - Running setup.py (path:/tmp/pip-vUUI9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:56 INFO - Running setup.py (path:/tmp/pip-Z17pPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:57 INFO - Running setup.py (path:/tmp/pip-VPxfSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:57 INFO - Running setup.py (path:/tmp/pip-G2kK7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:57 INFO - Running setup.py (path:/tmp/pip-kx1GfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:57 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)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:57 INFO - Running setup.py (path:/tmp/pip-nLWHNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:57 INFO - Running setup.py (path:/tmp/pip-m87esA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:57 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)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:57 INFO - Running setup.py (path:/tmp/pip-0eNRML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:57 INFO - Running setup.py (path:/tmp/pip-aYhSkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:57 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)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:57 INFO - Running setup.py (path:/tmp/pip-CbBqiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:57 INFO - Running setup.py (path:/tmp/pip-LI0pbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:57 INFO - Running setup.py (path:/tmp/pip-iPYOH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:59 INFO - Downloading blessings-1.6.tar.gz 14:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:59 INFO - Installing collected packages: blessings 14:53:59 INFO - Running setup.py install for blessings 14:53:59 INFO - Successfully installed blessings 14:53:59 INFO - Cleaning up... 14:53:59 INFO - Return code: 0 14:53:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:00 INFO - Reading from file tmpfile_stdout 14:54:00 INFO - Current package versions: 14:54:00 INFO - argparse == 1.2.1 14:54:00 INFO - blessings == 1.6 14:54:00 INFO - blobuploader == 1.2.4 14:54:00 INFO - docopt == 0.6.1 14:54:00 INFO - manifestparser == 1.1 14:54:00 INFO - mozInstall == 1.12 14:54:00 INFO - mozcrash == 0.17 14:54:00 INFO - mozdebug == 0.1 14:54:00 INFO - mozdevice == 0.48 14:54:00 INFO - mozfile == 1.2 14:54:00 INFO - mozhttpd == 0.7 14:54:00 INFO - mozinfo == 0.9 14:54:00 INFO - mozleak == 0.1 14:54:00 INFO - mozlog == 3.1 14:54:00 INFO - moznetwork == 0.27 14:54:00 INFO - mozprocess == 0.22 14:54:00 INFO - mozprofile == 0.28 14:54:00 INFO - mozrunner == 6.11 14:54:00 INFO - mozscreenshot == 0.1 14:54:00 INFO - mozsystemmonitor == 0.0 14:54:00 INFO - moztest == 0.7 14:54:00 INFO - mozversion == 1.4 14:54:00 INFO - psutil == 3.1.1 14:54:00 INFO - requests == 1.2.3 14:54:00 INFO - wsgiref == 0.1.2 14:54:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:00 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 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:54:00 INFO - Using env: {'DISPLAY': ':0', 14:54:00 INFO - 'HOME': '/home/cltbld', 14:54:00 INFO - 'LANG': 'en_US.UTF-8', 14:54:00 INFO - 'LANGUAGE': 'en_US:en', 14:54:00 INFO - 'LOGNAME': 'cltbld', 14:54:00 INFO - 'MAIL': '/var/mail/cltbld', 14:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:00 INFO - 'MOZ_NO_REMOTE': '1', 14:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:00 INFO - 'NO_EM_RESTART': '1', 14:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:00 INFO - 'PWD': '/builds/slave/test', 14:54:00 INFO - 'SHELL': '/bin/bash', 14:54:00 INFO - 'SHLVL': '1', 14:54:00 INFO - 'TERM': 'linux', 14:54:00 INFO - 'TMOUT': '86400', 14:54:00 INFO - 'USER': 'cltbld', 14:54:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:00 INFO - '_': '/tools/buildbot/bin/python'} 14:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:54:00 INFO - Cleaning up... 14:54:00 INFO - Return code: 0 14:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:00 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 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:54:00 INFO - Using env: {'DISPLAY': ':0', 14:54:00 INFO - 'HOME': '/home/cltbld', 14:54:00 INFO - 'LANG': 'en_US.UTF-8', 14:54:00 INFO - 'LANGUAGE': 'en_US:en', 14:54:00 INFO - 'LOGNAME': 'cltbld', 14:54:00 INFO - 'MAIL': '/var/mail/cltbld', 14:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:00 INFO - 'MOZ_NO_REMOTE': '1', 14:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:00 INFO - 'NO_EM_RESTART': '1', 14:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:00 INFO - 'PWD': '/builds/slave/test', 14:54:00 INFO - 'SHELL': '/bin/bash', 14:54:00 INFO - 'SHLVL': '1', 14:54:00 INFO - 'TERM': 'linux', 14:54:00 INFO - 'TMOUT': '86400', 14:54:00 INFO - 'USER': 'cltbld', 14:54:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:00 INFO - '_': '/tools/buildbot/bin/python'} 14:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:00 INFO - Downloading/unpacking jsonschema 14:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:02 INFO - Downloading/unpacking functools32 (from jsonschema) 14:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:02 INFO - warning: no files found matching '*.txt' 14:54:02 INFO - no previously-included directories found matching 'build' 14:54:02 INFO - no previously-included directories found matching 'dist' 14:54:02 INFO - no previously-included directories found matching '.git*' 14:54:02 INFO - Installing collected packages: jsonschema, functools32 14:54:02 INFO - Running setup.py install for functools32 14:54:02 INFO - warning: no files found matching '*.txt' 14:54:02 INFO - no previously-included directories found matching 'build' 14:54:02 INFO - no previously-included directories found matching 'dist' 14:54:02 INFO - no previously-included directories found matching '.git*' 14:54:02 INFO - Successfully installed jsonschema functools32 14:54:02 INFO - Cleaning up... 14:54:02 INFO - Return code: 0 14:54:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f742ecaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a705a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:54:02 INFO - Using env: {'DISPLAY': ':0', 14:54:02 INFO - 'HOME': '/home/cltbld', 14:54:02 INFO - 'LANG': 'en_US.UTF-8', 14:54:02 INFO - 'LANGUAGE': 'en_US:en', 14:54:02 INFO - 'LOGNAME': 'cltbld', 14:54:02 INFO - 'MAIL': '/var/mail/cltbld', 14:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:02 INFO - 'MOZ_NO_REMOTE': '1', 14:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:02 INFO - 'NO_EM_RESTART': '1', 14:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:02 INFO - 'PWD': '/builds/slave/test', 14:54:02 INFO - 'SHELL': '/bin/bash', 14:54:02 INFO - 'SHLVL': '1', 14:54:02 INFO - 'TERM': 'linux', 14:54:02 INFO - 'TMOUT': '86400', 14:54:02 INFO - 'USER': 'cltbld', 14:54:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:02 INFO - '_': '/tools/buildbot/bin/python'} 14:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:03 INFO - Downloading/unpacking flake8 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:54:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:54:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:05 INFO - no previously-included directories found matching 'docs/_build' 14:54:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:54:05 INFO - Running setup.py install for pep8 14:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:06 INFO - no previously-included directories found matching 'docs/_build' 14:54:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:54:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:54:06 INFO - Cleaning up... 14:54:06 INFO - Return code: 0 14:54:06 INFO - Running post-action listener: _resource_record_post_action 14:54:06 INFO - Running post-action listener: _start_resource_monitoring 14:54:06 INFO - Starting resource monitoring. 14:54:06 INFO - ##### 14:54:06 INFO - ##### Running install step. 14:54:06 INFO - ##### 14:54:06 INFO - Running pre-action listener: _resource_record_pre_action 14:54:06 INFO - Running main action method: install 14:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:06 INFO - Reading from file tmpfile_stdout 14:54:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:06 INFO - Reading from file tmpfile_stdout 14:54:06 INFO - Output received: 14:54:06 INFO - Usage: mozinstall [options] installer 14:54:06 INFO - Options: 14:54:06 INFO - -h, --help show this help message and exit 14:54:06 INFO - -d DEST, --destination=DEST 14:54:06 INFO - Directory to install application into. [default: 14:54:06 INFO - "/builds/slave/test"] 14:54:06 INFO - --app=APP Application being installed. [default: firefox] 14:54:06 INFO - mkdir: /builds/slave/test/build/application 14:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:54:19 INFO - Reading from file tmpfile_stdout 14:54:19 INFO - Output received: 14:54:19 INFO - /builds/slave/test/build/application/firefox/firefox 14:54:19 INFO - Running post-action listener: _resource_record_post_action 14:54:19 INFO - ##### 14:54:19 INFO - ##### Running run-tests step. 14:54:19 INFO - ##### 14:54:19 INFO - Running pre-action listener: _resource_record_pre_action 14:54:19 INFO - Running main action method: run_tests 14:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:19 INFO - Python 2.7.3 14:54:19 INFO - Return code: 0 14:54:19 INFO - grabbing minidump binary from tooltool 14:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:19 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 0x1aff410>, '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 0x1b00310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b007a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:54:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:54:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:19 INFO - Return code: 0 14:54:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:54:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:54:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:54:20 INFO - Return code: 0 14:54:20 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:54:20 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 14:54:20 INFO - Using env: {'DISPLAY': ':0', 14:54:20 INFO - 'HOME': '/home/cltbld', 14:54:20 INFO - 'LANG': 'en_US.UTF-8', 14:54:20 INFO - 'LANGUAGE': 'en_US:en', 14:54:20 INFO - 'LOGNAME': 'cltbld', 14:54:20 INFO - 'MAIL': '/var/mail/cltbld', 14:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:20 INFO - 'MOZ_NO_REMOTE': '1', 14:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:20 INFO - 'NO_EM_RESTART': '1', 14:54:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:20 INFO - 'PWD': '/builds/slave/test', 14:54:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:20 INFO - 'SHELL': '/bin/bash', 14:54:20 INFO - 'SHLVL': '1', 14:54:20 INFO - 'TERM': 'linux', 14:54:20 INFO - 'TMOUT': '86400', 14:54:20 INFO - 'USER': 'cltbld', 14:54:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888', 14:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:20 INFO - '_': '/tools/buildbot/bin/python'} 14:54:20 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/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 14:54:20 INFO - mozversion application_buildid: 20160606120332 14:54:20 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 14:54:20 INFO - mozversion application_display_name: Firefox 14:54:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:20 INFO - mozversion application_name: Firefox 14:54:20 INFO - mozversion application_remotingname: firefox 14:54:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:20 INFO - mozversion application_vendor: Mozilla 14:54:20 INFO - mozversion application_version: 48.0 14:54:20 INFO - mozversion platform_buildid: 20160606120332 14:54:20 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 14:54:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:54:20 INFO - mozversion platform_version: 48.0 14:54:20 INFO - using testdate: 1465250060 14:54:20 INFO - actual date: 1465250060 14:54:20 INFO - starting webserver on 'localhost:35754' 14:54:20 INFO - SUITE-START | Running 2 tests 14:54:20 INFO - TEST-START | dromaeo_css 14:54:20 INFO - operating with platform_type : linux_ 14:54:20 INFO - Initialising browser for dromaeo_css test... 14:54:20 INFO - TEST-INFO | started process 32530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmh5nX/profile http://localhost:35754/getInfo.html) 14:54:24 INFO - PROCESS | 32530 | __metrics Screen width/height:1600/1200 14:54:24 INFO - PROCESS | 32530 | colorDepth:24 14:54:24 INFO - PROCESS | 32530 | Browser inner width/height: 1024/697 14:54:24 INFO - PROCESS | 32530 | __metrics 14:54:25 ERROR - PROCESS | 32530 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:54:26 INFO - TEST-INFO | 32530: exit 0 14:54:26 INFO - Browser initialized. 14:54:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:26 INFO - TEST-INFO | started process 32620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmh5nX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:38 INFO - PROCESS | 32620 | RSS: Main: 140652544 14:54:38 INFO - PROCESS | 32620 | 14:55:29 INFO - PROCESS | 32620 | 1465250129638 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:57:37 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35754/tests/dromaeo/cssquery-ext.html) 14:57:38 INFO - PROCESS | 32620 | RSS: Main: 249942016 14:57:38 INFO - PROCESS | 32620 | 15:00:40 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-ext.html (next: http://localhost:35754/tests/dromaeo/cssquery-jquery.html) 15:00:40 INFO - PROCESS | 32620 | RSS: Main: 231882752 15:00:40 INFO - PROCESS | 32620 | 15:03:42 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35754/tests/dromaeo/cssquery-mootools.html) 15:03:43 INFO - PROCESS | 32620 | RSS: Main: 212422656 15:03:43 INFO - PROCESS | 32620 | 15:06:44 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35754/tests/dromaeo/cssquery-prototype.html) 15:06:45 INFO - PROCESS | 32620 | RSS: Main: 219009024 15:06:45 INFO - PROCESS | 32620 | 15:09:47 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35754/tests/dromaeo/cssquery-yui.html) 15:09:48 INFO - PROCESS | 32620 | RSS: Main: 213344256 15:09:48 INFO - PROCESS | 32620 | 15:12:50 INFO - PROCESS | 32620 | Cycle 1(1): loaded http://localhost:35754/tests/dromaeo/cssquery-yui.html (next: http://localhost:35754/tests/dromaeo/cssquery-dojo.html) 15:12:51 INFO - PROCESS | 32620 | RSS: Main: 258072576 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | __start_tp_report 15:12:51 INFO - PROCESS | 32620 | _x_x_mozilla_page_load 15:12:51 INFO - PROCESS | 32620 | _x_x_mozilla_page_load_details 15:12:51 INFO - PROCESS | 32620 | |i|pagename|runs| 15:12:51 INFO - PROCESS | 32620 | |0;dojo.html;3265.8530366133523;3302.785318954268;3317.220453193499;3322.568066151403;3365.7475689323305;5391.649542779716;5426.864328391787;5433.429489903562;5439.972800135999;5449.128139497681;5440.4287549807295;5449.482299181582;5473.233747275374;5482.671039737608;5503.697296648683;4865.051314993578;4879.560839524442;4925.384326959121;4997.825076122336;5037.949620503803;4902.950970490303;4923.212286034235;4930.852074437773;5004.699718016931;5008.549230569248;4929.630277729167;5027.798888044474;5091.516305950929;5106.668066575679;5116.667416617926;5047.242913562958;5065.392152941634;5072.391313042422;5087.643864929457;5118.795248190087;4837.975810120962;4899.191633380488;4967.801287948478;4973.5772459341;4988.052270068675;5335.146376579767;5374.140137577969;5391.433899440581;5410.48600382963;5414.485623865727;5863.794767183171;5895.616784908967;5895.823125306248;5898.174255604219;5903.35063143054;5845.707714614252;5922.230110085704;5930.55520835939;5980.162777211194;6002.189704389895;5486.1222204447495;5512.062949298629;5535.114381698909;5537.0863807471715;5539.307586551681;5860.70696465175;6015.879682406415;6029.698515074228;6034.668093254913;6035.969820150871;5748.109043098327;5814.127880817911;5831.241938547962;5832.825015249549;5837.6497410155525;5839.357670656224;5841.474267315877;5849;5850.0932355484965;5853.5317174625925;5663.150527420919;5750.194972703741;5806.883862322815;5819.214406055213;5831.650100993954;5876;5881.000229960917;5885.676287804126;5889.146073819272;5924.496417804448;4503.81984720614;4504.144212599595;4504.391907092566;4508.549145085531;4534.79593418297;3957.6438120569287;3959.92080158401;4029.7582145070805;4048.8987775305263;4056.7971601419813;5592.944070559323;5608.6073974821375;5615.298087739033;5621.241132447149;5633.352164501053;5941.405859414024;5942.465178133989;5943.881122377528;5948.702564871739;5949.286085669747;5459.863503412446;5565.972170139124;5610.214569960209;5629.493345598916;5668.518175955008;5048.343715316985;5062.11413002723;5070.543651071422;5075.746212689351;5076.36545431821;6019;6036.607620504653;6036.667983260875;6040.697965101727;6091.208142941389;5737.5983681141915;5929.6145750526075;6012.428819262163;6019.277686677627;6052.122442245938;6016.87966240664;6023;6024.0662697282;6025.307089684742;6025.487833534199;5576.749046293007;5725.656460612377;5746.597738158289;5750.856228594319;5759.90561793258;5932.8813423732145;6039.698015099139;6041.728122234422;6048.183495228264;6085.908711369421;5724.4275572444085;5741.822926300182;5746.942530574641;5760.395158508296;5768.798092066758;5590.189422533791;5703.828885133453;5705.22979397776;5741.741621626953;5751.712414379181;5649.774009039593;5666.744996475086;5672.602917795714;5689.886202276014;5720.513756330759;5788.565857560784;5798.768049277982;5804.390538993345;5812.3025236971835;5819;5625.803096891753;5699.316082070178;5715.685637289989;5739.196512488338;5810.82567522975 15:12:51 INFO - PROCESS | 32620 | |1;ext.html;603.4960807725549;660.7390080918037;671.5165081141577;674.3357792574315;692.8683550125472;33195.99999999997;33840;33850;33871.66128338716;40226.7988660057;44331.33502997458;44911.550884491146;44926;44928.77535612317;45081.77459112708;8802.86795698065;8981.820363592724;8983.46099234048;8984.19142277195;8985.14641109097;8842.557872106401;8932.508712020835;8950.552472376356;8967.506787126706;8970.820583588324;8925.330600204978;9211.170994610484;9214;9216.907830921671;9217.216536594364;9119.908800911971;9200.861987070199;9202.171804537556;9202.631894724203;9206.861897071516;8976.192142707188;9070;9080.954595227047;9096.90903090974;9103.590338434786;43915.56084439147;44515;44560.3315950261;44671.55328446707;44688.3296750549;3699.85200591976;3783.8297276622343;4039.656629186523;4149.398337241083;4630.72215667061;30722;30843.228919276975;30863;31009.069727908198;32512.187195320068;4407.625351845097;4489.573490518395;4494.68537202396;4501.504834468205;4528.8867778305475;293991;295495;295939;296837;297765;38727.80636096802;61825.38174618286;63490.682546587894;63580.36419635837;63605;37631.05922351963;37662;37768.811155944044;37788;37800.62199378026;15831.287592058385;16118.194090295437;16118.435854745028;16139.193040347936;16142.596435089217;13149.145305555108;13266.270355130368;13299.268540230187;13333.733325333438;13356.46574137043;9282.72151835446;9374.156325930562;9494.857577136348;9503.524823758784;9580.712578622653;3544.220271540257;3673.8897833065053;3724.646158614927;3742.8128593570214;3755.7370984030854;1079.978400431987;1098.4562641492512;1139.8518192634904;1157.1437136518916;1226.3316492511603;34588.347907588795;35026.474602880975;35196;35288.64711352905;35330.82334588362;1213.0356366688504;1215.9513619455122;1285.0940087238475;1288.8002359634272;1319.5711393797055;17949.641007179784;18050.3682371119;18160.273589056553;18204.271829126952;18307.450776476726;465259;470372;471205;471321;472337;62172.68913655493;63087.05369419463;63142.68428657919;63230.68384658139;63492.36507634957;1467.2517016321754;1531.525227179578;1540.2221877951563;1557.9610509737347;1609.4045203274864;34477.13807154841;35758.64241357657;36266.456003159445;36371.81814091018;36525.63474365223;51107.488925111764;51847.222291664904;51849;51859.2221116676;51916.740416297675;352266;354473;356504;357504;451249;30144.3971120572;31597.21006974844;31738.20654483564;31748.68251317457;31757.20606984844;44473.33290000588;44840.77579612081;44841.32738008998;45688.31467528056;46342;37180;38082.61917380791;38259.42610860895;38467.61532384752;38544.6145538541;37758.43362349622;37844.432333514465;38021.619783801805;41000.589994099675;41148.79425602853;42880.57119428766;43491;43502.782486087366;43682.78158609186;44149;35019;36229.27541449209;36379.81810091039;36513.81743091268;36876.815615922824;28459.146225613265;28511.0401582945;28643.28391790222;28683.940303268766;29179.708202918548 15:12:51 INFO - PROCESS | 32620 | |2;jquery.html;427.68137737385655;427.7967965216521;441.2564828264376;442.6458832933653;444.88210624184575;18555.443336699886;18590.814091859076;18599.535011624717;19317.71023434648;19408.126634301454;18477.630447391046;18515.444536663887;18691.81308186918;19152.329668461607;19593.412197634058;5725.08398656214;5797.246357973458;5819.6508209507565;5832;5906.143609176666;5630.465105814961;5734.541236701075;5750.33871104822;5845.0647896336595;5853.063509838426;5678.716064196794;5763.740631671564;5806.738696758634;5826.21346118275;5856.648601083927;5767.567432442584;5810.680412577307;5821.126830975345;5824.504917082053;5829.708514574276;5213.765380557884;5244.265802787613;5266.9202813423535;5291;5301.973490132563;22908;23036.53926921469;23373.065077397056;23398.53202935949;23409.88295058531;2608.8956441742307;2629.7764690001372;2631.8815653295646;2636.947261054768;2919.2409973406857;14445.927770361186;14702.852971470254;14841.257937103102;14990.700185996218;14994.175320357375;1944.4944314478196;2014.4027812267198;2029.7767245602972;2037.2360364863177;2067.7105205271273;76182.61908690477;77584;78372.21627783705;78740.21259787386;80575.59712201402;10171.84742228867;10453.581856725797;11001.394923279136;11198.832017519744;11214.383208923424;15628.2185890705;15655.060696358254;15727.292271847795;15733.44932927365;15774.9211253943;8093;8305.709300174465;8451.45065570736;8469;8530.74407767768;7974.880376794353;7980;8031.237032482021;8110.675572977133;8114.918850811534;4931.50684931504;4961.603071754251;4980.551750342486;4982.90034199314;4994.925076123861;1979.4853338131902;1985.3547597031022;2004.7894971028124;2037.3480486244555;2061.845361597886;470.12791272190276;481.75912043978013;939.1219210038636;1063.2079101069598;1193.928364298145;11055.170862185207;11076.39079850616;11085.390303533382;11091.500882460308;11262.549498020151;486.5475108149455;487.3542556113093;492.58130588999063;493.1837808427059;498.4218306764209;6022.247219097613;6023.27720673522;6046.093086037042;6136.417040381157;6175.660338681326;503764;524079;524740.7629618504;532493;532636;96529;98501;98905.50547247217;98971;99231.50384248032;509.0557016733905;509.23360342684765;510.2168171856183;511.2101802714815;515.2503107977883;10847.891521084688;10935.781284374427;10971.561137554727;10999.505022273857;11207.551697932318;39036.21927561376;39274.6072539271;39292.80353598214;40183.79908100441;40361.79819100886;57442.7127864358;58756;58757;59202.70398647979;59211.40788592059;8610.913890861262;8725.956370218108;8738.563071846509;8748.91251087481;8949.910500894908;9735.951320243637;13361.799573006607;13387.732245354844;13575.52485662997;13676.794848077088;6303.086052522451;11517.59688410935;11621.418929053345;12025.977791887437;12026.939865300967;11526.82709759371;11583.594574189863;11648.592299269485;12045.09661775388;12240.816387754012;12162.695932601402;12201.267923924594;12374.195677280948;12389.690257743268;12491.75016499683;8360.540170290693;8394.580270986304;8593.81221629372;8640.35197360213;8857.335699822668;8852.822943541221;11177.441127943408;12274.693132671397;12286.81569776472;12314.938425307817 15:12:51 INFO - PROCESS | 32620 | |3;mootools.html;1413.448754985555;1527.5646440764385;1546.327347603792;1723.4140392266627;1857.5541869951207;7492.962535187323;8191.672333106676;8323.667053317875;8334.958325208381;8352.624131914063;8173.959130204341;8309.584520773968;8310.168983101687;8315.792105197374;8317.667293308261;2374.121575017246;2393.293978276404;2397.6883005209297;2397.9160729374476;2399.4121440247077;2355.9411014724596;2378.5599664062115;2394.545036443079;2399.2082612737754;2414.106780491212;2353.0587764894008;2364.125273648752;2370.3126093432884;2388.940276493093;2390.103711108334;2348.1664009276633;2359.1978727232736;2360.7639236076343;2363.102021231938;2408.229366602688;2283.2579411691268;2329.3827135809024;2337.7194736631714;2349.6475528670667;2351.6354964980455;7308.634568271618;8042.919570804334;8617.439866408664;8668.26319762821;8695.565221738887;5201.973990130063;5279.5512381447625;5329.307190065306;5330.387005494379;5342.813001544927;3314.0720598232533;3347.3640008398324;3364.680355366236;3372.5278461015478;3418.470137128724;1079.228351728518;1156.699258192876;1161.7153797319627;1165.4231155578043;1165.7377090154732;11744.70638234051;12107.93946030273;12132.15074944763;12137.575184868487;12140.514379424812;4667.159911216014;4690.319903613957;4765.142274390573;4803.087413391444;4824.179889418807;9729.4648794317;9802.65690700822;9816.754581135528;9821.80356392868;9824.214062874953;5358;5406;5408.107662235687;5412;5416.593755468356;4939.1109600271575;4982.975085124551;5000.224965130411;5002.024605201951;5002.74986250686;3877.86427475037;3930.6855451563806;3952.7233093683167;3966.2265858157957;3972.245273398045;1179.180469573638;1181.232199070611;1186.525389844052;1212.9090318226167;1225.6139316115396;952.9857052144223;1082.588616325807;1083.9620613278498;1102.1072930925816;1110.566878917223;6129.356417576179;6186.969065154645;6291.087792270187;6291.811245662638;6361;1008.369768894441;1058.5871510111062;1067.5836423794726;1076.6500887211687;1085.6308854989184;4246.129543443587;4296.591823776736;4298.548652391516;4320.762358070274;4324.459442569679;10189.898101018895;10625.415602141957;10649.84025239622;10654.200934929911;10661.413622250695;10478.947605261925;10488.4231367274;10493.790124197474;10494.265401421828;10498.160147188206;7784.143744188134;7939.523628582304;8009.998750156347;8077.273045425823;8244.54654993981;5977.282726072899;5995.310539288038;6092.086187071975;6101.84745381369;6106.5114790817515;9166.495842728447;9192.770180745534;9206.447613142966;9305.395149315273;9354.672586459714;9148.359614827164;9317.813643727222;9417.152456278967;9529.571169297536;9580.13778759915;7662.578558179353;7769.611519424119;7774.533527988113;7836.92163078362;7842.019747531559;7851.450398472052;7946.721864734706;7988.081370642451;8230.341572674291;8234.300084492885;7361.1166660001145;7431;7574.734884279023;7585.582792946441;7640.503367281109;7202.639868006683;7225.169105552929;7266.67299971492;7300.452466065172;7365.668544915385;6749.190097188369;6817.420519255918;6823.522353435212;6850.554713943578;6854.383105520527;5135.178371460698;5216.40011398694;5243.58051355883;5362.624616276823;5458.372287187024;5285.471452854684;5363;5414;5430.592705547021;5435.782568697208 15:12:51 INFO - PROCESS | 32620 | |4;prototype.html;358.6288191721567;362.6554772965682;363.4675200830782;363.9253952939647;365.4171596303896;6258.0925765764;6315.684215789215;6375.649339286331;6380.936190638092;6384.233891932963;6273.654948977804;6282.780102696406;6283.465905398047;6292.433680968712;6312.431881130698;4590.311453282001;4663.510331415204;4775.307580400857;4793.688410253322;4807.759612019385;4756.429228492586;4773.952260477386;4775.14047471455;4783.306420569015;4793.688410253322;4582.541745825424;4744.169770290203;4751.881202969937;4754.524547545252;4755.453122890877;4641.187792136379;4671.205894997858;4718.433787945434;4718.622510199193;4765.404324459442;4214.346776249687;4218.409422680827;4223.704340696153;4223.97888010561;4228.978855105735;5993.160957465958;5998.700064996733;6000.609960352563;6007.639541627516;6014.0678194879865;5592.468715472024;5601.971990140064;5603.2715746953045;5604.047311956977;5606.915896261559;6408.743650254031;6601.306862779387;6602.306757790411;6607.93392066078;6611.6033038017395;4717.481077081518;4721.881952951204;4722.102800467935;4722.669413141081;4732.597729193023;6894.896576551356;6915;6928.515003949726;6929.618870962095;6930.13373328334;4829.372181616367;4829.541193586604;4830;4836.250381190921;4837.588804951548;4891.51084891508;4894.559489645949;4894.926576101361;4895.534924182197;4903.975480122576;5576.693281869536;5590.273264475592;5594.440555944373;5598.076317407582;5605.215269862141;6472.190976127984;6670.599764014175;6676.26561078281;6678.065070890079;6685.732570697118;1682.150513990427;1709.7435384692146;1721.888077274973;1725.3357457379;1725.8446739793228;1070.796548655753;1120.2046546951592;1135.1486385211092;1155.5608868629868;1171.5021116025655;6338.30278669346;6342.143810585512;6342.270638876496;6345.17512723343;6347.682615869188;6820.795376138723;6822.829429264308;6824.590524568542;6826.214985276757;6829.351211634887;6438.066480360321;6455.193100862392;6506.772262970773;6514.185726784152;6514.641694706742;3640.4175331946763;3684.1158122050515;3685.1708365618056;3688.354537955847;3692.132348898007;6864.862702745917;7156.534825236447;7158.892616610755;7171.677274522659;7171.820704482326;7010.579365238102;7035.718571257093;7041.788746337618;7085.256048114874;7090.468214883905;7125;7133.607651579109;7142.892856607155;7146.785596432115;7154.463415243774;6946.305369463215;6951.895721564079;6952.791416257521;6954.582725036514;6958.686859091252;6588.8352791180605;6778.932210678027;6807.047013418224;6807.761728339485;6827.48793840454;7020.6489675514995;7072.681729322296;7079.504434689522;7083.150021997393;7086.114235720535;4571.200039992921;4582.243929751554;4598.8620341389815;4600.42494688164;4608.677392582621;6823.454123670193;6828.760993365208;6835.555688880207;6843.3840954314355;6843.7604683835825;6510.707018184098;6645.767398141042;6650.434713049445;6656.900146497903;6658.300878407891;6588.934110659024;6596.571222870498;6611.107500487373;6626.204855417381;6633.9668301658185;6518.152640156749;6535.2811190768025;6538.803835884931;6538.934610654022;6539.967300163659;6680.365365290289;6691.966540167268;6694.531382803157;6695.899561506484;6700.262971073081;6420.807375778734;6537.182852143482;6551.967240163769;6557.704903279459;6560.3111673275525 15:12:51 INFO - PROCESS | 32620 | |5;yui.html;923.5464581645384;935.522883329502;943.5565284316377;965.3725078698845;969.3456916581306;15482.071075735465;15727;15778;15809.683806323881;15812.525624231277;14337.139771613685;14372.490888456718;14385.496507622236;14390.712185756278;14873.107613543169;894.3337213775729;898.8022635020318;900.2707806676581;900.333753022765;901.3375169250628;897.5422534507416;904.1230006893303;904.5341649050712;906.5829718329576;907.1790030022839;952.3476418653245;955.5461155950937;955.6034245787989;955.7180631713626;957.707899090777;945.957431915562;947.7772723410028;950.7623094226443;950.828850806858;951.5813042261383;696.2793508718452;702.034702284359;703.8381172330393;705.0728292295667;707.4375871182423;14671.926640366837;14694.11835289886;14705.338259778335;14735.852641473663;14744.926275368554;14639;14647.63380915475;14685.77971330431;14860.702785944328;14980.850191498055;11775.352355620438;11863.58477453285;11948;12090.758184836342;12097.274163550215;4012.277789997799;4031.596840315974;4047.453593764863;4069.8982525436804;4167.874963751062;49500.25749613759;53763;54329.72835135838;55395.72302138504;57700.134497982566;11818.231814932002;11846.348450835287;11949.761004779855;11951.641450756491;12074.456649450796;17123.74314385285;17142.828571714123;17284.91357543204;17311;17334.566635834206;8925.285977121815;9014.954925225333;9111.81776364469;9172.174504294646;9295.76760580991;4960;5085.466026067284;5119.462456442095;5156.716380599028;5169.560587350042;3659.2315613721416;3716.869909553153;3719.814009299524;3726.9440958385103;3732.0669832541867;650.4601181019742;683.5215349255541;734.2657342657343;742.6509540515949;754.7509321923752;636.3986033198676;686.7664993902097;687.1033301541437;696.24109720405;799.8440304140637;9713.660021899199;9809.754756131011;9868.80262394748;9869.309148359689;10035.297529173034;662.5163630549629;699.1016543741268;757.5454727163768;785.9017622797151;801.6913488307043;4670.719756814602;4840.15297322967;5019.14674505335;5109.182530795055;5111.258867464197;68892;69367.65316173488;70186;70689.2931070693;70702;60444.39555604476;61092;61905.38094619086;62519.374806252265;62777.68611156915;44541.94471635208;47818.760906195246;55640.72179639076;57757.42242577604;58477.70761146167;10225.693229203136;10427.113695335982;10444.373337599465;10451.895481045092;10546.314489558154;40045.39931900966;40178.39732403958;41329.58670413378;41865.79067104645;42214;51103.744481278845;53705.73147134239;54470.18294725662;55028.449715502335;55067.44932550623;12450.875491244971;12455.501779929064;12514.937425312815;12713.93643031779;12802;14049.719005620034;14475.203863787592;14489.420423183376;15091.924540377227;15275.770863436835;13319;13419.396127174496;13509.256990865597;13556.59330220095;14207.786883196553;13697.657558560717;13718.245496497788;13948.58154255374;13968.511102111377;14024.579262622137;13155.276459794803;13571.52499662507;13657.521986730417;14029.92985035109;14033.087849290172;11165.330080195214;11379.374134422686;11397.943010284895;11643.59247426336;11943.343116128697;11343.432828358384;11353.716157096138;11382;11539.942300288445;11614.76770464569 15:12:51 INFO - PROCESS | 32620 | __end_tp_report 15:12:51 INFO - PROCESS | 32620 | __start_cc_report 15:12:51 INFO - PROCESS | 32620 | _x_x_mozilla_cycle_collect,819 15:12:51 INFO - PROCESS | 32620 | __end_cc_report 15:12:51 INFO - PROCESS | 32620 | __startTimestamp1465251171067__endTimestamp 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | ------- Summary: start ------- 15:12:51 INFO - PROCESS | 32620 | Number of tests: 6 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#0] dojo.html Cycles:165 Average:5465.85 Median:5689.89 stddev:608.42 (10.7%) stddev-sans-first:585.29 15:12:51 INFO - PROCESS | 32620 | Values: 3265.9 3302.8 3317.2 3322.6 3365.7 5391.6 5426.9 5433.4 5440.0 5449.1 5440.4 5449.5 5473.2 5482.7 5503.7 4865.1 4879.6 4925.4 4997.8 5037.9 4903.0 4923.2 4930.9 5004.7 5008.5 4929.6 5027.8 5091.5 5106.7 5116.7 5047.2 5065.4 5072.4 5087.6 5118.8 4838.0 4899.2 4967.8 4973.6 4988.1 5335.1 5374.1 5391.4 5410.5 5414.5 5863.8 5895.6 5895.8 5898.2 5903.4 5845.7 5922.2 5930.6 5980.2 6002.2 5486.1 5512.1 5535.1 5537.1 5539.3 5860.7 6015.9 6029.7 6034.7 6036.0 5748.1 5814.1 5831.2 5832.8 5837.6 5839.4 5841.5 5849.0 5850.1 5853.5 5663.2 5750.2 5806.9 5819.2 5831.7 5876.0 5881.0 5885.7 5889.1 5924.5 4503.8 4504.1 4504.4 4508.5 4534.8 3957.6 3959.9 4029.8 4048.9 4056.8 5592.9 5608.6 5615.3 5621.2 5633.4 5941.4 5942.5 5943.9 5948.7 5949.3 5459.9 5566.0 5610.2 5629.5 5668.5 5048.3 5062.1 5070.5 5075.7 5076.4 6019.0 6036.6 6036.7 6040.7 6091.2 5737.6 5929.6 6012.4 6019.3 6052.1 6016.9 6023.0 6024.1 6025.3 6025.5 5576.7 5725.7 5746.6 5750.9 5759.9 5932.9 6039.7 6041.7 6048.2 6085.9 5724.4 5741.8 5746.9 5760.4 5768.8 5590.2 5703.8 5705.2 5741.7 5751.7 5649.8 5666.7 5672.6 5689.9 5720.5 5788.6 5798.8 5804.4 5812.3 5819.0 5625.8 5699.3 5715.7 5739.2 5810.8 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#1] ext.html Cycles:180 Average:54418.82 Median:38363.52 stddev:102388.41 (266.9%) stddev-sans-first:102595.91 15:12:51 INFO - PROCESS | 32620 | Values: 603.5 660.7 671.5 674.3 692.9 33196.0 33840.0 33850.0 33871.7 40226.8 44331.3 44911.6 44926.0 44928.8 45081.8 8802.9 8981.8 8983.5 8984.2 8985.1 8842.6 8932.5 8950.6 8967.5 8970.8 8925.3 9211.2 9214.0 9216.9 9217.2 9119.9 9200.9 9202.2 9202.6 9206.9 8976.2 9070.0 9081.0 9096.9 9103.6 43915.6 44515.0 44560.3 44671.6 44688.3 3699.9 3783.8 4039.7 4149.4 4630.7 30722.0 30843.2 30863.0 31009.1 32512.2 4407.6 4489.6 4494.7 4501.5 4528.9 293991.0 295495.0 295939.0 296837.0 297765.0 38727.8 61825.4 63490.7 63580.4 63605.0 37631.1 37662.0 37768.8 37788.0 37800.6 15831.3 16118.2 16118.4 16139.2 16142.6 13149.1 13266.3 13299.3 13333.7 13356.5 9282.7 9374.2 9494.9 9503.5 9580.7 3544.2 3673.9 3724.6 3742.8 3755.7 1080.0 1098.5 1139.9 1157.1 1226.3 34588.3 35026.5 35196.0 35288.6 35330.8 1213.0 1216.0 1285.1 1288.8 1319.6 17949.6 18050.4 18160.3 18204.3 18307.5 465259.0 470372.0 471205.0 471321.0 472337.0 62172.7 63087.1 63142.7 63230.7 63492.4 1467.3 1531.5 1540.2 1558.0 1609.4 34477.1 35758.6 36266.5 36371.8 36525.6 51107.5 51847.2 51849.0 51859.2 51916.7 352266.0 354473.0 356504.0 357504.0 451249.0 30144.4 31597.2 31738.2 31748.7 31757.2 44473.3 44840.8 44841.3 45688.3 46342.0 37180.0 38082.6 38259.4 38467.6 38544.6 37758.4 37844.4 38021.6 41000.6 41148.8 42880.6 43491.0 43502.8 43682.8 44149.0 35019.0 36229.3 36379.8 36513.8 36876.8 28459.1 28511.0 28643.3 28683.9 29179.7 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#2] jquery.html Cycles:180 Average:29559.96 Median:484.15 stddev:86343.87 (17834.0%) stddev-sans-first:86558.38 15:12:51 INFO - PROCESS | 32620 | Values: 427.7 427.8 441.3 442.6 444.9 18555.4 18590.8 18599.5 19317.7 19408.1 18477.6 18515.4 18691.8 19152.3 19593.4 5725.1 5797.2 5819.7 5832.0 5906.1 5630.5 5734.5 5750.3 5845.1 5853.1 5678.7 5763.7 5806.7 5826.2 5856.6 5767.6 5810.7 5821.1 5824.5 5829.7 5213.8 5244.3 5266.9 5291.0 5302.0 22908.0 23036.5 23373.1 23398.5 23409.9 2608.9 2629.8 2631.9 2636.9 2919.2 14445.9 14702.9 14841.3 14990.7 14994.2 1944.5 2014.4 2029.8 2037.2 2067.7 76182.6 77584.0 78372.2 78740.2 80575.6 10171.8 10453.6 11001.4 11198.8 11214.4 15628.2 15655.1 15727.3 15733.4 15774.9 8093.0 8305.7 8451.5 8469.0 8530.7 7974.9 7980.0 8031.2 8110.7 8114.9 4931.5 4961.6 4980.6 4982.9 4994.9 1979.5 1985.4 2004.8 2037.3 2061.8 470.1 481.8 939.1 1063.2 1193.9 11055.2 11076.4 11085.4 11091.5 11262.5 486.5 487.4 492.6 493.2 498.4 6022.2 6023.3 6046.1 6136.4 6175.7 503764.0 524079.0 524740.8 532493.0 532636.0 96529.0 98501.0 98905.5 98971.0 99231.5 509.1 509.2 510.2 511.2 515.3 10847.9 10935.8 10971.6 10999.5 11207.6 39036.2 39274.6 39292.8 40183.8 40361.8 57442.7 58756.0 58757.0 59202.7 59211.4 8610.9 8726.0 8738.6 8748.9 8949.9 9736.0 13361.8 13387.7 13575.5 13676.8 6303.1 11517.6 11621.4 12026.0 12026.9 11526.8 11583.6 11648.6 12045.1 12240.8 12162.7 12201.3 12374.2 12389.7 12491.8 8360.5 8394.6 8593.8 8640.4 8857.3 8852.8 11177.4 12274.7 12286.8 12314.9 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#3] mootools.html Cycles:180 Average:5684.03 Median:5209.19 stddev:3086.40 (59.2%) stddev-sans-first:3078.37 15:12:51 INFO - PROCESS | 32620 | Values: 1413.4 1527.6 1546.3 1723.4 1857.6 7493.0 8191.7 8323.7 8335.0 8352.6 8174.0 8309.6 8310.2 8315.8 8317.7 2374.1 2393.3 2397.7 2397.9 2399.4 2355.9 2378.6 2394.5 2399.2 2414.1 2353.1 2364.1 2370.3 2388.9 2390.1 2348.2 2359.2 2360.8 2363.1 2408.2 2283.3 2329.4 2337.7 2349.6 2351.6 7308.6 8042.9 8617.4 8668.3 8695.6 5202.0 5279.6 5329.3 5330.4 5342.8 3314.1 3347.4 3364.7 3372.5 3418.5 1079.2 1156.7 1161.7 1165.4 1165.7 11744.7 12107.9 12132.2 12137.6 12140.5 4667.2 4690.3 4765.1 4803.1 4824.2 9729.5 9802.7 9816.8 9821.8 9824.2 5358.0 5406.0 5408.1 5412.0 5416.6 4939.1 4983.0 5000.2 5002.0 5002.7 3877.9 3930.7 3952.7 3966.2 3972.2 1179.2 1181.2 1186.5 1212.9 1225.6 953.0 1082.6 1084.0 1102.1 1110.6 6129.4 6187.0 6291.1 6291.8 6361.0 1008.4 1058.6 1067.6 1076.7 1085.6 4246.1 4296.6 4298.5 4320.8 4324.5 10189.9 10625.4 10649.8 10654.2 10661.4 10478.9 10488.4 10493.8 10494.3 10498.2 7784.1 7939.5 8010.0 8077.3 8244.5 5977.3 5995.3 6092.1 6101.8 6106.5 9166.5 9192.8 9206.4 9305.4 9354.7 9148.4 9317.8 9417.2 9529.6 9580.1 7662.6 7769.6 7774.5 7836.9 7842.0 7851.5 7946.7 7988.1 8230.3 8234.3 7361.1 7431.0 7574.7 7585.6 7640.5 7202.6 7225.2 7266.7 7300.5 7365.7 6749.2 6817.4 6823.5 6850.6 6854.4 5135.2 5216.4 5243.6 5362.6 5458.4 5285.5 5363.0 5414.0 5430.6 5435.8 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#4] prototype.html Cycles:180 Average:5571.78 Median:6346.43 stddev:1674.77 (26.4%) stddev-sans-first:1633.12 15:12:51 INFO - PROCESS | 32620 | Values: 358.6 362.7 363.5 363.9 365.4 6258.1 6315.7 6375.6 6380.9 6384.2 6273.7 6282.8 6283.5 6292.4 6312.4 4590.3 4663.5 4775.3 4793.7 4807.8 4756.4 4774.0 4775.1 4783.3 4793.7 4582.5 4744.2 4751.9 4754.5 4755.5 4641.2 4671.2 4718.4 4718.6 4765.4 4214.3 4218.4 4223.7 4224.0 4229.0 5993.2 5998.7 6000.6 6007.6 6014.1 5592.5 5602.0 5603.3 5604.0 5606.9 6408.7 6601.3 6602.3 6607.9 6611.6 4717.5 4721.9 4722.1 4722.7 4732.6 6894.9 6915.0 6928.5 6929.6 6930.1 4829.4 4829.5 4830.0 4836.3 4837.6 4891.5 4894.6 4894.9 4895.5 4904.0 5576.7 5590.3 5594.4 5598.1 5605.2 6472.2 6670.6 6676.3 6678.1 6685.7 1682.2 1709.7 1721.9 1725.3 1725.8 1070.8 1120.2 1135.1 1155.6 1171.5 6338.3 6342.1 6342.3 6345.2 6347.7 6820.8 6822.8 6824.6 6826.2 6829.4 6438.1 6455.2 6506.8 6514.2 6514.6 3640.4 3684.1 3685.2 3688.4 3692.1 6864.9 7156.5 7158.9 7171.7 7171.8 7010.6 7035.7 7041.8 7085.3 7090.5 7125.0 7133.6 7142.9 7146.8 7154.5 6946.3 6951.9 6952.8 6954.6 6958.7 6588.8 6778.9 6807.0 6807.8 6827.5 7020.6 7072.7 7079.5 7083.2 7086.1 4571.2 4582.2 4598.9 4600.4 4608.7 6823.5 6828.8 6835.6 6843.4 6843.8 6510.7 6645.8 6650.4 6656.9 6658.3 6588.9 6596.6 6611.1 6626.2 6634.0 6518.2 6535.3 6538.8 6538.9 6540.0 6680.4 6692.0 6694.5 6695.9 6700.3 6420.8 6537.2 6552.0 6557.7 6560.3 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - PROCESS | 32620 | [#5] yui.html Cycles:180 Average:16127.58 Median:43377.97 stddev:18877.22 (43.5%) stddev-sans-first:18895.64 15:12:51 INFO - PROCESS | 32620 | Values: 923.5 935.5 943.6 965.4 969.3 15482.1 15727.0 15778.0 15809.7 15812.5 14337.1 14372.5 14385.5 14390.7 14873.1 894.3 898.8 900.3 900.3 901.3 897.5 904.1 904.5 906.6 907.2 952.3 955.5 955.6 955.7 957.7 946.0 947.8 950.8 950.8 951.6 696.3 702.0 703.8 705.1 707.4 14671.9 14694.1 14705.3 14735.9 14744.9 14639.0 14647.6 14685.8 14860.7 14980.9 11775.4 11863.6 11948.0 12090.8 12097.3 4012.3 4031.6 4047.5 4069.9 4167.9 49500.3 53763.0 54329.7 55395.7 57700.1 11818.2 11846.3 11949.8 11951.6 12074.5 17123.7 17142.8 17284.9 17311.0 17334.6 8925.3 9015.0 9111.8 9172.2 9295.8 4960.0 5085.5 5119.5 5156.7 5169.6 3659.2 3716.9 3719.8 3726.9 3732.1 650.5 683.5 734.3 742.7 754.8 636.4 686.8 687.1 696.2 799.8 9713.7 9809.8 9868.8 9869.3 10035.3 662.5 699.1 757.5 785.9 801.7 4670.7 4840.2 5019.1 5109.2 5111.3 68892.0 69367.7 70186.0 70689.3 70702.0 60444.4 61092.0 61905.4 62519.4 62777.7 44541.9 47818.8 55640.7 57757.4 58477.7 10225.7 10427.1 10444.4 10451.9 10546.3 40045.4 40178.4 41329.6 41865.8 42214.0 51103.7 53705.7 54470.2 55028.4 55067.4 12450.9 12455.5 12514.9 12713.9 12802.0 14049.7 14475.2 14489.4 15091.9 15275.8 13319.0 13419.4 13509.3 13556.6 14207.8 13697.7 13718.2 13948.6 13968.5 14024.6 13155.3 13571.5 13657.5 14029.9 14033.1 11165.3 11379.4 11397.9 11643.6 11943.3 11343.4 11353.7 11382.0 11539.9 11614.8 15:12:51 INFO - PROCESS | 32620 | -------- Summary: end -------- 15:12:51 INFO - PROCESS | 32620 | 15:12:51 INFO - TEST-INFO | 32620: exit 0 15:12:51 INFO - TEST-OK | dromaeo_css | took 1110935ms 15:12:51 INFO - TEST-START | kraken 15:12:51 INFO - operating with platform_type : linux_ 15:12:51 INFO - Initialising browser for kraken test... 15:12:51 INFO - TEST-INFO | started process 336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB6LDqk/profile http://localhost:35754/getInfo.html) 15:12:55 INFO - PROCESS | 336 | __metrics Screen width/height:1600/1200 15:12:55 INFO - PROCESS | 336 | colorDepth:24 15:12:55 INFO - PROCESS | 336 | Browser inner width/height: 1024/697 15:12:55 INFO - PROCESS | 336 | __metrics 15:12:56 ERROR - PROCESS | 336 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:12:57 INFO - TEST-INFO | 336: exit 0 15:12:57 INFO - Browser initialized. 15:12:57 INFO - Running cycle 1/1 for kraken test... 15:12:57 INFO - TEST-INFO | started process 430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB6LDqk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:09 INFO - PROCESS | 430 | RSS: Main: 141246464 15:13:09 INFO - PROCESS | 430 | 15:13:11 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35754/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:12 INFO - PROCESS | 430 | RSS: Main: 197365760 15:13:12 INFO - PROCESS | 430 | 15:13:15 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35754/tests/kraken/driver.html?testName=audio-dft) 15:13:15 INFO - PROCESS | 430 | RSS: Main: 184168448 15:13:15 INFO - PROCESS | 430 | 15:13:18 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35754/tests/kraken/driver.html?testName=audio-fft) 15:13:19 INFO - PROCESS | 430 | RSS: Main: 272887808 15:13:19 INFO - PROCESS | 430 | 15:13:21 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35754/tests/kraken/driver.html?testName=audio-oscillator) 15:13:22 INFO - PROCESS | 430 | RSS: Main: 178720768 15:13:22 INFO - PROCESS | 430 | 15:13:24 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:24 INFO - PROCESS | 430 | RSS: Main: 177332224 15:13:24 INFO - PROCESS | 430 | 15:13:27 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35754/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:28 INFO - PROCESS | 430 | RSS: Main: 211906560 15:13:28 INFO - PROCESS | 430 | 15:13:31 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35754/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:32 INFO - PROCESS | 430 | RSS: Main: 212541440 15:13:32 INFO - PROCESS | 430 | 15:13:34 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35754/tests/kraken/driver.html?testName=json-parse-financial) 15:13:35 INFO - PROCESS | 430 | RSS: Main: 212307968 15:13:35 INFO - PROCESS | 430 | 15:13:37 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:37 INFO - PROCESS | 430 | RSS: Main: 191897600 15:13:37 INFO - PROCESS | 430 | 15:13:39 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:39 INFO - PROCESS | 430 | RSS: Main: 195624960 15:13:39 INFO - PROCESS | 430 | 15:13:41 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:42 INFO - PROCESS | 430 | RSS: Main: 210354176 15:13:42 INFO - PROCESS | 430 | 15:13:44 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:13:45 INFO - PROCESS | 430 | RSS: Main: 216539136 15:13:45 INFO - PROCESS | 430 | 15:13:48 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:13:48 INFO - PROCESS | 430 | RSS: Main: 212488192 15:13:48 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | Cycle 1(1): loaded http://localhost:35754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35754/tests/kraken/driver.html?testName=ai-astar) 15:13:50 INFO - PROCESS | 430 | RSS: Main: 272928768 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | __start_tp_report 15:13:50 INFO - PROCESS | 430 | _x_x_mozilla_page_load 15:13:50 INFO - PROCESS | 430 | _x_x_mozilla_page_load_details 15:13:50 INFO - PROCESS | 430 | |i|pagename|runs| 15:13:50 INFO - PROCESS | 430 | |0;ai-astar;109;111;111;111;110;111;106;108;107;109 15:13:50 INFO - PROCESS | 430 | |1;audio-beat-detection;152;126;157;176;127;152;158;129;189;130 15:13:50 INFO - PROCESS | 430 | |2;audio-dft;160;162;163;162;159;160;160;160;161;160 15:13:50 INFO - PROCESS | 430 | |3;audio-fft;75;76;76;168;76;76;75;75;174;80 15:13:50 INFO - PROCESS | 430 | |4;audio-oscillator;93;93;156;93;93;92;144;93;92;149 15:13:50 INFO - PROCESS | 430 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 15:13:50 INFO - PROCESS | 430 | |6;imaging-darkroom;145;145;146;146;146;145;146;146;146;145 15:13:50 INFO - PROCESS | 430 | |7;imaging-desaturate;94;94;95;94;95;95;94;95;94;94 15:13:50 INFO - PROCESS | 430 | |8;json-parse-financial;55;53;55;53;54;52;55;75;53;51 15:13:50 INFO - PROCESS | 430 | |9;json-stringify-tinderbox;58;59;60;58;58;57;58;59;58;59 15:13:50 INFO - PROCESS | 430 | |10;stanford-crypto-aes;72;74;73;71;83;72;81;73;72;80 15:13:50 INFO - PROCESS | 430 | |11;stanford-crypto-ccm;117;124;113;116;110;110;113;123;125;112 15:13:50 INFO - PROCESS | 430 | |12;stanford-crypto-pbkdf2;159;157;161;160;154;161;157;157;158;159 15:13:50 INFO - PROCESS | 430 | |13;stanford-crypto-sha256-iterative;65;68;65;66;65;65;66;65;65;65 15:13:50 INFO - PROCESS | 430 | __end_tp_report 15:13:50 INFO - PROCESS | 430 | __start_cc_report 15:13:50 INFO - PROCESS | 430 | _x_x_mozilla_cycle_collect,1576 15:13:50 INFO - PROCESS | 430 | __end_cc_report 15:13:50 INFO - PROCESS | 430 | __startTimestamp1465251230828__endTimestamp 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | ------- Summary: start ------- 15:13:50 INFO - PROCESS | 430 | Number of tests: 14 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:1.83 (1.7%) stddev-sans-first:1.94 15:13:50 INFO - PROCESS | 430 | Values: 109.0 111.0 111.0 111.0 110.0 111.0 106.0 108.0 107.0 109.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:154.50 stddev:21.76 (14.1%) stddev-sans-first:23.07 15:13:50 INFO - PROCESS | 430 | Values: 152.0 126.0 157.0 176.0 127.0 152.0 158.0 129.0 189.0 130.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 15:13:50 INFO - PROCESS | 430 | Values: 160.0 162.0 163.0 162.0 159.0 160.0 160.0 160.0 161.0 160.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.05 (52.7%) stddev-sans-first:41.82 15:13:50 INFO - PROCESS | 430 | Values: 75.0 76.0 76.0 168.0 76.0 76.0 75.0 75.0 174.0 80.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:27.66 (29.7%) stddev-sans-first:28.66 15:13:50 INFO - PROCESS | 430 | Values: 93.0 93.0 156.0 93.0 93.0 92.0 144.0 93.0 92.0 149.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:13:50 INFO - PROCESS | 430 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:13:50 INFO - PROCESS | 430 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:13:50 INFO - PROCESS | 430 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.50 stddev:6.95 (12.7%) stddev-sans-first:7.37 15:13:50 INFO - PROCESS | 430 | Values: 55.0 53.0 55.0 53.0 54.0 52.0 55.0 75.0 53.0 51.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 15:13:50 INFO - PROCESS | 430 | Values: 58.0 59.0 60.0 58.0 58.0 57.0 58.0 59.0 58.0 59.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:73.50 stddev:4.43 (6.0%) stddev-sans-first:4.56 15:13:50 INFO - PROCESS | 430 | Values: 72.0 74.0 73.0 71.0 83.0 72.0 81.0 73.0 72.0 80.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:116.50 stddev:5.77 (5.0%) stddev-sans-first:6.12 15:13:50 INFO - PROCESS | 430 | Values: 117.0 124.0 113.0 116.0 110.0 110.0 113.0 123.0 125.0 112.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:2.16 (1.4%) stddev-sans-first:2.28 15:13:50 INFO - PROCESS | 430 | Values: 159.0 157.0 161.0 160.0 154.0 161.0 157.0 157.0 158.0 159.0 15:13:50 INFO - PROCESS | 430 | 15:13:50 INFO - PROCESS | 430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 15:13:50 INFO - PROCESS | 430 | Values: 65.0 68.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 15:13:50 INFO - PROCESS | 430 | -------- Summary: end -------- 15:13:50 INFO - PROCESS | 430 | 15:13:51 INFO - TEST-INFO | 430: exit 0 15:13:51 INFO - TEST-OK | kraken | took 59998ms 15:13:51 INFO - SUITE-END | took 1170s 15:13:51 INFO - Completed test suite (00:19:31) 15:13:51 INFO - javascript benchmark 15:13:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.8530366133523, 3302.785318954268, 3317.220453193499, 3322.568066151403, 3365.7475689323305, 5391.649542779716, 5426.864328391787, 5433.429489903562, 5439.972800135999, 5449.128139497681, 5440.4287549807295, 5449.482299181582, 5473.233747275374, 5482.671039737608, 5503.697296648683, 4865.051314993578, 4879.560839524442, 4925.384326959121, 4997.825076122336, 5037.949620503803, 4902.950970490303, 4923.212286034235, 4930.852074437773, 5004.699718016931, 5008.549230569248, 4929.630277729167, 5027.798888044474, 5091.516305950929, 5106.668066575679, 5116.667416617926, 5047.242913562958, 5065.392152941634, 5072.391313042422, 5087.643864929457, 5118.795248190087, 4837.975810120962, 4899.191633380488, 4967.801287948478, 4973.5772459341, 4988.052270068675, 5335.146376579767, 5374.140137577969, 5391.433899440581, 5410.48600382963, 5414.485623865727, 5863.794767183171, 5895.616784908967, 5895.823125306248, 5898.174255604219, 5903.35063143054, 5845.707714614252, 5922.230110085704, 5930.55520835939, 5980.162777211194, 6002.189704389895, 5486.1222204447495, 5512.062949298629, 5535.114381698909, 5537.0863807471715, 5539.307586551681, 5860.70696465175, 6015.879682406415, 6029.698515074228, 6034.668093254913, 6035.969820150871, 5748.109043098327, 5814.127880817911, 5831.241938547962, 5832.825015249549, 5837.6497410155525, 5839.357670656224, 5841.474267315877, 5849.0, 5850.0932355484965, 5853.5317174625925, 5663.150527420919, 5750.194972703741, 5806.883862322815, 5819.214406055213, 5831.650100993954, 5876.0, 5881.000229960917, 5885.676287804126, 5889.146073819272, 5924.496417804448, 4503.81984720614, 4504.144212599595, 4504.391907092566, 4508.549145085531, 4534.79593418297, 3957.6438120569287, 3959.92080158401, 4029.7582145070805, 4048.8987775305263, 4056.7971601419813, 5592.944070559323, 5608.6073974821375, 5615.298087739033, 5621.241132447149, 5633.352164501053, 5941.405859414024, 5942.465178133989, 5943.881122377528, 5948.702564871739, 5949.286085669747, 5459.863503412446, 5565.972170139124, 5610.214569960209, 5629.493345598916, 5668.518175955008, 5048.343715316985, 5062.11413002723, 5070.543651071422, 5075.746212689351, 5076.36545431821, 6019.0, 6036.607620504653, 6036.667983260875, 6040.697965101727, 6091.208142941389, 5737.5983681141915, 5929.6145750526075, 6012.428819262163, 6019.277686677627, 6052.122442245938, 6016.87966240664, 6023.0, 6024.0662697282, 6025.307089684742, 6025.487833534199, 5576.749046293007, 5725.656460612377, 5746.597738158289, 5750.856228594319, 5759.90561793258, 5932.8813423732145, 6039.698015099139, 6041.728122234422, 6048.183495228264, 6085.908711369421, 5724.4275572444085, 5741.822926300182, 5746.942530574641, 5760.395158508296, 5768.798092066758, 5590.189422533791, 5703.828885133453, 5705.22979397776, 5741.741621626953, 5751.712414379181, 5649.774009039593, 5666.744996475086, 5672.602917795714, 5689.886202276014, 5720.513756330759, 5788.565857560784, 5798.768049277982, 5804.390538993345, 5812.3025236971835, 5819.0, 5625.803096891753, 5699.316082070178, 5715.685637289989, 5739.196512488338, 5810.82567522975], "value": 5426.28765895077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4960807725549, 660.7390080918037, 671.5165081141577, 674.3357792574315, 692.8683550125472, 33195.99999999997, 33840.0, 33850.0, 33871.66128338716, 40226.7988660057, 44331.33502997458, 44911.550884491146, 44926.0, 44928.77535612317, 45081.77459112708, 8802.86795698065, 8981.820363592724, 8983.46099234048, 8984.19142277195, 8985.14641109097, 8842.557872106401, 8932.508712020835, 8950.552472376356, 8967.506787126706, 8970.820583588324, 8925.330600204978, 9211.170994610484, 9214.0, 9216.907830921671, 9217.216536594364, 9119.908800911971, 9200.861987070199, 9202.171804537556, 9202.631894724203, 9206.861897071516, 8976.192142707188, 9070.0, 9080.954595227047, 9096.90903090974, 9103.590338434786, 43915.56084439147, 44515.0, 44560.3315950261, 44671.55328446707, 44688.3296750549, 3699.85200591976, 3783.8297276622343, 4039.656629186523, 4149.398337241083, 4630.72215667061, 30722.0, 30843.228919276975, 30863.0, 31009.069727908198, 32512.187195320068, 4407.625351845097, 4489.573490518395, 4494.68537202396, 4501.504834468205, 4528.8867778305475, 293991.0, 295495.0, 295939.0, 296837.0, 297765.0, 38727.80636096802, 61825.38174618286, 63490.682546587894, 63580.36419635837, 63605.0, 37631.05922351963, 37662.0, 37768.811155944044, 37788.0, 37800.62199378026, 15831.287592058385, 16118.194090295437, 16118.435854745028, 16139.193040347936, 16142.596435089217, 13149.145305555108, 13266.270355130368, 13299.268540230187, 13333.733325333438, 13356.46574137043, 9282.72151835446, 9374.156325930562, 9494.857577136348, 9503.524823758784, 9580.712578622653, 3544.220271540257, 3673.8897833065053, 3724.646158614927, 3742.8128593570214, 3755.7370984030854, 1079.978400431987, 1098.4562641492512, 1139.8518192634904, 1157.1437136518916, 1226.3316492511603, 34588.347907588795, 35026.474602880975, 35196.0, 35288.64711352905, 35330.82334588362, 1213.0356366688504, 1215.9513619455122, 1285.0940087238475, 1288.8002359634272, 1319.5711393797055, 17949.641007179784, 18050.3682371119, 18160.273589056553, 18204.271829126952, 18307.450776476726, 465259.0, 470372.0, 471205.0, 471321.0, 472337.0, 62172.68913655493, 63087.05369419463, 63142.68428657919, 63230.68384658139, 63492.36507634957, 1467.2517016321754, 1531.525227179578, 1540.2221877951563, 1557.9610509737347, 1609.4045203274864, 34477.13807154841, 35758.64241357657, 36266.456003159445, 36371.81814091018, 36525.63474365223, 51107.488925111764, 51847.222291664904, 51849.0, 51859.2221116676, 51916.740416297675, 352266.0, 354473.0, 356504.0, 357504.0, 451249.0, 30144.3971120572, 31597.21006974844, 31738.20654483564, 31748.68251317457, 31757.20606984844, 44473.33290000588, 44840.77579612081, 44841.32738008998, 45688.31467528056, 46342.0, 37180.0, 38082.61917380791, 38259.42610860895, 38467.61532384752, 38544.6145538541, 37758.43362349622, 37844.432333514465, 38021.619783801805, 41000.589994099675, 41148.79425602853, 42880.57119428766, 43491.0, 43502.782486087366, 43682.78158609186, 44149.0, 35019.0, 36229.27541449209, 36379.81810091039, 36513.81743091268, 36876.815615922824, 28459.146225613265, 28511.0401582945, 28643.28391790222, 28683.940303268766, 29179.708202918548], "value": 19367.868276225116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.68137737385655, 427.7967965216521, 441.2564828264376, 442.6458832933653, 444.88210624184575, 18555.443336699886, 18590.814091859076, 18599.535011624717, 19317.71023434648, 19408.126634301454, 18477.630447391046, 18515.444536663887, 18691.81308186918, 19152.329668461607, 19593.412197634058, 5725.08398656214, 5797.246357973458, 5819.6508209507565, 5832.0, 5906.143609176666, 5630.465105814961, 5734.541236701075, 5750.33871104822, 5845.0647896336595, 5853.063509838426, 5678.716064196794, 5763.740631671564, 5806.738696758634, 5826.21346118275, 5856.648601083927, 5767.567432442584, 5810.680412577307, 5821.126830975345, 5824.504917082053, 5829.708514574276, 5213.765380557884, 5244.265802787613, 5266.9202813423535, 5291.0, 5301.973490132563, 22908.0, 23036.53926921469, 23373.065077397056, 23398.53202935949, 23409.88295058531, 2608.8956441742307, 2629.7764690001372, 2631.8815653295646, 2636.947261054768, 2919.2409973406857, 14445.927770361186, 14702.852971470254, 14841.257937103102, 14990.700185996218, 14994.175320357375, 1944.4944314478196, 2014.4027812267198, 2029.7767245602972, 2037.2360364863177, 2067.7105205271273, 76182.61908690477, 77584.0, 78372.21627783705, 78740.21259787386, 80575.59712201402, 10171.84742228867, 10453.581856725797, 11001.394923279136, 11198.832017519744, 11214.383208923424, 15628.2185890705, 15655.060696358254, 15727.292271847795, 15733.44932927365, 15774.9211253943, 8093.0, 8305.709300174465, 8451.45065570736, 8469.0, 8530.74407767768, 7974.880376794353, 7980.0, 8031.237032482021, 8110.675572977133, 8114.918850811534, 4931.50684931504, 4961.603071754251, 4980.551750342486, 4982.90034199314, 4994.925076123861, 1979.4853338131902, 1985.3547597031022, 2004.7894971028124, 2037.3480486244555, 2061.845361597886, 470.12791272190276, 481.75912043978013, 939.1219210038636, 1063.2079101069598, 1193.928364298145, 11055.170862185207, 11076.39079850616, 11085.390303533382, 11091.500882460308, 11262.549498020151, 486.5475108149455, 487.3542556113093, 492.58130588999063, 493.1837808427059, 498.4218306764209, 6022.247219097613, 6023.27720673522, 6046.093086037042, 6136.417040381157, 6175.660338681326, 503764.0, 524079.0, 524740.7629618504, 532493.0, 532636.0, 96529.0, 98501.0, 98905.50547247217, 98971.0, 99231.50384248032, 509.0557016733905, 509.23360342684765, 510.2168171856183, 511.2101802714815, 515.2503107977883, 10847.891521084688, 10935.781284374427, 10971.561137554727, 10999.505022273857, 11207.551697932318, 39036.21927561376, 39274.6072539271, 39292.80353598214, 40183.79908100441, 40361.79819100886, 57442.7127864358, 58756.0, 58757.0, 59202.70398647979, 59211.40788592059, 8610.913890861262, 8725.956370218108, 8738.563071846509, 8748.91251087481, 8949.910500894908, 9735.951320243637, 13361.799573006607, 13387.732245354844, 13575.52485662997, 13676.794848077088, 6303.086052522451, 11517.59688410935, 11621.418929053345, 12025.977791887437, 12026.939865300967, 11526.82709759371, 11583.594574189863, 11648.592299269485, 12045.09661775388, 12240.816387754012, 12162.695932601402, 12201.267923924594, 12374.195677280948, 12389.690257743268, 12491.75016499683, 8360.540170290693, 8394.580270986304, 8593.81221629372, 8640.35197360213, 8857.335699822668, 8852.822943541221, 11177.441127943408, 12274.693132671397, 12286.81569776472, 12314.938425307817], "value": 8625.8320331386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.448754985555, 1527.5646440764385, 1546.327347603792, 1723.4140392266627, 1857.5541869951207, 7492.962535187323, 8191.672333106676, 8323.667053317875, 8334.958325208381, 8352.624131914063, 8173.959130204341, 8309.584520773968, 8310.168983101687, 8315.792105197374, 8317.667293308261, 2374.121575017246, 2393.293978276404, 2397.6883005209297, 2397.9160729374476, 2399.4121440247077, 2355.9411014724596, 2378.5599664062115, 2394.545036443079, 2399.2082612737754, 2414.106780491212, 2353.0587764894008, 2364.125273648752, 2370.3126093432884, 2388.940276493093, 2390.103711108334, 2348.1664009276633, 2359.1978727232736, 2360.7639236076343, 2363.102021231938, 2408.229366602688, 2283.2579411691268, 2329.3827135809024, 2337.7194736631714, 2349.6475528670667, 2351.6354964980455, 7308.634568271618, 8042.919570804334, 8617.439866408664, 8668.26319762821, 8695.565221738887, 5201.973990130063, 5279.5512381447625, 5329.307190065306, 5330.387005494379, 5342.813001544927, 3314.0720598232533, 3347.3640008398324, 3364.680355366236, 3372.5278461015478, 3418.470137128724, 1079.228351728518, 1156.699258192876, 1161.7153797319627, 1165.4231155578043, 1165.7377090154732, 11744.70638234051, 12107.93946030273, 12132.15074944763, 12137.575184868487, 12140.514379424812, 4667.159911216014, 4690.319903613957, 4765.142274390573, 4803.087413391444, 4824.179889418807, 9729.4648794317, 9802.65690700822, 9816.754581135528, 9821.80356392868, 9824.214062874953, 5358.0, 5406.0, 5408.107662235687, 5412.0, 5416.593755468356, 4939.1109600271575, 4982.975085124551, 5000.224965130411, 5002.024605201951, 5002.74986250686, 3877.86427475037, 3930.6855451563806, 3952.7233093683167, 3966.2265858157957, 3972.245273398045, 1179.180469573638, 1181.232199070611, 1186.525389844052, 1212.9090318226167, 1225.6139316115396, 952.9857052144223, 1082.588616325807, 1083.9620613278498, 1102.1072930925816, 1110.566878917223, 6129.356417576179, 6186.969065154645, 6291.087792270187, 6291.811245662638, 6361.0, 1008.369768894441, 1058.5871510111062, 1067.5836423794726, 1076.6500887211687, 1085.6308854989184, 4246.129543443587, 4296.591823776736, 4298.548652391516, 4320.762358070274, 4324.459442569679, 10189.898101018895, 10625.415602141957, 10649.84025239622, 10654.200934929911, 10661.413622250695, 10478.947605261925, 10488.4231367274, 10493.790124197474, 10494.265401421828, 10498.160147188206, 7784.143744188134, 7939.523628582304, 8009.998750156347, 8077.273045425823, 8244.54654993981, 5977.282726072899, 5995.310539288038, 6092.086187071975, 6101.84745381369, 6106.5114790817515, 9166.495842728447, 9192.770180745534, 9206.447613142966, 9305.395149315273, 9354.672586459714, 9148.359614827164, 9317.813643727222, 9417.152456278967, 9529.571169297536, 9580.13778759915, 7662.578558179353, 7769.611519424119, 7774.533527988113, 7836.92163078362, 7842.019747531559, 7851.450398472052, 7946.721864734706, 7988.081370642451, 8230.341572674291, 8234.300084492885, 7361.1166660001145, 7431.0, 7574.734884279023, 7585.582792946441, 7640.503367281109, 7202.639868006683, 7225.169105552929, 7266.67299971492, 7300.452466065172, 7365.668544915385, 6749.190097188369, 6817.420519255918, 6823.522353435212, 6850.554713943578, 6854.383105520527, 5135.178371460698, 5216.40011398694, 5243.58051355883, 5362.624616276823, 5458.372287187024, 5285.471452854684, 5363.0, 5414.0, 5430.592705547021, 5435.782568697208], "value": 4631.320365359715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6288191721567, 362.6554772965682, 363.4675200830782, 363.9253952939647, 365.4171596303896, 6258.0925765764, 6315.684215789215, 6375.649339286331, 6380.936190638092, 6384.233891932963, 6273.654948977804, 6282.780102696406, 6283.465905398047, 6292.433680968712, 6312.431881130698, 4590.311453282001, 4663.510331415204, 4775.307580400857, 4793.688410253322, 4807.759612019385, 4756.429228492586, 4773.952260477386, 4775.14047471455, 4783.306420569015, 4793.688410253322, 4582.541745825424, 4744.169770290203, 4751.881202969937, 4754.524547545252, 4755.453122890877, 4641.187792136379, 4671.205894997858, 4718.433787945434, 4718.622510199193, 4765.404324459442, 4214.346776249687, 4218.409422680827, 4223.704340696153, 4223.97888010561, 4228.978855105735, 5993.160957465958, 5998.700064996733, 6000.609960352563, 6007.639541627516, 6014.0678194879865, 5592.468715472024, 5601.971990140064, 5603.2715746953045, 5604.047311956977, 5606.915896261559, 6408.743650254031, 6601.306862779387, 6602.306757790411, 6607.93392066078, 6611.6033038017395, 4717.481077081518, 4721.881952951204, 4722.102800467935, 4722.669413141081, 4732.597729193023, 6894.896576551356, 6915.0, 6928.515003949726, 6929.618870962095, 6930.13373328334, 4829.372181616367, 4829.541193586604, 4830.0, 4836.250381190921, 4837.588804951548, 4891.51084891508, 4894.559489645949, 4894.926576101361, 4895.534924182197, 4903.975480122576, 5576.693281869536, 5590.273264475592, 5594.440555944373, 5598.076317407582, 5605.215269862141, 6472.190976127984, 6670.599764014175, 6676.26561078281, 6678.065070890079, 6685.732570697118, 1682.150513990427, 1709.7435384692146, 1721.888077274973, 1725.3357457379, 1725.8446739793228, 1070.796548655753, 1120.2046546951592, 1135.1486385211092, 1155.5608868629868, 1171.5021116025655, 6338.30278669346, 6342.143810585512, 6342.270638876496, 6345.17512723343, 6347.682615869188, 6820.795376138723, 6822.829429264308, 6824.590524568542, 6826.214985276757, 6829.351211634887, 6438.066480360321, 6455.193100862392, 6506.772262970773, 6514.185726784152, 6514.641694706742, 3640.4175331946763, 3684.1158122050515, 3685.1708365618056, 3688.354537955847, 3692.132348898007, 6864.862702745917, 7156.534825236447, 7158.892616610755, 7171.677274522659, 7171.820704482326, 7010.579365238102, 7035.718571257093, 7041.788746337618, 7085.256048114874, 7090.468214883905, 7125.0, 7133.607651579109, 7142.892856607155, 7146.785596432115, 7154.463415243774, 6946.305369463215, 6951.895721564079, 6952.791416257521, 6954.582725036514, 6958.686859091252, 6588.8352791180605, 6778.932210678027, 6807.047013418224, 6807.761728339485, 6827.48793840454, 7020.6489675514995, 7072.681729322296, 7079.504434689522, 7083.150021997393, 7086.114235720535, 4571.200039992921, 4582.243929751554, 4598.8620341389815, 4600.42494688164, 4608.677392582621, 6823.454123670193, 6828.760993365208, 6835.555688880207, 6843.3840954314355, 6843.7604683835825, 6510.707018184098, 6645.767398141042, 6650.434713049445, 6656.900146497903, 6658.300878407891, 6588.934110659024, 6596.571222870498, 6611.107500487373, 6626.204855417381, 6633.9668301658185, 6518.152640156749, 6535.2811190768025, 6538.803835884931, 6538.934610654022, 6539.967300163659, 6680.365365290289, 6691.966540167268, 6694.531382803157, 6695.899561506484, 6700.262971073081, 6420.807375778734, 6537.182852143482, 6551.967240163769, 6557.704903279459, 6560.3111673275525], "value": 5030.7555338636785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.5464581645384, 935.522883329502, 943.5565284316377, 965.3725078698845, 969.3456916581306, 15482.071075735465, 15727.0, 15778.0, 15809.683806323881, 15812.525624231277, 14337.139771613685, 14372.490888456718, 14385.496507622236, 14390.712185756278, 14873.107613543169, 894.3337213775729, 898.8022635020318, 900.2707806676581, 900.333753022765, 901.3375169250628, 897.5422534507416, 904.1230006893303, 904.5341649050712, 906.5829718329576, 907.1790030022839, 952.3476418653245, 955.5461155950937, 955.6034245787989, 955.7180631713626, 957.707899090777, 945.957431915562, 947.7772723410028, 950.7623094226443, 950.828850806858, 951.5813042261383, 696.2793508718452, 702.034702284359, 703.8381172330393, 705.0728292295667, 707.4375871182423, 14671.926640366837, 14694.11835289886, 14705.338259778335, 14735.852641473663, 14744.926275368554, 14639.0, 14647.63380915475, 14685.77971330431, 14860.702785944328, 14980.850191498055, 11775.352355620438, 11863.58477453285, 11948.0, 12090.758184836342, 12097.274163550215, 4012.277789997799, 4031.596840315974, 4047.453593764863, 4069.8982525436804, 4167.874963751062, 49500.25749613759, 53763.0, 54329.72835135838, 55395.72302138504, 57700.134497982566, 11818.231814932002, 11846.348450835287, 11949.761004779855, 11951.641450756491, 12074.456649450796, 17123.74314385285, 17142.828571714123, 17284.91357543204, 17311.0, 17334.566635834206, 8925.285977121815, 9014.954925225333, 9111.81776364469, 9172.174504294646, 9295.76760580991, 4960.0, 5085.466026067284, 5119.462456442095, 5156.716380599028, 5169.560587350042, 3659.2315613721416, 3716.869909553153, 3719.814009299524, 3726.9440958385103, 3732.0669832541867, 650.4601181019742, 683.5215349255541, 734.2657342657343, 742.6509540515949, 754.7509321923752, 636.3986033198676, 686.7664993902097, 687.1033301541437, 696.24109720405, 799.8440304140637, 9713.660021899199, 9809.754756131011, 9868.80262394748, 9869.309148359689, 10035.297529173034, 662.5163630549629, 699.1016543741268, 757.5454727163768, 785.9017622797151, 801.6913488307043, 4670.719756814602, 4840.15297322967, 5019.14674505335, 5109.182530795055, 5111.258867464197, 68892.0, 69367.65316173488, 70186.0, 70689.2931070693, 70702.0, 60444.39555604476, 61092.0, 61905.38094619086, 62519.374806252265, 62777.68611156915, 44541.94471635208, 47818.760906195246, 55640.72179639076, 57757.42242577604, 58477.70761146167, 10225.693229203136, 10427.113695335982, 10444.373337599465, 10451.895481045092, 10546.314489558154, 40045.39931900966, 40178.39732403958, 41329.58670413378, 41865.79067104645, 42214.0, 51103.744481278845, 53705.73147134239, 54470.18294725662, 55028.449715502335, 55067.44932550623, 12450.875491244971, 12455.501779929064, 12514.937425312815, 12713.93643031779, 12802.0, 14049.719005620034, 14475.203863787592, 14489.420423183376, 15091.924540377227, 15275.770863436835, 13319.0, 13419.396127174496, 13509.256990865597, 13556.59330220095, 14207.786883196553, 13697.657558560717, 13718.245496497788, 13948.58154255374, 13968.511102111377, 14024.579262622137, 13155.276459794803, 13571.52499662507, 13657.521986730417, 14029.92985035109, 14033.087849290172, 11165.330080195214, 11379.374134422686, 11397.943010284895, 11643.59247426336, 11943.343116128697, 11343.432828358384, 11353.716157096138, 11382.0, 11539.942300288445, 11614.76770464569], "value": 7326.205765885789, "unit": "score"}], "name": "dromaeo_css", "value": 7327.231090908951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 111.0, 110.0, 111.0, 106.0, 108.0, 107.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 157.0, 176.0, 127.0, 152.0, 158.0, 129.0, 189.0, 130.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 162.0, 159.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 168.0, 76.0, 76.0, 75.0, 75.0, 174.0, 80.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 156.0, 93.0, 93.0, 92.0, 144.0, 93.0, 92.0, 149.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 53.0, 54.0, 52.0, 55.0, 75.0, 53.0, 51.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 58.0, 58.0, 57.0, 58.0, 59.0, 58.0, 59.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 71.0, 83.0, 72.0, 81.0, 73.0, 72.0, 80.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 113.0, 116.0, 110.0, 110.0, 113.0, 123.0, 125.0, 112.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 161.0, 160.0, 154.0, 161.0, 157.0, 157.0, 158.0, 159.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1510.4999999999998, "alertThreshold": 2.0}]} 15:13:52 INFO - Return code: 0 15:13:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:13:52 ERROR - # TBPL SUCCESS # 15:13:52 INFO - Running post-action listener: _resource_record_post_action 15:13:52 INFO - Running post-run listener: _resource_record_post_run 15:13:53 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462229504; Read time: 16; Write time: 502852 15:13:53 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 242339840; Read time: 0; Write time: 340048 15:13:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219889664; Read time: 16; Write time: 162804 15:13:53 INFO - Running post-run listener: _upload_blobber_files 15:13:53 INFO - Blob upload gear active. 15:13:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:13:53 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 15:13:53 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'] 15:13:53 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 15:13:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:54 INFO - (blobuploader) - INFO - Done attempting. 15:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:13:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:13:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:55 INFO - (blobuploader) - INFO - Done attempting. 15:13:55 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:55 INFO - Return code: 0 15:13:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:13:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a6ab2a2b178de4243b36596821b7383dea34d8f11cc19d86a208ee3277e979c6c33dad1738465eefa0def9fbe7753501c41f596d11e211eb7b83aab840e5282", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c66c758607176063909725e07e2572068241a85603a0c34a527845670dee1901efab0caecd9bfa0659cdc9aeda72be9266f8826331f9b4cfe665d9f27a93e36"} 15:13:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:13:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:13:55 INFO - Contents: 15:13:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a6ab2a2b178de4243b36596821b7383dea34d8f11cc19d86a208ee3277e979c6c33dad1738465eefa0def9fbe7753501c41f596d11e211eb7b83aab840e5282", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c66c758607176063909725e07e2572068241a85603a0c34a527845670dee1901efab0caecd9bfa0659cdc9aeda72be9266f8826331f9b4cfe665d9f27a93e36"} 15:13:55 INFO - Running post-run listener: copy_logs_to_upload_dir 15:13:55 INFO - Copying logs to upload dir... 15:13:55 INFO - mkdir: /builds/slave/test/build/upload/logs 15:13:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.958191 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-06 15:13:55.443394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:13:55.447062) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 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/7a6ab2a2b178de4243b36596821b7383dea34d8f11cc19d86a208ee3277e979c6c33dad1738465eefa0def9fbe7753501c41f596d11e211eb7b83aab840e5282", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c66c758607176063909725e07e2572068241a85603a0c34a527845670dee1901efab0caecd9bfa0659cdc9aeda72be9266f8826331f9b4cfe665d9f27a93e36"} build_url:https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/DBC1y0KmQwaKqH_GooMS2g/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a6ab2a2b178de4243b36596821b7383dea34d8f11cc19d86a208ee3277e979c6c33dad1738465eefa0def9fbe7753501c41f596d11e211eb7b83aab840e5282", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c66c758607176063909725e07e2572068241a85603a0c34a527845670dee1901efab0caecd9bfa0659cdc9aeda72be9266f8826331f9b4cfe665d9f27a93e36"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:13:55.472501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:13:55.472809) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465249506.745663-1847825888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:13:55.555522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:13:55.555923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:13:55.556211) ========= ========= Total master_lag: 0.17 =========