builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1460646417.19 results: success (0) buildid: 20160414053016 builduid: 08c0acaaf74d412ea9b1d42aa3e8579f revision: 30010c0e58af2b863b6f56bb9d1e519128832eb5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.188918) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.189400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.189692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.222594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.223272) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 08:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.3M=0s 2016-04-14 08:06:57 (39.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.420060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.420358) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018201 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:57.513664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 08:06:57.514039) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30010c0e58af2b863b6f56bb9d1e519128832eb5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 30010c0e58af2b863b6f56bb9d1e519128832eb5 --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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 08:06:57,926 truncating revision to first 12 chars 2016-04-14 08:06:57,926 Setting DEBUG logging. 2016-04-14 08:06:57,926 attempt 1/10 2016-04-14 08:06:57,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30010c0e58af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 08:06:58,386 unpacking tar archive at: fx-team-30010c0e58af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.010382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 08:06:58.544478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:58.544802) ========= script_repo_revision: 30010c0e58af2b863b6f56bb9d1e519128832eb5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:58.545228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:58.545550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 08:06:58.553525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-14 08:06:58.554174) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:59 INFO - MultiFileLogger online at 20160414 08:06:59 in /builds/slave/test 08:06:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:59 INFO - {'append_to_log': False, 08:06:59 INFO - 'base_work_dir': '/builds/slave/test', 08:06:59 INFO - 'blob_upload_branch': 'Fx-Team', 08:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:59 INFO - 'branch': 'Fx-Team', 08:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:59 INFO - 'config_files': ('talos/linux_config.py',), 08:06:59 INFO - 'default_actions': ('clobber', 08:06:59 INFO - 'read-buildbot-config', 08:06:59 INFO - 'download-and-extract', 08:06:59 INFO - 'populate-webroot', 08:06:59 INFO - 'create-virtualenv', 08:06:59 INFO - 'install', 08:06:59 INFO - 'run-tests'), 08:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:59 INFO - 'download_minidump_stackwalk': True, 08:06:59 INFO - 'download_symbols': 'ondemand', 08:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:59 INFO - 'installer_path': 'installer.exe', 08:06:59 INFO - 'log_level': 'info', 08:06:59 INFO - 'log_name': 'talos', 08:06:59 INFO - 'log_to_console': True, 08:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:59 INFO - 'opt_config_files': (), 08:06:59 INFO - 'pip_index': False, 08:06:59 INFO - 'sps_profile': False, 08:06:59 INFO - 'sps_profile_interval': 0, 08:06:59 INFO - 'suite': 'dromaeojs', 08:06:59 INFO - 'system_bits': '32', 08:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:59 INFO - 'title': 'talos-linux64-ix-001', 08:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:59 INFO - 'use_talos_json': True, 08:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:59 INFO - 'work_dir': 'build'} 08:06:59 INFO - ##### 08:06:59 INFO - ##### Running clobber step. 08:06:59 INFO - ##### 08:06:59 INFO - Running pre-action listener: _resource_record_pre_action 08:06:59 INFO - Running main action method: clobber 08:06:59 INFO - rmtree: /builds/slave/test/build 08:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:07:00 INFO - Running post-action listener: _resource_record_post_action 08:07:00 INFO - ##### 08:07:00 INFO - ##### Running read-buildbot-config step. 08:07:00 INFO - ##### 08:07:00 INFO - Running pre-action listener: _resource_record_pre_action 08:07:00 INFO - Running main action method: read_buildbot_config 08:07:00 INFO - Using buildbot properties: 08:07:00 INFO - { 08:07:00 INFO - "project": "", 08:07:00 INFO - "product": "firefox", 08:07:00 INFO - "script_repo_revision": "production", 08:07:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:07:00 INFO - "repository": "", 08:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:07:00 INFO - "buildid": "20160414053016", 08:07:00 INFO - "pgo_build": "True", 08:07:00 INFO - "basedir": "/builds/slave/test", 08:07:00 INFO - "buildnumber": 1098, 08:07:00 INFO - "slavename": "talos-linux64-ix-001", 08:07:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:07:00 INFO - "platform": "ubuntu64_hw", 08:07:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:07:00 INFO - "branch": "fx-team", 08:07:00 INFO - "repo_path": "integration/fx-team", 08:07:00 INFO - "revision": "30010c0e58af2b863b6f56bb9d1e519128832eb5", 08:07:00 INFO - "stage_platform": "linux64-pgo", 08:07:00 INFO - "builduid": "08c0acaaf74d412ea9b1d42aa3e8579f", 08:07:00 INFO - "slavebuilddir": "test" 08:07:00 INFO - } 08:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:07:00 INFO - Running post-action listener: _resource_record_post_action 08:07:00 INFO - ##### 08:07:00 INFO - ##### Running download-and-extract step. 08:07:00 INFO - ##### 08:07:00 INFO - Running pre-action listener: _resource_record_pre_action 08:07:00 INFO - Running main action method: download_and_extract 08:07:00 INFO - mkdir: /builds/slave/test/build/tests 08:07: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')]} 08:07:00 INFO - https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:07:06 INFO - Downloaded 1361 bytes. 08:07:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:07:06 INFO - Using the following test package requirements: 08:07:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:07:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:07:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'jsshell-linux-x86_64.zip'], 08:07:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:07:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:07:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:07:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:07:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:07:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:07:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:07:06 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')]} 08:07:06 INFO - https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:14 INFO - Downloaded 23774751 bytes. 08:07:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:15 INFO - Return code: 0 08:07:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:15 INFO - https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:07:23 INFO - Downloaded 23774751 bytes. 08:07:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:07:24 INFO - Return code: 0 08:07:24 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')]} 08:07:24 INFO - https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:07:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:07:25 INFO - Downloaded 10841076 bytes. 08:07:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:07:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:07:25 INFO - Return code: 0 08:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:25 INFO - https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:07:28 INFO - Downloaded 58149893 bytes. 08:07:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:28 INFO - mkdir: /builds/slave/test/properties 08:07:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:07:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:07:28 INFO - Contents: 08:07:28 INFO - build_url:https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:07:29 INFO - Running post-action listener: _resource_record_post_action 08:07:29 INFO - Running post-action listener: set_extra_try_arguments 08:07:29 INFO - ##### 08:07:29 INFO - ##### Running populate-webroot step. 08:07:29 INFO - ##### 08:07:29 INFO - Running pre-action listener: _resource_record_pre_action 08:07:29 INFO - Running main action method: populate_webroot 08:07:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:29 INFO - '--tppagecycles', 08:07:29 INFO - '7'], 08:07:29 INFO - 'tests': ['tsvgm']}}, 08:07:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:07:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:07:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['damp', 'tps']}, 08:07:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'tests': ['damp', 'tps']}, 08:07:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['dromaeo_dom']}, 08:07:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'other-e10s': {'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['a11yr', 08:07:29 INFO - 'ts_paint', 08:07:29 INFO - 'tpaint', 08:07:29 INFO - 'sessionrestore', 08:07:29 INFO - 'sessionrestore_no_auto_restore', 08:07:29 INFO - 'tabpaint']}, 08:07:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['tsvgx', 08:07:29 INFO - 'tsvgr_opacity', 08:07:29 INFO - 'tart', 08:07:29 INFO - 'tscrollx', 08:07:29 INFO - 'cart']}, 08:07:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:07:29 INFO - 'tsvgr_opacity', 08:07:29 INFO - 'tart', 08:07:29 INFO - 'tscrollx', 08:07:29 INFO - 'cart']}, 08:07:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'talos_options': ['--disable-e10s'], 08:07:29 INFO - 'tests': ['tp5o']}, 08:07:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'tests': ['tp5o']}, 08:07:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'talos_options': ['--disable-e10s', 08:07:29 INFO - '--xperf_path', 08:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:29 INFO - 'tests': ['tp5n']}, 08:07:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:29 INFO - 'talos_options': ['--xperf_path', 08:07:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:29 INFO - 'tests': ['tp5n']}}, 08:07:29 INFO - 'talos.zip': {'path': '', 08:07:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:29 INFO - Running post-action listener: _resource_record_post_action 08:07:29 INFO - ##### 08:07:29 INFO - ##### Running create-virtualenv step. 08:07:29 INFO - ##### 08:07:29 INFO - Running pre-action listener: _resource_record_pre_action 08:07:29 INFO - Running main action method: create_virtualenv 08:07:29 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:29 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 08:07:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:29 INFO - Using real prefix '/usr' 08:07:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:31 INFO - Installing pip.................done. 08:07:31 INFO - Return code: 0 08:07:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:31 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')]} 08:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:31 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')]} 08:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:31 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:31 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 08:07:31 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 08:07:31 INFO - Using env: {'DISPLAY': ':0', 08:07:31 INFO - 'HOME': '/home/cltbld', 08:07:31 INFO - 'LANG': 'en_US.UTF-8', 08:07:31 INFO - 'LANGUAGE': 'en_US:en', 08:07:31 INFO - 'LOGNAME': 'cltbld', 08:07:31 INFO - 'MAIL': '/var/mail/cltbld', 08:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:31 INFO - 'MOZ_NO_REMOTE': '1', 08:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:31 INFO - 'NO_EM_RESTART': '1', 08:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:31 INFO - 'PWD': '/builds/slave/test', 08:07:31 INFO - 'SHELL': '/bin/bash', 08:07:31 INFO - 'SHLVL': '1', 08:07:31 INFO - 'TERM': 'linux', 08:07:31 INFO - 'TMOUT': '86400', 08:07:31 INFO - 'USER': 'cltbld', 08:07:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:31 INFO - '_': '/tools/buildbot/bin/python'} 08:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:32 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 08:07:32 INFO - Cleaning up... 08:07:32 INFO - Return code: 0 08:07:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:32 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:32 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 08:07:32 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 08:07:32 INFO - Using env: {'DISPLAY': ':0', 08:07:32 INFO - 'HOME': '/home/cltbld', 08:07:32 INFO - 'LANG': 'en_US.UTF-8', 08:07:32 INFO - 'LANGUAGE': 'en_US:en', 08:07:32 INFO - 'LOGNAME': 'cltbld', 08:07:32 INFO - 'MAIL': '/var/mail/cltbld', 08:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:32 INFO - 'MOZ_NO_REMOTE': '1', 08:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:32 INFO - 'NO_EM_RESTART': '1', 08:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:32 INFO - 'PWD': '/builds/slave/test', 08:07:32 INFO - 'SHELL': '/bin/bash', 08:07:32 INFO - 'SHLVL': '1', 08:07:32 INFO - 'TERM': 'linux', 08:07:32 INFO - 'TMOUT': '86400', 08:07:32 INFO - 'USER': 'cltbld', 08:07:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:32 INFO - '_': '/tools/buildbot/bin/python'} 08:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:32 INFO - Downloading/unpacking psutil>=0.7.1 08:07:32 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 08:07:32 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 08:07:32 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 08:07:32 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 08:07:32 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 08:07:32 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 08:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:34 INFO - Installing collected packages: psutil 08:07:34 INFO - Running setup.py install for psutil 08:07:34 INFO - building 'psutil._psutil_linux' extension 08:07:34 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 08:07:34 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 08:07:34 INFO - building 'psutil._psutil_posix' extension 08:07:34 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 08:07:34 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 08:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:34 INFO - Successfully installed psutil 08:07:34 INFO - Cleaning up... 08:07:34 INFO - Return code: 0 08:07:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:07:34 INFO - Using env: {'DISPLAY': ':0', 08:07:34 INFO - 'HOME': '/home/cltbld', 08:07:34 INFO - 'LANG': 'en_US.UTF-8', 08:07:34 INFO - 'LANGUAGE': 'en_US:en', 08:07:34 INFO - 'LOGNAME': 'cltbld', 08:07:34 INFO - 'MAIL': '/var/mail/cltbld', 08:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:34 INFO - 'MOZ_NO_REMOTE': '1', 08:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:34 INFO - 'NO_EM_RESTART': '1', 08:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:34 INFO - 'PWD': '/builds/slave/test', 08:07:34 INFO - 'SHELL': '/bin/bash', 08:07:34 INFO - 'SHLVL': '1', 08:07:34 INFO - 'TERM': 'linux', 08:07:34 INFO - 'TMOUT': '86400', 08:07:34 INFO - 'USER': 'cltbld', 08:07:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:34 INFO - '_': '/tools/buildbot/bin/python'} 08:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:35 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 08:07:35 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 08:07:35 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 08:07:35 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 08:07:35 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 08:07:35 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 08:07:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:07:36 INFO - Installing collected packages: mozsystemmonitor 08:07:36 INFO - Running setup.py install for mozsystemmonitor 08:07:37 INFO - Successfully installed mozsystemmonitor 08:07:37 INFO - Cleaning up... 08:07:37 INFO - Return code: 0 08:07:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:37 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:37 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 08:07:37 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 08:07:37 INFO - Using env: {'DISPLAY': ':0', 08:07:37 INFO - 'HOME': '/home/cltbld', 08:07:37 INFO - 'LANG': 'en_US.UTF-8', 08:07:37 INFO - 'LANGUAGE': 'en_US:en', 08:07:37 INFO - 'LOGNAME': 'cltbld', 08:07:37 INFO - 'MAIL': '/var/mail/cltbld', 08:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:37 INFO - 'MOZ_NO_REMOTE': '1', 08:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:37 INFO - 'NO_EM_RESTART': '1', 08:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:37 INFO - 'PWD': '/builds/slave/test', 08:07:37 INFO - 'SHELL': '/bin/bash', 08:07:37 INFO - 'SHLVL': '1', 08:07:37 INFO - 'TERM': 'linux', 08:07:37 INFO - 'TMOUT': '86400', 08:07:37 INFO - 'USER': 'cltbld', 08:07:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:37 INFO - '_': '/tools/buildbot/bin/python'} 08:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:37 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 08:07:37 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 08:07:37 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 08:07:37 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 08:07:37 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 08:07:37 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 08:07:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 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 08:07:39 INFO - Downloading docopt-0.6.1.tar.gz 08:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:39 INFO - Running setup.py install for blobuploader 08:07:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:40 INFO - Running setup.py install for requests 08:07:40 INFO - Running setup.py install for docopt 08:07:40 INFO - Successfully installed blobuploader requests docopt 08:07:40 INFO - Cleaning up... 08:07:40 INFO - Return code: 0 08:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:40 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')]} 08:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:40 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')]} 08:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:40 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:40 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 08:07:40 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 08:07:40 INFO - Using env: {'DISPLAY': ':0', 08:07:40 INFO - 'HOME': '/home/cltbld', 08:07:40 INFO - 'LANG': 'en_US.UTF-8', 08:07:40 INFO - 'LANGUAGE': 'en_US:en', 08:07:40 INFO - 'LOGNAME': 'cltbld', 08:07:40 INFO - 'MAIL': '/var/mail/cltbld', 08:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:40 INFO - 'MOZ_NO_REMOTE': '1', 08:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:40 INFO - 'NO_EM_RESTART': '1', 08:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:40 INFO - 'PWD': '/builds/slave/test', 08:07:40 INFO - 'SHELL': '/bin/bash', 08:07:40 INFO - 'SHLVL': '1', 08:07:40 INFO - 'TERM': 'linux', 08:07:40 INFO - 'TMOUT': '86400', 08:07:40 INFO - 'USER': 'cltbld', 08:07:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:40 INFO - '_': '/tools/buildbot/bin/python'} 08:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:40 INFO - Running setup.py (path:/tmp/pip-9fNdAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:40 INFO - Running setup.py (path:/tmp/pip-rdfMTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:40 INFO - Running setup.py (path:/tmp/pip-06_FL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:40 INFO - Running setup.py (path:/tmp/pip-uaz2sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:41 INFO - Running setup.py (path:/tmp/pip-8dKML6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:41 INFO - Running setup.py (path:/tmp/pip-COW2ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:41 INFO - Running setup.py (path:/tmp/pip-BR9CWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:41 INFO - Running setup.py (path:/tmp/pip-UWZdWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:41 INFO - Running setup.py (path:/tmp/pip-3mlAPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:41 INFO - Running setup.py (path:/tmp/pip-3ykei8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:41 INFO - Running setup.py (path:/tmp/pip-HpGD5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:41 INFO - Running setup.py (path:/tmp/pip-8lU7kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:41 INFO - Running setup.py (path:/tmp/pip-n5Udhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:41 INFO - Running setup.py (path:/tmp/pip-xaE3sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:41 INFO - Running setup.py (path:/tmp/pip-kNHRHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:41 INFO - Running setup.py (path:/tmp/pip-5VIQxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:41 INFO - Running setup.py (path:/tmp/pip-VZLPwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:41 INFO - Running setup.py install for manifestparser 08:07:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Running setup.py install for mozcrash 08:07:42 INFO - Running setup.py install for mozdebug 08:07:42 INFO - Running setup.py install for mozdevice 08:07:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Running setup.py install for mozfile 08:07:42 INFO - Running setup.py install for mozhttpd 08:07:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Running setup.py install for mozinfo 08:07:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Running setup.py install for mozInstall 08:07:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:42 INFO - Running setup.py install for mozleak 08:07:42 INFO - Running setup.py install for mozlog 08:07:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Running setup.py install for moznetwork 08:07:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Running setup.py install for mozprocess 08:07:43 INFO - Running setup.py install for mozprofile 08:07:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Running setup.py install for mozrunner 08:07:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Running setup.py install for mozscreenshot 08:07:43 INFO - Running setup.py install for moztest 08:07:43 INFO - Running setup.py install for mozversion 08:07:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:43 INFO - Cleaning up... 08:07:43 INFO - Return code: 0 08:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:43 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')]} 08:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 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')]} 08:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:43 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:43 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 08:07:43 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 08:07:43 INFO - Using env: {'DISPLAY': ':0', 08:07:43 INFO - 'HOME': '/home/cltbld', 08:07:43 INFO - 'LANG': 'en_US.UTF-8', 08:07:43 INFO - 'LANGUAGE': 'en_US:en', 08:07:43 INFO - 'LOGNAME': 'cltbld', 08:07:43 INFO - 'MAIL': '/var/mail/cltbld', 08:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:43 INFO - 'MOZ_NO_REMOTE': '1', 08:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:43 INFO - 'NO_EM_RESTART': '1', 08:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:43 INFO - 'PWD': '/builds/slave/test', 08:07:43 INFO - 'SHELL': '/bin/bash', 08:07:43 INFO - 'SHLVL': '1', 08:07:43 INFO - 'TERM': 'linux', 08:07:43 INFO - 'TMOUT': '86400', 08:07:43 INFO - 'USER': 'cltbld', 08:07:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:43 INFO - '_': '/tools/buildbot/bin/python'} 08:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:43 INFO - Running setup.py (path:/tmp/pip-ZcdaHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:44 INFO - Running setup.py (path:/tmp/pip-gT26aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:44 INFO - Running setup.py (path:/tmp/pip-xFk2LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:44 INFO - Running setup.py (path:/tmp/pip-e2cAYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:44 INFO - Running setup.py (path:/tmp/pip-_pHDnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:44 INFO - Running setup.py (path:/tmp/pip-Y9IrTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:44 INFO - Running setup.py (path:/tmp/pip-D0QTDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:44 INFO - Running setup.py (path:/tmp/pip-NpzJjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:44 INFO - Running setup.py (path:/tmp/pip-Vb9LHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:44 INFO - Running setup.py (path:/tmp/pip-MpvAZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:44 INFO - Running setup.py (path:/tmp/pip-hH9jjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:44 INFO - Running setup.py (path:/tmp/pip-8iIS3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:44 INFO - Running setup.py (path:/tmp/pip-_Rjdty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:44 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)) 08:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:44 INFO - Running setup.py (path:/tmp/pip-KvqOep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:45 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)) 08:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:45 INFO - Running setup.py (path:/tmp/pip-O3UmhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:45 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)) 08:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:45 INFO - Running setup.py (path:/tmp/pip-vYxtex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:45 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)) 08:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:45 INFO - Running setup.py (path:/tmp/pip-0yQSBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:45 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)) 08:07:45 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)) 08:07:45 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)) 08:07:45 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)) 08:07:45 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)) 08:07:45 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)) 08:07:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:45 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 08:07:45 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 08:07:45 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 08:07:45 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 08:07:45 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 08:07:45 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 08:07:47 INFO - Downloading blessings-1.6.tar.gz 08:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:47 INFO - Installing collected packages: blessings 08:07:47 INFO - Running setup.py install for blessings 08:07:47 INFO - Successfully installed blessings 08:07:47 INFO - Cleaning up... 08:07:47 INFO - Return code: 0 08:07:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:47 INFO - Reading from file tmpfile_stdout 08:07:47 INFO - Current package versions: 08:07:47 INFO - argparse == 1.2.1 08:07:47 INFO - blessings == 1.6 08:07:47 INFO - blobuploader == 1.2.4 08:07:47 INFO - docopt == 0.6.1 08:07:47 INFO - manifestparser == 1.1 08:07:47 INFO - mozInstall == 1.12 08:07:47 INFO - mozcrash == 0.17 08:07:47 INFO - mozdebug == 0.1 08:07:47 INFO - mozdevice == 0.48 08:07:47 INFO - mozfile == 1.2 08:07:47 INFO - mozhttpd == 0.7 08:07:47 INFO - mozinfo == 0.9 08:07:47 INFO - mozleak == 0.1 08:07:47 INFO - mozlog == 3.1 08:07:47 INFO - moznetwork == 0.27 08:07:47 INFO - mozprocess == 0.22 08:07:47 INFO - mozprofile == 0.28 08:07:47 INFO - mozrunner == 6.11 08:07:47 INFO - mozscreenshot == 0.1 08:07:47 INFO - mozsystemmonitor == 0.0 08:07:47 INFO - moztest == 0.7 08:07:47 INFO - mozversion == 1.4 08:07:47 INFO - psutil == 3.1.1 08:07:47 INFO - requests == 1.2.3 08:07:47 INFO - wsgiref == 0.1.2 08:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:47 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:47 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 08:07:47 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 08:07:47 INFO - Using env: {'DISPLAY': ':0', 08:07:47 INFO - 'HOME': '/home/cltbld', 08:07:47 INFO - 'LANG': 'en_US.UTF-8', 08:07:47 INFO - 'LANGUAGE': 'en_US:en', 08:07:47 INFO - 'LOGNAME': 'cltbld', 08:07:47 INFO - 'MAIL': '/var/mail/cltbld', 08:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:47 INFO - 'MOZ_NO_REMOTE': '1', 08:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:47 INFO - 'NO_EM_RESTART': '1', 08:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:47 INFO - 'PWD': '/builds/slave/test', 08:07:47 INFO - 'SHELL': '/bin/bash', 08:07:47 INFO - 'SHLVL': '1', 08:07:47 INFO - 'TERM': 'linux', 08:07:47 INFO - 'TMOUT': '86400', 08:07:47 INFO - 'USER': 'cltbld', 08:07:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:47 INFO - '_': '/tools/buildbot/bin/python'} 08:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 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)) 08:07:47 INFO - Cleaning up... 08:07:47 INFO - Return code: 0 08:07:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07: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', 'jsonschema'] in /builds/slave/test/build 08:07: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 jsonschema 08:07:47 INFO - Using env: {'DISPLAY': ':0', 08:07:47 INFO - 'HOME': '/home/cltbld', 08:07:47 INFO - 'LANG': 'en_US.UTF-8', 08:07:47 INFO - 'LANGUAGE': 'en_US:en', 08:07:47 INFO - 'LOGNAME': 'cltbld', 08:07:47 INFO - 'MAIL': '/var/mail/cltbld', 08:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:47 INFO - 'MOZ_NO_REMOTE': '1', 08:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:47 INFO - 'NO_EM_RESTART': '1', 08:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:47 INFO - 'PWD': '/builds/slave/test', 08:07:47 INFO - 'SHELL': '/bin/bash', 08:07:47 INFO - 'SHLVL': '1', 08:07:47 INFO - 'TERM': 'linux', 08:07:47 INFO - 'TMOUT': '86400', 08:07:47 INFO - 'USER': 'cltbld', 08:07:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:47 INFO - '_': '/tools/buildbot/bin/python'} 08:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:47 INFO - Downloading/unpacking jsonschema 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:49 INFO - Downloading/unpacking functools32 (from jsonschema) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:07:50 INFO - warning: no files found matching '*.txt' 08:07:50 INFO - no previously-included directories found matching 'build' 08:07:50 INFO - no previously-included directories found matching 'dist' 08:07:50 INFO - no previously-included directories found matching '.git*' 08:07:50 INFO - Installing collected packages: jsonschema, functools32 08:07:50 INFO - Running setup.py install for functools32 08:07:50 INFO - warning: no files found matching '*.txt' 08:07:50 INFO - no previously-included directories found matching 'build' 08:07:50 INFO - no previously-included directories found matching 'dist' 08:07:50 INFO - no previously-included directories found matching '.git*' 08:07:50 INFO - Successfully installed jsonschema functools32 08:07:50 INFO - Cleaning up... 08:07:50 INFO - Return code: 0 08:07:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:07:50 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')]} 08:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:50 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')]} 08:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:50 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 0x7f9a32e89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24249a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, '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': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', '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 08:07:50 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 08:07:50 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 08:07:50 INFO - Using env: {'DISPLAY': ':0', 08:07:50 INFO - 'HOME': '/home/cltbld', 08:07:50 INFO - 'LANG': 'en_US.UTF-8', 08:07:50 INFO - 'LANGUAGE': 'en_US:en', 08:07:50 INFO - 'LOGNAME': 'cltbld', 08:07:50 INFO - 'MAIL': '/var/mail/cltbld', 08:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:50 INFO - 'MOZ_NO_REMOTE': '1', 08:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:50 INFO - 'NO_EM_RESTART': '1', 08:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:50 INFO - 'PWD': '/builds/slave/test', 08:07:50 INFO - 'SHELL': '/bin/bash', 08:07:50 INFO - 'SHLVL': '1', 08:07:50 INFO - 'TERM': 'linux', 08:07:50 INFO - 'TMOUT': '86400', 08:07:50 INFO - 'USER': 'cltbld', 08:07:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:50 INFO - '_': '/tools/buildbot/bin/python'} 08:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:50 INFO - Downloading/unpacking flake8 08:07:50 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 08:07:50 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 08:07:50 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 08:07:50 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 08:07:50 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 08:07:50 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 08:07:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:07:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:07:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:53 INFO - no previously-included directories found matching 'docs/_build' 08:07:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:07:53 INFO - Running setup.py install for pep8 08:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:53 INFO - no previously-included directories found matching 'docs/_build' 08:07:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:07:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:07:53 INFO - Cleaning up... 08:07:53 INFO - Return code: 0 08:07:53 INFO - Running post-action listener: _resource_record_post_action 08:07:53 INFO - Running post-action listener: _start_resource_monitoring 08:07:53 INFO - Starting resource monitoring. 08:07:53 INFO - ##### 08:07:53 INFO - ##### Running install step. 08:07:53 INFO - ##### 08:07:53 INFO - Running pre-action listener: _resource_record_pre_action 08:07:53 INFO - Running main action method: install 08:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:53 INFO - Reading from file tmpfile_stdout 08:07:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:53 INFO - Reading from file tmpfile_stdout 08:07:53 INFO - Output received: 08:07:53 INFO - Usage: mozinstall [options] installer 08:07:53 INFO - Options: 08:07:53 INFO - -h, --help show this help message and exit 08:07:53 INFO - -d DEST, --destination=DEST 08:07:53 INFO - Directory to install application into. [default: 08:07:53 INFO - "/builds/slave/test"] 08:07:53 INFO - --app=APP Application being installed. [default: firefox] 08:07:53 INFO - mkdir: /builds/slave/test/build/application 08:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:10 INFO - Reading from file tmpfile_stdout 08:08:10 INFO - Output received: 08:08:10 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:10 INFO - Running post-action listener: _resource_record_post_action 08:08:10 INFO - ##### 08:08:10 INFO - ##### Running run-tests step. 08:08:10 INFO - ##### 08:08:10 INFO - Running pre-action listener: _resource_record_pre_action 08:08:10 INFO - Running main action method: run_tests 08:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:10 INFO - Python 2.7.3 08:08:10 INFO - Return code: 0 08:08:10 INFO - grabbing minidump binary from tooltool 08:08:10 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')]} 08:08:10 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 0x24b3810>, '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 0x24b4710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b4ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:10 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 08:08:10 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 08:08:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:10 INFO - Return code: 0 08:08:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:11 INFO - Return code: 0 08:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 08:08:11 INFO - Using env: {'DISPLAY': ':0', 08:08:11 INFO - 'HOME': '/home/cltbld', 08:08:11 INFO - 'LANG': 'en_US.UTF-8', 08:08:11 INFO - 'LANGUAGE': 'en_US:en', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MAIL': '/var/mail/cltbld', 08:08:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SHLVL': '1', 08:08:11 INFO - 'TERM': 'linux', 08:08:11 INFO - 'TMOUT': '86400', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - '_': '/tools/buildbot/bin/python'} 08:08:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:08:11 INFO - mozversion application_buildid: 20160414053016 08:08:11 INFO - mozversion application_changeset: 30010c0e58af2b863b6f56bb9d1e519128832eb5 08:08:11 INFO - mozversion application_display_name: Nightly 08:08:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:11 INFO - mozversion application_name: Firefox 08:08:11 INFO - mozversion application_remotingname: firefox 08:08:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:11 INFO - mozversion application_vendor: Mozilla 08:08:11 INFO - mozversion application_version: 48.0a1 08:08:11 INFO - mozversion platform_buildid: 20160414053016 08:08:11 INFO - mozversion platform_changeset: 30010c0e58af2b863b6f56bb9d1e519128832eb5 08:08:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:11 INFO - mozversion platform_version: 48.0a1 08:08:11 INFO - using testdate: 1460646491 08:08:11 INFO - actual date: 1460646491 08:08:11 INFO - starting webserver on 'localhost:57646' 08:08:11 INFO - SUITE-START | Running 2 tests 08:08:11 INFO - TEST-START | dromaeo_css 08:08:11 INFO - operating with platform_type : linux_ 08:08:11 INFO - Initialising browser for dromaeo_css test... 08:08:11 INFO - TEST-INFO | started process 16932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCmaujZ/profile http://localhost:57646/getInfo.html) 08:08:15 INFO - PROCESS | 16932 | __metrics Screen width/height:1600/1200 08:08:15 INFO - PROCESS | 16932 | colorDepth:24 08:08:15 INFO - PROCESS | 16932 | Browser inner width/height: 1024/697 08:08:15 INFO - PROCESS | 16932 | __metrics 08:08:16 ERROR - PROCESS | 16932 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:08:17 INFO - TEST-INFO | 16932: exit 0 08:08:17 INFO - Browser initialized. 08:08:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:17 INFO - TEST-INFO | started process 17015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCmaujZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:29 INFO - PROCESS | 17015 | RSS: Main: 152784896 08:08:29 INFO - PROCESS | 17015 | 08:09:20 INFO - PROCESS | 17015 | 1460646560606 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] 08:11:28 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57646/tests/dromaeo/cssquery-ext.html) 08:11:29 INFO - PROCESS | 17015 | RSS: Main: 273649664 08:11:29 INFO - PROCESS | 17015 | 08:14:31 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-ext.html (next: http://localhost:57646/tests/dromaeo/cssquery-jquery.html) 08:14:32 INFO - PROCESS | 17015 | RSS: Main: 239140864 08:14:32 INFO - PROCESS | 17015 | 08:17:33 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57646/tests/dromaeo/cssquery-mootools.html) 08:17:34 INFO - PROCESS | 17015 | RSS: Main: 245792768 08:17:34 INFO - PROCESS | 17015 | 08:20:36 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57646/tests/dromaeo/cssquery-prototype.html) 08:20:36 INFO - PROCESS | 17015 | RSS: Main: 234450944 08:20:36 INFO - PROCESS | 17015 | 08:23:39 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57646/tests/dromaeo/cssquery-yui.html) 08:23:40 INFO - PROCESS | 17015 | RSS: Main: 223248384 08:23:40 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:57646/tests/dromaeo/cssquery-yui.html (next: http://localhost:57646/tests/dromaeo/cssquery-dojo.html) 08:26:42 INFO - PROCESS | 17015 | RSS: Main: 269807616 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | __start_tp_report 08:26:42 INFO - PROCESS | 17015 | _x_x_mozilla_page_load 08:26:42 INFO - PROCESS | 17015 | _x_x_mozilla_page_load_details 08:26:42 INFO - PROCESS | 17015 | |i|pagename|runs| 08:26:42 INFO - PROCESS | 17015 | |0;dojo.html;3118.968810311897;3179.6661350558206;3216.935661286774;3217.6138863336387;3252.3495300939803;5141.074606570815;5178.4562620924735;5367.46325367463;5382.327209098858;5502.6148169628095;5287.4976877196705;5306.655067420625;5332.440093790155;5440.455954404558;5465.699386533739;4783.210770222909;4841.975790121044;4880.682755620891;4894.094592500399;5028.974855125719;4951.826686065989;4987.850364489053;5003.499650034985;5017.322661440695;5018.924716129261;4758.072175925696;4859.441164266119;4952.975235123838;4965.503449655042;4970.155073637472;4891.4863939286215;4909.68087074339;4925.556699897026;4925.950740492585;4933.333999910002;4796.304535842283;4826.420829500447;4836.637252206098;4853.660243782937;4876.146674332013;5069.771860266297;5245.947540524584;5256.684598924076;5358.115910874701;5373.194020896858;5738.856528586777;5771.740271687784;5790.7394167262155;5794.420557944214;5811;5788.160716696098;5838.2702162229725;5848.356680765112;5849.415058494159;5853.619514731528;5240.135377662681;5278.9208161877605;5327.733613319358;5328.120860058086;5330.893382132335;5750.3099628044065;5752.223449834219;5766.04860198071;5796.188533605298;5798.072308430631;5510.8071217507195;5516.9448305517235;5522.779088836482;5523.751431185607;5554.666719996813;5562.110062390079;5594.440555944454;5600.52395546375;5600.775968961196;5630.577706671934;5502.202180683858;5506.03644362235;5506.256655351556;5509.779608815603;5511.641743286754;5480.7533660985355;5520.834374968757;5523.6685798852195;5523.7238138093735;5531.585131115183;4261.31818908973;4261.701680882308;4292.441982542249;4417.580329868657;4419.204543182258;3900.9804950975063;3909.1204478992;3922.7057970652313;3943.92112157761;3952.7628342299554;5441.075017247077;5456.61803673747;5464.535514481234;5466.5900057495055;5506.201600767866;5592.105263157875;5681.34664513578;5741.913871291934;5760.942390576124;5764.625299355528;5478.534324582375;5501.449855014466;5513.035218836688;5513.61404701675;5514.944850551524;4973.875653108701;4988.6757360771435;5007.399112106497;5012.373453318335;5059.266406371055;5699.886002279931;5966.105084237312;6023.1266466363;6024.518038556905;6057.121717350959;5764.711764411846;5772.884542309214;5773.278340207474;5796.652200867961;5801.970990145022;5704.372519022987;5970.671613061149;5978.521718262616;5979.043353063489;5983.282006159288;5517.503424691637;5553.222548843246;5591.440855914376;5599.384067752462;5606.579506536945;5682.886342273214;5684.346300175367;5693.373728889736;5696.572757043155;5699.943000570107;5446.455354464521;5530.474604912527;5540.86147846291;5542.556595472433;5559.388467268678;5486.039943010037;5520.309961254843;5525.972370138124;5537.1140617501005;5572.60991730575;5418.295621569171;5543.944560554342;5558.694271815089;5560.694161821139;5564.443555644403;5340.279062326692;5572.164175373727;5631.267935168566;5656.547476201812;5689.203511508475;5525.475079867406;5538.47384498472;5540.168974653673;5541.445855414427;5598.356189038313 08:26:42 INFO - PROCESS | 17015 | |1;ext.html;604.739961816419;637.4517914593449;639.4309064932211;640.823773462298;659.2023651381828;30071.398572028575;36848.81575592122;37712.43431348532;37789;37830;40555.797221013854;41133;41228.38157427641;41324.380134297935;41341.79329103358;8475.491470511774;8763.211310982011;8768.167024132728;8769.079246679103;8769.386142969995;8642.827143457127;8740.475571465733;8752.081031491698;8770.122987701243;8772.298216142693;8802.735917922473;8856.73429797104;8867.512286824222;8876.289896808272;8877.334199934998;8685.218330350268;8730.912690873138;8795.120487951217;8805.42764720291;8814.206721395074;8535.786605334853;8713.085126061798;8719.869201961976;8725.258353039999;8729.214370706666;39300;39827.601723982676;39848.40227396591;39871.8006409969;39918;3344.2141096842224;3498.702610278129;3511.5961664408665;3511.877084302037;4402.845900393503;30004.69995300041;30595.38809223803;30941;30962.380752384826;31212.8439357804;3677.3013127505956;3736.308782875177;3784.6972242220554;3820.369639009588;3826.445165450994;290689;291600.9999999979;292356.0732945038;292789;293006;51606.74196628993;52828;53173.734131329096;53259.20111198335;53303.20045199325;54976;56710.7164464175;63913.680431597546;65852.670736646;66244.6687766558;13837.515686950908;14017.649558761113;14062.43750249999;14063;14066.085704429179;9952.203823694088;10618;10673.83989240162;10678;10679.252452328417;15880.52358429226;16345.34618615266;16370.83629163717;16413.83586164147;16535.586610334598;6446.806595802133;6490.935090649033;6491.67541622917;6507.8698426031215;6655.434288085567;969.9612015519441;1013.7212266626736;1068.455087905174;1072.1690689715376;1183.928964262147;32467.51298730521;32672.67327326744;32683;32803.1799205017;32971.50542741861;1124.5670416889557;1140.7319279969201;1174.9647510574696;1208.7642909632536;1297.0855546839455;16864.915675421544;17316.393926212775;17349.392771252944;17534.561635959202;17547.21037553313;406291;411039;411387;411717;412908;57346;58001.12998305029;58155.127673084935;58325;58647.4135258642;1344.8117263583106;1381.0677792490028;1394.9302534873216;1398.8741013308647;1408.2114016150783;30519.694803052575;31613.683863161074;31759.84120079385;32058.038258852273;32444.675553244164;49896;50409;50495.49504504908;50525;50552;356186;364786;370520;370582;371124;33615.495767563014;39458.80270598629;40413.79793101016;40722;41205.55780547787;41565.79217103895;42249.577504224566;42535;42639;43250.13499729925;35189.29621407506;35381.82309088438;35617.46573801447;35875.641243588274;35934.460983085795;36058.27883442369;38802.80598596989;39013;39118;39388.212235755695;39204;39762.60237397589;39801;40017.79991100026;40057.19599627998;33999.98000060002;34313.313733725685;35142.472862906565;35165.82417087898;35323.82085612307;27427.862860685567;27489.587656185573;27692.861535693;27715.44569108647;27779.44441111126 08:26:42 INFO - PROCESS | 17015 | |2;jquery.html;389.3653345047573;391.35621901971257;394.8973266950592;399.59241573594915;405.4384677222047;17474.82525174748;17844.732329015074;18135.546611334725;18174.182161802717;18232.908835455837;16690.58273543162;17225.655486890253;17291.913540432313;17568.912155439204;17829.286828526845;5164.2253661950635;5660.150977353389;5789.9710501447435;5811.099279611646;5836.766529338843;5585.776568937237;5590.580706447033;5608.4391560844;5617.859553511174;5624.100143976964;5570.303712035996;5575.2473416088915;5589.74846131923;5610.859728506779;6308.337624549425;6225.252969643627;6227.190465239535;6241.968790156043;6270.247570291572;6276.3409841966395;5354.196870469422;5443.237946687467;5645.23789288449;5646.661200327952;5648;13341.266230357327;13393.732125357536;13403.061785675007;17573;21963.121475140975;2165.2096984600666;2238.0264584905453;2269.375921621551;2325.9534809303887;2368.857868527894;9423.246140308758;9627.711168664951;9942.850857237147;10020.849687254697;10076.244281678903;1794.8923064616033;1865.3191585071352;1867.1597780998604;1870.710039943811;1908.7041508566194;76362;78176.60911695405;78643.21356786473;78766;79980.99999999942;10631.84052239217;10822.621208257673;10823.67528974132;10872.238943273895;11040.116790656728;15043.699126017418;15123.31945062475;15137.697246055017;15153.242337883063;15157.696846063018;7595.430342724208;7607.782754759212;7761.107472640719;7826.960865195638;7838.294553490213;7234.529755565872;7244.963775181091;7262.346388824925;7295.124585049828;7447.329740323397;4585.541445855454;4592.6555508337005;4635.490096089427;4637.675362724577;4688.062387522509;1676.5138109948223;1682.587765997314;1695.981781679797;1707.6840784454917;1725.1546742096534;1006.2568535122165;1017.2269075502671;1049.1554298789395;1056.4879449477728;1082.2099867096906;18178.90910545439;18349.633007339777;18612.162452689663;19112.713309300372;19283.132259048096;970.825251454745;980.926430517714;1006.5470538257813;1030.3766221436074;1080.3517889266377;10129.544170512345;10612.151027917747;10626.840597391045;10709.143268538654;10731;483098;488221;488585;496106;497123;88925;89094;91613;91955.5402222998;92207.5389623061;1045.858809060767;1047.1256500821898;1104.4256986367045;1120.3166068698088;1124.3254047571554;16252.66820301859;16598.75101873449;16706.4152754653;16841.831581684026;16983.575410614834;35910.28179436449;36111;36518.45222321614;36768.81615591905;37409.625903741704;49539.752301238266;52956.47043529515;53532.73233633807;53535.732321338146;53967.73016134894;7304.306090921354;7639.427042971688;7686.654100565376;8247.463914845515;8492.830143397221;9173.816523669622;11906;12299.69250768738;12379.62861114168;12649.557265496032;10851.186161037796;11186.8106674905;11571.942140289244;11732.530698771954;11867.287962722265;11387.601433949772;11409.828852567383;11411.828822567833;11548.884511155116;11553.24903881245;11781.705457363634;11878.406079695807;11912.52349905994;12107.757844842878;12142.75714485723;7777.066751989797;7777.57223352721;7852.528848269122;7912.446128770931;8108.878366824621;11369.829452558053;11814.291142531476;11817.763644726885;11838.052955763345;11977.023791074374 08:26:42 INFO - PROCESS | 17015 | |3;mootools.html;1322.3718733601534;1522.0943538594536;1545.042073914173;1710.5980094677748;1796.8652351073672;6681.432078273347;7628.504147230433;7856.9607151964165;7865.331446827012;7870.763877083682;7374.594397308146;7592.658330375132;7616.04799400075;7629.656665450054;7640.426967977396;1946.3966170487195;2191.375457994472;2230.966535501969;2256.6727824465443;2270.8069814065825;2255.4812393149587;2278.51012032413;2280.8061314788265;2281.7376001759762;2282.1327895399727;2238.787315205053;2280.1677387753434;2284.0635339510804;2286.4855407533255;2288.2906299047268;1974.3484650065443;2159.676048592708;2231.0852550454238;2232.363776323756;2233.553289342138;2186.7922547357975;2217.8225741940605;2229.4314949687728;2229.8662080275235;2245.517213799041;7759.9612001940195;7813;7817.921820781777;7822.374210063182;7826.530408175528;4821.662483626147;5019.42276638184;5033.144365457881;5042.571381432583;5126.61550383719;3269.362474317509;3282.2614911644687;3335.399628066947;3345.3978283908887;3360.83195840207;1049.5539395756773;1067.6370034188412;1081.783643271341;1082.4046774274198;1134.3704244144496;10701.892981070168;10929.125669946465;10931;10933.453327333602;10960.616378426797;4383.649308055348;4424.668149888771;4577.5880170784785;4629.8842528936375;4632.328312394684;9372.718818435458;9383.5308234588;9386.85919711205;9387.34288599805;9388.765280868032;4331.696781225284;5064.290999260106;5077.213031980049;5080.974595127074;5096.566791822663;4453.955460445354;4558.316252562142;4564.109998550251;4590.609798167126;4613.907721845544;3856.4986551748093;3931.368482079905;3952.545457272393;3977.7414468059483;4016.116454380032;1264.974700506003;1293.6765808547864;1298.7792075347213;1300.9609711708663;1302.908796384244;950.2825366848124;971.3006635222629;977.2621670638764;978.515634760798;980.8479685648736;5477.452254774491;5532.7786888524815;5573.804916827891;5625.071863142617;5750.482456578928;436.8754904852165;439.2291528367694;440.55063834888875;442.34091204106295;464.7745843266013;3863.478430411915;3893.980530097331;3912.784796836201;3926.293267211929;3963.147923196527;9416.717498475056;9680.27397945157;9791.804163916824;9870.506474676238;9932.801343973224;9651;9664.081912218327;9882.752931176778;9884.209263258923;9895.406275623342;7189.5686258824635;7245.384142347854;7303.926960730431;7345.559266444137;7353.301436363537;5250;5450.591205659671;5497.038018346693;5511.448855114457;5554.50009499147;8588.153546987427;8658.264047556027;8659.653613855628;8809.779755506164;8884.600192991202;8574.142585741376;8786.516741579275;8927.151920567536;9066.682666106655;9071.365004449624;6305.464035557029;6522.869542609216;6534.901976470262;6844.384005439534;6923;7352.044234249727;7518.661660225193;7549.207333230152;7552.546847189186;7567.545947243183;6854.143232095988;6981.685824137824;6982.615956122462;7074.823129421806;7089.468289878383;6717.093192418961;6723.125993620798;6724.49566282521;6933.37599616037;6934.098567186234;6289.119523266838;6335.556511044367;6358.332375100548;6368.172137622079;6516.706748196438;4762.738049407316;4896.534829191221;4902.803887844446;4918.950810491992;4978.502149784992;4696.812127514998;4734;4824.300476430828;4886.242632391985;5003.124453220599 08:26:42 INFO - PROCESS | 17015 | |4;prototype.html;316.96988786065316;323.2162007132703;323.2581226086131;328.2859779978549;328.77807479951025;5608.971955140229;5623.662580245188;5648.350439699436;5663.377028526864;5669.659820410773;5255.632105752599;5320.414754377025;5460.453954604547;5529;5543.695096769686;4287.592678695534;4314.590113939171;4319.632831209351;4328.3074708046715;4328.783560821962;4305.137083839243;4307.784610769465;4320.416743739602;4326.156399502099;4333.718308309965;4075.857344992926;4157.272477316473;4261.595148460907;4287.378330142127;4322.135572885435;4256.382824490432;4260;4260.573942605745;4286.185624731306;4295.8330419493195;3761.4733937248534;3766.4162054881535;3782.7541209821275;3790.4503846942316;3797.1456422305037;5244.632875698702;5362.0616392131615;5378.865528361783;5392.649477783932;5400.729963501848;4937.5556199942175;4953.777080031407;4954.925676114825;4990.251462280687;4994.101061808873;5791.102379131242;5825.359210486843;5827.941720582782;5833.32916714579;5850.619709718854;4060.167665628539;4130.586941305875;4132.896677583054;4142.668586513072;4157.210130075276;6037.939620603782;6060.757569697207;6073.665948372838;6074.453299203049;6080.8750381179625;4247.957520424818;4251.532331443539;4259.254630439661;4259.42497762798;4260.062786187033;4223.788810559521;4343.326784348431;4346.782660866944;4357.346398040256;4364.388985542027;4901.260052681247;4910.754462276872;4934.555889969848;4937.901241975141;4957.256411538298;5760.654360738369;5879.823605291848;5880.411958804171;5904.468597826216;5914.852128696731;1400.4958215042577;1444.949426770058;1456.2354763749117;1490.5155824357128;1497.445945000357;1007.4056306779036;1013.8735347137228;1024.1601886453036;1025.2464438637596;1025.47700672656;5618.410066942912;5636.774529018875;5640.746166422521;5646.88241909284;5647.887042259214;5885.852853678693;5945.256842894638;5976.880462390728;5988.341282458926;5993.790217342372;5411;5593.888122237532;5608.1027035674915;5608.69152196625;5615.466530679579;3169.3819705157734;3171.5401266816184;3174.1429813950103;3196.1210667066744;3201.6318123416104;5972.940270597325;6134.263888333339;6136.570440069241;6158.291796443376;6161.045038019114;5946.554008449383;6012.30858451275;6057.666828324396;6087.1173679816175;6093.299270583851;6023.488003519662;6063.120847477091;6080.270367555921;6113.296970848321;6119.724612392453;5749.115959351495;5909.438603332676;5928.110783382354;5950.732217050157;5953.642781433128;5776.913346299725;5824.805914787374;5845.269341332333;5859.472647461749;5868.530517558671;5958.76164953397;6114.357992410733;6128.142060111499;6142.692865356625;6149.385061493815;4246.810892949979;4249.36259561056;4265.445492086009;4269.4449721536;4270.743755374688;5789.1605717171615;5951.345352011362;5952;5958.672273025025;5968.8806223876145;5741.885162296814;5905.143754155709;5906.1140828874295;5920.230370051866;5931.4114960448305;5857.297124345106;5912.586118971631;5917.5857689961285;5918.881622367615;5926.822195334147;5637.718114094361;5761.711914404347;5770.307563092456;5809.390014048464;5822.254862287223;5883.058710606282;5929.495992840484;5949.970250148722;5950.166976623363;5969.164316995711;5717.338766053508;5763.5965482417505;5813.302403711582;5822.563307752021;5827.854303642443 08:26:42 INFO - PROCESS | 17015 | |5;yui.html;754.5057987018502;757.1784613694145;784.6508303804806;814.6049166154411;885.6103314541599;12644.810327845078;12949.22304661721;13113.868861311385;13133.737325253489;13137.73724525509;11941;13031.869681303184;13057.804132938014;13173.34133293334;13225.404856781444;812.1999830167296;817.3502065857627;821.9630116644736;823.6170180865896;824.381713714714;811.7280710961805;812.0255693168192;812.3866480806983;817.1175130858688;820.5281962871343;845.5222799118509;846.6613354658156;846.7967687754925;847.0132295875297;847.8812966184739;835.9122292159296;837.7277384849917;844.1727107434748;844.3835999720177;846.2130218896424;615.575253075381;622.8069298517474;622.8878801815671;622.9345918678564;623.0498489803041;11548.364839933884;11631.360275184861;11780.410979450993;11811.055115590732;11851.822222666668;11948.70128246792;12015.219010764273;12016.639500814903;12115;12143.210691305037;10491.58033678652;10492.685219443429;10593.364398136137;10718.356898586031;10806.891931080667;3691.9261614767825;3742.7754334740002;3754.8685795997008;3789.4315852622053;3790.65884070435;54273;57050.714746426005;57204.71397643027;57217.14174287389;57233.427665723226;9066.773330666787;9277.67528136512;9379.90620093804;9428.292878034175;9595;18420;18677.252909883453;18677.439676809718;18678.626427471645;18691;7766.611669416619;7833.686652533835;7967.402444816662;8078.919210807934;8113.269805717396;4485.102979404132;4546.795394207269;4585.931211031837;4595.655325850507;4633.7683115844075;3068.094912000965;3137.1843320736316;3166.8099914005234;3177.3645270945904;3183.8567264473154;597.9790707325222;599.5623195067625;604.0576700347472;605.6971514242879;606.5541826757329;636.9867756006403;649.9512536559777;682.8258794007596;708.9007538944552;722.7553934010157;9048.728538143867;9147.664773909677;9204.447733136034;9211.585478653476;9449.38578992377;713.7957430732987;720.3664085930124;747.5701471653712;765.2768134113321;780.7852840468803;4054.779272922418;4097.610726980932;4108.650764685035;4157.272477316457;4167.708260421741;64327;65037.67481162564;65825.67087164533;65829.6708516464;65913;39629.80185099056;51217;52541.7372913133;54272.185917211275;55968;50475.74762126166;51523.48476515187;51679.93280268822;52181.7390913043;52515;7962.482438641469;8106.918930810616;9522.61909523639;9542.810800591287;9823.115919567274;29913;29990.25024374408;30685.69857260759;31197.220069497536;31380.686193137775;41747;42085.36871946984;42413.15173696571;44815.327770082826;45005.774971124934;11803.114766392726;11891.924155906156;11974.700632484257;12104.09219308573;12349.876501234872;12891.355432228163;13036.283004434847;13211.66970825737;13686.794698079337;13736.725265494435;11192.496337664661;11295.209335346446;11536.712037069396;11554.94222528882;11602.535898563963;11897.702557436134;11991.520339186334;12040.698982525508;12185.634430967086;12467.314297713712;11028.779424411627;11083;11183.496742646763;11271.492782824957;12248.14263001617;9562.952185239308;9686.814641627814;9826.754331141492;9902.900970990486;9920.305578609428;9559.486645855122;10247.600403511537;10282.794344113225;10475.423851687925;10485.423301718478 08:26:42 INFO - PROCESS | 17015 | __end_tp_report 08:26:42 INFO - PROCESS | 17015 | __start_cc_report 08:26:42 INFO - PROCESS | 17015 | _x_x_mozilla_cycle_collect,968 08:26:42 INFO - PROCESS | 17015 | __end_cc_report 08:26:42 INFO - PROCESS | 17015 | __startTimestamp1460647602649__endTimestamp 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | ------- Summary: start ------- 08:26:42 INFO - PROCESS | 17015 | Number of tests: 6 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#0] dojo.html Cycles:165 Average:5305.78 Median:5511.64 stddev:579.67 (10.5%) stddev-sans-first:555.48 08:26:42 INFO - PROCESS | 17015 | Values: 3119.0 3179.7 3216.9 3217.6 3252.3 5141.1 5178.5 5367.5 5382.3 5502.6 5287.5 5306.7 5332.4 5440.5 5465.7 4783.2 4842.0 4880.7 4894.1 5029.0 4951.8 4987.9 5003.5 5017.3 5018.9 4758.1 4859.4 4953.0 4965.5 4970.2 4891.5 4909.7 4925.6 4926.0 4933.3 4796.3 4826.4 4836.6 4853.7 4876.1 5069.8 5245.9 5256.7 5358.1 5373.2 5738.9 5771.7 5790.7 5794.4 5811.0 5788.2 5838.3 5848.4 5849.4 5853.6 5240.1 5278.9 5327.7 5328.1 5330.9 5750.3 5752.2 5766.0 5796.2 5798.1 5510.8 5516.9 5522.8 5523.8 5554.7 5562.1 5594.4 5600.5 5600.8 5630.6 5502.2 5506.0 5506.3 5509.8 5511.6 5480.8 5520.8 5523.7 5523.7 5531.6 4261.3 4261.7 4292.4 4417.6 4419.2 3901.0 3909.1 3922.7 3943.9 3952.8 5441.1 5456.6 5464.5 5466.6 5506.2 5592.1 5681.3 5741.9 5760.9 5764.6 5478.5 5501.4 5513.0 5513.6 5514.9 4973.9 4988.7 5007.4 5012.4 5059.3 5699.9 5966.1 6023.1 6024.5 6057.1 5764.7 5772.9 5773.3 5796.7 5802.0 5704.4 5970.7 5978.5 5979.0 5983.3 5517.5 5553.2 5591.4 5599.4 5606.6 5682.9 5684.3 5693.4 5696.6 5699.9 5446.5 5530.5 5540.9 5542.6 5559.4 5486.0 5520.3 5526.0 5537.1 5572.6 5418.3 5543.9 5558.7 5560.7 5564.4 5340.3 5572.2 5631.3 5656.5 5689.2 5525.5 5538.5 5540.2 5541.4 5598.4 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#1] ext.html Cycles:180 Average:52283.75 Median:39065.50 stddev:94707.01 (242.4%) stddev-sans-first:94893.20 08:26:42 INFO - PROCESS | 17015 | Values: 604.7 637.5 639.4 640.8 659.2 30071.4 36848.8 37712.4 37789.0 37830.0 40555.8 41133.0 41228.4 41324.4 41341.8 8475.5 8763.2 8768.2 8769.1 8769.4 8642.8 8740.5 8752.1 8770.1 8772.3 8802.7 8856.7 8867.5 8876.3 8877.3 8685.2 8730.9 8795.1 8805.4 8814.2 8535.8 8713.1 8719.9 8725.3 8729.2 39300.0 39827.6 39848.4 39871.8 39918.0 3344.2 3498.7 3511.6 3511.9 4402.8 30004.7 30595.4 30941.0 30962.4 31212.8 3677.3 3736.3 3784.7 3820.4 3826.4 290689.0 291601.0 292356.1 292789.0 293006.0 51606.7 52828.0 53173.7 53259.2 53303.2 54976.0 56710.7 63913.7 65852.7 66244.7 13837.5 14017.6 14062.4 14063.0 14066.1 9952.2 10618.0 10673.8 10678.0 10679.3 15880.5 16345.3 16370.8 16413.8 16535.6 6446.8 6490.9 6491.7 6507.9 6655.4 970.0 1013.7 1068.5 1072.2 1183.9 32467.5 32672.7 32683.0 32803.2 32971.5 1124.6 1140.7 1175.0 1208.8 1297.1 16864.9 17316.4 17349.4 17534.6 17547.2 406291.0 411039.0 411387.0 411717.0 412908.0 57346.0 58001.1 58155.1 58325.0 58647.4 1344.8 1381.1 1394.9 1398.9 1408.2 30519.7 31613.7 31759.8 32058.0 32444.7 49896.0 50409.0 50495.5 50525.0 50552.0 356186.0 364786.0 370520.0 370582.0 371124.0 33615.5 39458.8 40413.8 40722.0 41205.6 41565.8 42249.6 42535.0 42639.0 43250.1 35189.3 35381.8 35617.5 35875.6 35934.5 36058.3 38802.8 39013.0 39118.0 39388.2 39204.0 39762.6 39801.0 40017.8 40057.2 34000.0 34313.3 35142.5 35165.8 35323.8 27427.9 27489.6 27692.9 27715.4 27779.4 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#2] jquery.html Cycles:180 Average:28162.70 Median:2253.70 stddev:80827.44 (3586.4%) stddev-sans-first:81027.28 08:26:42 INFO - PROCESS | 17015 | Values: 389.4 391.4 394.9 399.6 405.4 17474.8 17844.7 18135.5 18174.2 18232.9 16690.6 17225.7 17291.9 17568.9 17829.3 5164.2 5660.2 5790.0 5811.1 5836.8 5585.8 5590.6 5608.4 5617.9 5624.1 5570.3 5575.2 5589.7 5610.9 6308.3 6225.3 6227.2 6242.0 6270.2 6276.3 5354.2 5443.2 5645.2 5646.7 5648.0 13341.3 13393.7 13403.1 17573.0 21963.1 2165.2 2238.0 2269.4 2326.0 2368.9 9423.2 9627.7 9942.9 10020.8 10076.2 1794.9 1865.3 1867.2 1870.7 1908.7 76362.0 78176.6 78643.2 78766.0 79981.0 10631.8 10822.6 10823.7 10872.2 11040.1 15043.7 15123.3 15137.7 15153.2 15157.7 7595.4 7607.8 7761.1 7827.0 7838.3 7234.5 7245.0 7262.3 7295.1 7447.3 4585.5 4592.7 4635.5 4637.7 4688.1 1676.5 1682.6 1696.0 1707.7 1725.2 1006.3 1017.2 1049.2 1056.5 1082.2 18178.9 18349.6 18612.2 19112.7 19283.1 970.8 980.9 1006.5 1030.4 1080.4 10129.5 10612.2 10626.8 10709.1 10731.0 483098.0 488221.0 488585.0 496106.0 497123.0 88925.0 89094.0 91613.0 91955.5 92207.5 1045.9 1047.1 1104.4 1120.3 1124.3 16252.7 16598.8 16706.4 16841.8 16983.6 35910.3 36111.0 36518.5 36768.8 37409.6 49539.8 52956.5 53532.7 53535.7 53967.7 7304.3 7639.4 7686.7 8247.5 8492.8 9173.8 11906.0 12299.7 12379.6 12649.6 10851.2 11186.8 11571.9 11732.5 11867.3 11387.6 11409.8 11411.8 11548.9 11553.2 11781.7 11878.4 11912.5 12107.8 12142.8 7777.1 7777.6 7852.5 7912.4 8108.9 11369.8 11814.3 11817.8 11838.1 11977.0 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#3] mootools.html Cycles:180 Average:5261.92 Median:5070.75 stddev:2862.63 (56.5%) stddev-sans-first:2855.34 08:26:42 INFO - PROCESS | 17015 | Values: 1322.4 1522.1 1545.0 1710.6 1796.9 6681.4 7628.5 7857.0 7865.3 7870.8 7374.6 7592.7 7616.0 7629.7 7640.4 1946.4 2191.4 2231.0 2256.7 2270.8 2255.5 2278.5 2280.8 2281.7 2282.1 2238.8 2280.2 2284.1 2286.5 2288.3 1974.3 2159.7 2231.1 2232.4 2233.6 2186.8 2217.8 2229.4 2229.9 2245.5 7760.0 7813.0 7817.9 7822.4 7826.5 4821.7 5019.4 5033.1 5042.6 5126.6 3269.4 3282.3 3335.4 3345.4 3360.8 1049.6 1067.6 1081.8 1082.4 1134.4 10701.9 10929.1 10931.0 10933.5 10960.6 4383.6 4424.7 4577.6 4629.9 4632.3 9372.7 9383.5 9386.9 9387.3 9388.8 4331.7 5064.3 5077.2 5081.0 5096.6 4454.0 4558.3 4564.1 4590.6 4613.9 3856.5 3931.4 3952.5 3977.7 4016.1 1265.0 1293.7 1298.8 1301.0 1302.9 950.3 971.3 977.3 978.5 980.8 5477.5 5532.8 5573.8 5625.1 5750.5 436.9 439.2 440.6 442.3 464.8 3863.5 3894.0 3912.8 3926.3 3963.1 9416.7 9680.3 9791.8 9870.5 9932.8 9651.0 9664.1 9882.8 9884.2 9895.4 7189.6 7245.4 7303.9 7345.6 7353.3 5250.0 5450.6 5497.0 5511.4 5554.5 8588.2 8658.3 8659.7 8809.8 8884.6 8574.1 8786.5 8927.2 9066.7 9071.4 6305.5 6522.9 6534.9 6844.4 6923.0 7352.0 7518.7 7549.2 7552.5 7567.5 6854.1 6981.7 6982.6 7074.8 7089.5 6717.1 6723.1 6724.5 6933.4 6934.1 6289.1 6335.6 6358.3 6368.2 6516.7 4762.7 4896.5 4902.8 4919.0 4978.5 4696.8 4734.0 4824.3 4886.2 5003.1 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#4] prototype.html Cycles:180 Average:4898.81 Median:5616.94 stddev:1445.65 (25.7%) stddev-sans-first:1408.21 08:26:42 INFO - PROCESS | 17015 | Values: 317.0 323.2 323.3 328.3 328.8 5609.0 5623.7 5648.4 5663.4 5669.7 5255.6 5320.4 5460.5 5529.0 5543.7 4287.6 4314.6 4319.6 4328.3 4328.8 4305.1 4307.8 4320.4 4326.2 4333.7 4075.9 4157.3 4261.6 4287.4 4322.1 4256.4 4260.0 4260.6 4286.2 4295.8 3761.5 3766.4 3782.8 3790.5 3797.1 5244.6 5362.1 5378.9 5392.6 5400.7 4937.6 4953.8 4954.9 4990.3 4994.1 5791.1 5825.4 5827.9 5833.3 5850.6 4060.2 4130.6 4132.9 4142.7 4157.2 6037.9 6060.8 6073.7 6074.5 6080.9 4248.0 4251.5 4259.3 4259.4 4260.1 4223.8 4343.3 4346.8 4357.3 4364.4 4901.3 4910.8 4934.6 4937.9 4957.3 5760.7 5879.8 5880.4 5904.5 5914.9 1400.5 1444.9 1456.2 1490.5 1497.4 1007.4 1013.9 1024.2 1025.2 1025.5 5618.4 5636.8 5640.7 5646.9 5647.9 5885.9 5945.3 5976.9 5988.3 5993.8 5411.0 5593.9 5608.1 5608.7 5615.5 3169.4 3171.5 3174.1 3196.1 3201.6 5972.9 6134.3 6136.6 6158.3 6161.0 5946.6 6012.3 6057.7 6087.1 6093.3 6023.5 6063.1 6080.3 6113.3 6119.7 5749.1 5909.4 5928.1 5950.7 5953.6 5776.9 5824.8 5845.3 5859.5 5868.5 5958.8 6114.4 6128.1 6142.7 6149.4 4246.8 4249.4 4265.4 4269.4 4270.7 5789.2 5951.3 5952.0 5958.7 5968.9 5741.9 5905.1 5906.1 5920.2 5931.4 5857.3 5912.6 5917.6 5918.9 5926.8 5637.7 5761.7 5770.3 5809.4 5822.3 5883.1 5929.5 5950.0 5950.2 5969.2 5717.3 5763.6 5813.3 5822.6 5827.9 08:26:42 INFO - PROCESS | 17015 | 08:26:42 INFO - PROCESS | 17015 | [#5] yui.html Cycles:180 Average:14312.28 Median:50846.37 stddev:17192.68 (33.8%) stddev-sans-first:17210.76 08:26:42 INFO - PROCESS | 17015 | Values: 754.5 757.2 784.7 814.6 885.6 12644.8 12949.2 13113.9 13133.7 13137.7 11941.0 13031.9 13057.8 13173.3 13225.4 812.2 817.4 822.0 823.6 824.4 811.7 812.0 812.4 817.1 820.5 845.5 846.7 846.8 847.0 847.9 835.9 837.7 844.2 844.4 846.2 615.6 622.8 622.9 622.9 623.0 11548.4 11631.4 11780.4 11811.1 11851.8 11948.7 12015.2 12016.6 12115.0 12143.2 10491.6 10492.7 10593.4 10718.4 10806.9 3691.9 3742.8 3754.9 3789.4 3790.7 54273.0 57050.7 57204.7 57217.1 57233.4 9066.8 9277.7 9379.9 9428.3 9595.0 18420.0 18677.3 18677.4 18678.6 18691.0 7766.6 7833.7 7967.4 8078.9 8113.3 4485.1 4546.8 4585.9 4595.7 4633.8 3068.1 3137.2 3166.8 3177.4 3183.9 598.0 599.6 604.1 605.7 606.6 637.0 650.0 682.8 708.9 722.8 9048.7 9147.7 9204.4 9211.6 9449.4 713.8 720.4 747.6 765.3 780.8 4054.8 4097.6 4108.7 4157.3 4167.7 64327.0 65037.7 65825.7 65829.7 65913.0 39629.8 51217.0 52541.7 54272.2 55968.0 50475.7 51523.5 51679.9 52181.7 52515.0 7962.5 8106.9 9522.6 9542.8 9823.1 29913.0 29990.3 30685.7 31197.2 31380.7 41747.0 42085.4 42413.2 44815.3 45005.8 11803.1 11891.9 11974.7 12104.1 12349.9 12891.4 13036.3 13211.7 13686.8 13736.7 11192.5 11295.2 11536.7 11554.9 11602.5 11897.7 11991.5 12040.7 12185.6 12467.3 11028.8 11083.0 11183.5 11271.5 12248.1 9563.0 9686.8 9826.8 9902.9 9920.3 9559.5 10247.6 10282.8 10475.4 10485.4 08:26:42 INFO - PROCESS | 17015 | -------- Summary: end -------- 08:26:42 INFO - PROCESS | 17015 | 08:26:43 INFO - TEST-INFO | 17015: exit 0 08:26:43 INFO - TEST-OK | dromaeo_css | took 1111821ms 08:26:43 INFO - TEST-START | kraken 08:26:43 INFO - operating with platform_type : linux_ 08:26:43 INFO - Initialising browser for kraken test... 08:26:43 INFO - TEST-INFO | started process 17193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yDzOI/profile http://localhost:57646/getInfo.html) 08:26:47 INFO - PROCESS | 17193 | __metrics Screen width/height:1600/1200 08:26:47 INFO - PROCESS | 17193 | colorDepth:24 08:26:47 INFO - PROCESS | 17193 | Browser inner width/height: 1024/697 08:26:47 INFO - PROCESS | 17193 | __metrics 08:26:48 ERROR - PROCESS | 17193 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:26:49 INFO - TEST-INFO | 17193: exit 0 08:26:49 INFO - Browser initialized. 08:26:49 INFO - Running cycle 1/1 for kraken test... 08:26:49 INFO - TEST-INFO | started process 17277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yDzOI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:01 INFO - PROCESS | 17277 | RSS: Main: 152694784 08:27:01 INFO - PROCESS | 17277 | 08:27:03 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57646/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:04 INFO - PROCESS | 17277 | RSS: Main: 208015360 08:27:04 INFO - PROCESS | 17277 | 08:27:07 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57646/tests/kraken/driver.html?testName=audio-dft) 08:27:07 INFO - PROCESS | 17277 | RSS: Main: 192950272 08:27:07 INFO - PROCESS | 17277 | 08:27:10 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57646/tests/kraken/driver.html?testName=audio-fft) 08:27:11 INFO - PROCESS | 17277 | RSS: Main: 263131136 08:27:11 INFO - PROCESS | 17277 | 08:27:13 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57646/tests/kraken/driver.html?testName=audio-oscillator) 08:27:13 INFO - PROCESS | 17277 | RSS: Main: 172011520 08:27:13 INFO - PROCESS | 17277 | 08:27:16 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:16 INFO - PROCESS | 17277 | RSS: Main: 175804416 08:27:16 INFO - PROCESS | 17277 | 08:27:19 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57646/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:20 INFO - PROCESS | 17277 | RSS: Main: 213180416 08:27:20 INFO - PROCESS | 17277 | 08:27:23 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57646/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:24 INFO - PROCESS | 17277 | RSS: Main: 213893120 08:27:24 INFO - PROCESS | 17277 | 08:27:26 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57646/tests/kraken/driver.html?testName=json-parse-financial) 08:27:27 INFO - PROCESS | 17277 | RSS: Main: 213524480 08:27:27 INFO - PROCESS | 17277 | 08:27:29 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:29 INFO - PROCESS | 17277 | RSS: Main: 199057408 08:27:29 INFO - PROCESS | 17277 | 08:27:31 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:32 INFO - PROCESS | 17277 | RSS: Main: 203194368 08:27:32 INFO - PROCESS | 17277 | 08:27:34 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:34 INFO - PROCESS | 17277 | RSS: Main: 217669632 08:27:34 INFO - PROCESS | 17277 | 08:27:37 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:37 INFO - PROCESS | 17277 | RSS: Main: 222011392 08:27:37 INFO - PROCESS | 17277 | 08:27:40 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:41 INFO - PROCESS | 17277 | RSS: Main: 219074560 08:27:41 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | Cycle 1(1): loaded http://localhost:57646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57646/tests/kraken/driver.html?testName=ai-astar) 08:27:43 INFO - PROCESS | 17277 | RSS: Main: 282005504 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | __start_tp_report 08:27:43 INFO - PROCESS | 17277 | _x_x_mozilla_page_load 08:27:43 INFO - PROCESS | 17277 | _x_x_mozilla_page_load_details 08:27:43 INFO - PROCESS | 17277 | |i|pagename|runs| 08:27:43 INFO - PROCESS | 17277 | |0;ai-astar;111;111;105;111;113;113;100;113;112;110 08:27:43 INFO - PROCESS | 17277 | |1;audio-beat-detection;156;136;160;193;125;155;153;128;182;135 08:27:43 INFO - PROCESS | 17277 | |2;audio-dft;161;161;161;161;159;161;162;162;162;164 08:27:43 INFO - PROCESS | 17277 | |3;audio-fft;74;74;103;111;74;76;72;120;102;76 08:27:43 INFO - PROCESS | 17277 | |4;audio-oscillator;94;92;154;93;93;93;146;94;92;144 08:27:43 INFO - PROCESS | 17277 | |5;imaging-gaussian-blur;116;116;117;117;118;117;117;117;117;117 08:27:43 INFO - PROCESS | 17277 | |6;imaging-darkroom;146;153;146;145;146;145;147;146;146;145 08:27:43 INFO - PROCESS | 17277 | |7;imaging-desaturate;95;95;96;95;96;95;94;95;95;95 08:27:43 INFO - PROCESS | 17277 | |8;json-parse-financial;54;58;56;56;56;56;56;70;57;53 08:27:43 INFO - PROCESS | 17277 | |9;json-stringify-tinderbox;63;62;62;63;62;66;62;63;63;68 08:27:43 INFO - PROCESS | 17277 | |10;stanford-crypto-aes;81;80;89;80;81;81;82;90;82;83 08:27:43 INFO - PROCESS | 17277 | |11;stanford-crypto-ccm;134;138;131;137;134;129;139;128;161;128 08:27:43 INFO - PROCESS | 17277 | |12;stanford-crypto-pbkdf2;168;165;165;166;166;168;172;176;173;171 08:27:43 INFO - PROCESS | 17277 | |13;stanford-crypto-sha256-iterative;70;68;69;67;68;67;67;69;66;68 08:27:43 INFO - PROCESS | 17277 | __end_tp_report 08:27:43 INFO - PROCESS | 17277 | __start_cc_report 08:27:43 INFO - PROCESS | 17277 | _x_x_mozilla_cycle_collect,1625 08:27:43 INFO - PROCESS | 17277 | __end_cc_report 08:27:43 INFO - PROCESS | 17277 | __startTimestamp1460647663339__endTimestamp 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | ------- Summary: start ------- 08:27:43 INFO - PROCESS | 17277 | Number of tests: 14 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.20 (3.8%) stddev-sans-first:4.44 08:27:43 INFO - PROCESS | 17277 | Values: 111.0 111.0 105.0 111.0 113.0 113.0 100.0 113.0 112.0 110.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:155.50 stddev:22.41 (14.4%) stddev-sans-first:23.73 08:27:43 INFO - PROCESS | 17277 | Values: 156.0 136.0 160.0 193.0 125.0 155.0 153.0 128.0 182.0 135.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.33 08:27:43 INFO - PROCESS | 17277 | Values: 161.0 161.0 161.0 161.0 159.0 161.0 162.0 162.0 162.0 164.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#3] audio-fft Cycles:10 Average:88.20 Median:74.00 stddev:18.58 (25.1%) stddev-sans-first:18.98 08:27:43 INFO - PROCESS | 17277 | Values: 74.0 74.0 103.0 111.0 74.0 76.0 72.0 120.0 102.0 76.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:26.69 (28.7%) stddev-sans-first:27.72 08:27:43 INFO - PROCESS | 17277 | Values: 94.0 92.0 154.0 93.0 93.0 93.0 146.0 94.0 92.0 144.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 08:27:43 INFO - PROCESS | 17277 | Values: 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:2.37 (1.6%) stddev-sans-first:2.51 08:27:43 INFO - PROCESS | 17277 | Values: 146.0 153.0 146.0 145.0 146.0 145.0 147.0 146.0 146.0 145.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:27:43 INFO - PROCESS | 17277 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:4.71 (8.4%) stddev-sans-first:4.85 08:27:43 INFO - PROCESS | 17277 | Values: 54.0 58.0 56.0 56.0 56.0 56.0 56.0 70.0 57.0 53.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:2.01 (3.2%) stddev-sans-first:2.13 08:27:43 INFO - PROCESS | 17277 | Values: 63.0 62.0 62.0 63.0 62.0 66.0 62.0 63.0 63.0 68.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:3.60 (4.4%) stddev-sans-first:3.76 08:27:43 INFO - PROCESS | 17277 | Values: 81.0 80.0 89.0 80.0 81.0 81.0 82.0 90.0 82.0 83.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:9.71 (7.2%) stddev-sans-first:10.28 08:27:43 INFO - PROCESS | 17277 | Values: 134.0 138.0 131.0 137.0 134.0 129.0 139.0 128.0 161.0 128.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.50 stddev:3.80 (2.2%) stddev-sans-first:4.01 08:27:43 INFO - PROCESS | 17277 | Values: 168.0 165.0 165.0 166.0 166.0 168.0 172.0 176.0 173.0 171.0 08:27:43 INFO - PROCESS | 17277 | 08:27:43 INFO - PROCESS | 17277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 08:27:43 INFO - PROCESS | 17277 | Values: 70.0 68.0 69.0 67.0 68.0 67.0 67.0 69.0 66.0 68.0 08:27:43 INFO - PROCESS | 17277 | -------- Summary: end -------- 08:27:43 INFO - PROCESS | 17277 | 08:27:44 INFO - TEST-INFO | 17277: exit 0 08:27:44 INFO - TEST-OK | kraken | took 60882ms 08:27:44 INFO - SUITE-END | took 1172s 08:27:44 INFO - Completed test suite (00:19:32) 08:27:44 INFO - javascript benchmark 08:27:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.968810311897, 3179.6661350558206, 3216.935661286774, 3217.6138863336387, 3252.3495300939803, 5141.074606570815, 5178.4562620924735, 5367.46325367463, 5382.327209098858, 5502.6148169628095, 5287.4976877196705, 5306.655067420625, 5332.440093790155, 5440.455954404558, 5465.699386533739, 4783.210770222909, 4841.975790121044, 4880.682755620891, 4894.094592500399, 5028.974855125719, 4951.826686065989, 4987.850364489053, 5003.499650034985, 5017.322661440695, 5018.924716129261, 4758.072175925696, 4859.441164266119, 4952.975235123838, 4965.503449655042, 4970.155073637472, 4891.4863939286215, 4909.68087074339, 4925.556699897026, 4925.950740492585, 4933.333999910002, 4796.304535842283, 4826.420829500447, 4836.637252206098, 4853.660243782937, 4876.146674332013, 5069.771860266297, 5245.947540524584, 5256.684598924076, 5358.115910874701, 5373.194020896858, 5738.856528586777, 5771.740271687784, 5790.7394167262155, 5794.420557944214, 5811.0, 5788.160716696098, 5838.2702162229725, 5848.356680765112, 5849.415058494159, 5853.619514731528, 5240.135377662681, 5278.9208161877605, 5327.733613319358, 5328.120860058086, 5330.893382132335, 5750.3099628044065, 5752.223449834219, 5766.04860198071, 5796.188533605298, 5798.072308430631, 5510.8071217507195, 5516.9448305517235, 5522.779088836482, 5523.751431185607, 5554.666719996813, 5562.110062390079, 5594.440555944454, 5600.52395546375, 5600.775968961196, 5630.577706671934, 5502.202180683858, 5506.03644362235, 5506.256655351556, 5509.779608815603, 5511.641743286754, 5480.7533660985355, 5520.834374968757, 5523.6685798852195, 5523.7238138093735, 5531.585131115183, 4261.31818908973, 4261.701680882308, 4292.441982542249, 4417.580329868657, 4419.204543182258, 3900.9804950975063, 3909.1204478992, 3922.7057970652313, 3943.92112157761, 3952.7628342299554, 5441.075017247077, 5456.61803673747, 5464.535514481234, 5466.5900057495055, 5506.201600767866, 5592.105263157875, 5681.34664513578, 5741.913871291934, 5760.942390576124, 5764.625299355528, 5478.534324582375, 5501.449855014466, 5513.035218836688, 5513.61404701675, 5514.944850551524, 4973.875653108701, 4988.6757360771435, 5007.399112106497, 5012.373453318335, 5059.266406371055, 5699.886002279931, 5966.105084237312, 6023.1266466363, 6024.518038556905, 6057.121717350959, 5764.711764411846, 5772.884542309214, 5773.278340207474, 5796.652200867961, 5801.970990145022, 5704.372519022987, 5970.671613061149, 5978.521718262616, 5979.043353063489, 5983.282006159288, 5517.503424691637, 5553.222548843246, 5591.440855914376, 5599.384067752462, 5606.579506536945, 5682.886342273214, 5684.346300175367, 5693.373728889736, 5696.572757043155, 5699.943000570107, 5446.455354464521, 5530.474604912527, 5540.86147846291, 5542.556595472433, 5559.388467268678, 5486.039943010037, 5520.309961254843, 5525.972370138124, 5537.1140617501005, 5572.60991730575, 5418.295621569171, 5543.944560554342, 5558.694271815089, 5560.694161821139, 5564.443555644403, 5340.279062326692, 5572.164175373727, 5631.267935168566, 5656.547476201812, 5689.203511508475, 5525.475079867406, 5538.47384498472, 5540.168974653673, 5541.445855414427, 5598.356189038313], "value": 5268.663306631108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.739961816419, 637.4517914593449, 639.4309064932211, 640.823773462298, 659.2023651381828, 30071.398572028575, 36848.81575592122, 37712.43431348532, 37789.0, 37830.0, 40555.797221013854, 41133.0, 41228.38157427641, 41324.380134297935, 41341.79329103358, 8475.491470511774, 8763.211310982011, 8768.167024132728, 8769.079246679103, 8769.386142969995, 8642.827143457127, 8740.475571465733, 8752.081031491698, 8770.122987701243, 8772.298216142693, 8802.735917922473, 8856.73429797104, 8867.512286824222, 8876.289896808272, 8877.334199934998, 8685.218330350268, 8730.912690873138, 8795.120487951217, 8805.42764720291, 8814.206721395074, 8535.786605334853, 8713.085126061798, 8719.869201961976, 8725.258353039999, 8729.214370706666, 39300.0, 39827.601723982676, 39848.40227396591, 39871.8006409969, 39918.0, 3344.2141096842224, 3498.702610278129, 3511.5961664408665, 3511.877084302037, 4402.845900393503, 30004.69995300041, 30595.38809223803, 30941.0, 30962.380752384826, 31212.8439357804, 3677.3013127505956, 3736.308782875177, 3784.6972242220554, 3820.369639009588, 3826.445165450994, 290689.0, 291600.9999999979, 292356.0732945038, 292789.0, 293006.0, 51606.74196628993, 52828.0, 53173.734131329096, 53259.20111198335, 53303.20045199325, 54976.0, 56710.7164464175, 63913.680431597546, 65852.670736646, 66244.6687766558, 13837.515686950908, 14017.649558761113, 14062.43750249999, 14063.0, 14066.085704429179, 9952.203823694088, 10618.0, 10673.83989240162, 10678.0, 10679.252452328417, 15880.52358429226, 16345.34618615266, 16370.83629163717, 16413.83586164147, 16535.586610334598, 6446.806595802133, 6490.935090649033, 6491.67541622917, 6507.8698426031215, 6655.434288085567, 969.9612015519441, 1013.7212266626736, 1068.455087905174, 1072.1690689715376, 1183.928964262147, 32467.51298730521, 32672.67327326744, 32683.0, 32803.1799205017, 32971.50542741861, 1124.5670416889557, 1140.7319279969201, 1174.9647510574696, 1208.7642909632536, 1297.0855546839455, 16864.915675421544, 17316.393926212775, 17349.392771252944, 17534.561635959202, 17547.21037553313, 406291.0, 411039.0, 411387.0, 411717.0, 412908.0, 57346.0, 58001.12998305029, 58155.127673084935, 58325.0, 58647.4135258642, 1344.8117263583106, 1381.0677792490028, 1394.9302534873216, 1398.8741013308647, 1408.2114016150783, 30519.694803052575, 31613.683863161074, 31759.84120079385, 32058.038258852273, 32444.675553244164, 49896.0, 50409.0, 50495.49504504908, 50525.0, 50552.0, 356186.0, 364786.0, 370520.0, 370582.0, 371124.0, 33615.495767563014, 39458.80270598629, 40413.79793101016, 40722.0, 41205.55780547787, 41565.79217103895, 42249.577504224566, 42535.0, 42639.0, 43250.13499729925, 35189.29621407506, 35381.82309088438, 35617.46573801447, 35875.641243588274, 35934.460983085795, 36058.27883442369, 38802.80598596989, 39013.0, 39118.0, 39388.212235755695, 39204.0, 39762.60237397589, 39801.0, 40017.79991100026, 40057.19599627998, 33999.98000060002, 34313.313733725685, 35142.472862906565, 35165.82417087898, 35323.82085612307, 27427.862860685567, 27489.587656185573, 27692.861535693, 27715.44569108647, 27779.44441111126], "value": 19158.5684354427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3653345047573, 391.35621901971257, 394.8973266950592, 399.59241573594915, 405.4384677222047, 17474.82525174748, 17844.732329015074, 18135.546611334725, 18174.182161802717, 18232.908835455837, 16690.58273543162, 17225.655486890253, 17291.913540432313, 17568.912155439204, 17829.286828526845, 5164.2253661950635, 5660.150977353389, 5789.9710501447435, 5811.099279611646, 5836.766529338843, 5585.776568937237, 5590.580706447033, 5608.4391560844, 5617.859553511174, 5624.100143976964, 5570.303712035996, 5575.2473416088915, 5589.74846131923, 5610.859728506779, 6308.337624549425, 6225.252969643627, 6227.190465239535, 6241.968790156043, 6270.247570291572, 6276.3409841966395, 5354.196870469422, 5443.237946687467, 5645.23789288449, 5646.661200327952, 5648.0, 13341.266230357327, 13393.732125357536, 13403.061785675007, 17573.0, 21963.121475140975, 2165.2096984600666, 2238.0264584905453, 2269.375921621551, 2325.9534809303887, 2368.857868527894, 9423.246140308758, 9627.711168664951, 9942.850857237147, 10020.849687254697, 10076.244281678903, 1794.8923064616033, 1865.3191585071352, 1867.1597780998604, 1870.710039943811, 1908.7041508566194, 76362.0, 78176.60911695405, 78643.21356786473, 78766.0, 79980.99999999942, 10631.84052239217, 10822.621208257673, 10823.67528974132, 10872.238943273895, 11040.116790656728, 15043.699126017418, 15123.31945062475, 15137.697246055017, 15153.242337883063, 15157.696846063018, 7595.430342724208, 7607.782754759212, 7761.107472640719, 7826.960865195638, 7838.294553490213, 7234.529755565872, 7244.963775181091, 7262.346388824925, 7295.124585049828, 7447.329740323397, 4585.541445855454, 4592.6555508337005, 4635.490096089427, 4637.675362724577, 4688.062387522509, 1676.5138109948223, 1682.587765997314, 1695.981781679797, 1707.6840784454917, 1725.1546742096534, 1006.2568535122165, 1017.2269075502671, 1049.1554298789395, 1056.4879449477728, 1082.2099867096906, 18178.90910545439, 18349.633007339777, 18612.162452689663, 19112.713309300372, 19283.132259048096, 970.825251454745, 980.926430517714, 1006.5470538257813, 1030.3766221436074, 1080.3517889266377, 10129.544170512345, 10612.151027917747, 10626.840597391045, 10709.143268538654, 10731.0, 483098.0, 488221.0, 488585.0, 496106.0, 497123.0, 88925.0, 89094.0, 91613.0, 91955.5402222998, 92207.5389623061, 1045.858809060767, 1047.1256500821898, 1104.4256986367045, 1120.3166068698088, 1124.3254047571554, 16252.66820301859, 16598.75101873449, 16706.4152754653, 16841.831581684026, 16983.575410614834, 35910.28179436449, 36111.0, 36518.45222321614, 36768.81615591905, 37409.625903741704, 49539.752301238266, 52956.47043529515, 53532.73233633807, 53535.732321338146, 53967.73016134894, 7304.306090921354, 7639.427042971688, 7686.654100565376, 8247.463914845515, 8492.830143397221, 9173.816523669622, 11906.0, 12299.69250768738, 12379.62861114168, 12649.557265496032, 10851.186161037796, 11186.8106674905, 11571.942140289244, 11732.530698771954, 11867.287962722265, 11387.601433949772, 11409.828852567383, 11411.828822567833, 11548.884511155116, 11553.24903881245, 11781.705457363634, 11878.406079695807, 11912.52349905994, 12107.757844842878, 12142.75714485723, 7777.066751989797, 7777.57223352721, 7852.528848269122, 7912.446128770931, 8108.878366824621, 11369.829452558053, 11814.291142531476, 11817.763644726885, 11838.052955763345, 11977.023791074374], "value": 8859.69117110314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.3718733601534, 1522.0943538594536, 1545.042073914173, 1710.5980094677748, 1796.8652351073672, 6681.432078273347, 7628.504147230433, 7856.9607151964165, 7865.331446827012, 7870.763877083682, 7374.594397308146, 7592.658330375132, 7616.04799400075, 7629.656665450054, 7640.426967977396, 1946.3966170487195, 2191.375457994472, 2230.966535501969, 2256.6727824465443, 2270.8069814065825, 2255.4812393149587, 2278.51012032413, 2280.8061314788265, 2281.7376001759762, 2282.1327895399727, 2238.787315205053, 2280.1677387753434, 2284.0635339510804, 2286.4855407533255, 2288.2906299047268, 1974.3484650065443, 2159.676048592708, 2231.0852550454238, 2232.363776323756, 2233.553289342138, 2186.7922547357975, 2217.8225741940605, 2229.4314949687728, 2229.8662080275235, 2245.517213799041, 7759.9612001940195, 7813.0, 7817.921820781777, 7822.374210063182, 7826.530408175528, 4821.662483626147, 5019.42276638184, 5033.144365457881, 5042.571381432583, 5126.61550383719, 3269.362474317509, 3282.2614911644687, 3335.399628066947, 3345.3978283908887, 3360.83195840207, 1049.5539395756773, 1067.6370034188412, 1081.783643271341, 1082.4046774274198, 1134.3704244144496, 10701.892981070168, 10929.125669946465, 10931.0, 10933.453327333602, 10960.616378426797, 4383.649308055348, 4424.668149888771, 4577.5880170784785, 4629.8842528936375, 4632.328312394684, 9372.718818435458, 9383.5308234588, 9386.85919711205, 9387.34288599805, 9388.765280868032, 4331.696781225284, 5064.290999260106, 5077.213031980049, 5080.974595127074, 5096.566791822663, 4453.955460445354, 4558.316252562142, 4564.109998550251, 4590.609798167126, 4613.907721845544, 3856.4986551748093, 3931.368482079905, 3952.545457272393, 3977.7414468059483, 4016.116454380032, 1264.974700506003, 1293.6765808547864, 1298.7792075347213, 1300.9609711708663, 1302.908796384244, 950.2825366848124, 971.3006635222629, 977.2621670638764, 978.515634760798, 980.8479685648736, 5477.452254774491, 5532.7786888524815, 5573.804916827891, 5625.071863142617, 5750.482456578928, 436.8754904852165, 439.2291528367694, 440.55063834888875, 442.34091204106295, 464.7745843266013, 3863.478430411915, 3893.980530097331, 3912.784796836201, 3926.293267211929, 3963.147923196527, 9416.717498475056, 9680.27397945157, 9791.804163916824, 9870.506474676238, 9932.801343973224, 9651.0, 9664.081912218327, 9882.752931176778, 9884.209263258923, 9895.406275623342, 7189.5686258824635, 7245.384142347854, 7303.926960730431, 7345.559266444137, 7353.301436363537, 5250.0, 5450.591205659671, 5497.038018346693, 5511.448855114457, 5554.50009499147, 8588.153546987427, 8658.264047556027, 8659.653613855628, 8809.779755506164, 8884.600192991202, 8574.142585741376, 8786.516741579275, 8927.151920567536, 9066.682666106655, 9071.365004449624, 6305.464035557029, 6522.869542609216, 6534.901976470262, 6844.384005439534, 6923.0, 7352.044234249727, 7518.661660225193, 7549.207333230152, 7552.546847189186, 7567.545947243183, 6854.143232095988, 6981.685824137824, 6982.615956122462, 7074.823129421806, 7089.468289878383, 6717.093192418961, 6723.125993620798, 6724.49566282521, 6933.37599616037, 6934.098567186234, 6289.119523266838, 6335.556511044367, 6358.332375100548, 6368.172137622079, 6516.706748196438, 4762.738049407316, 4896.534829191221, 4902.803887844446, 4918.950810491992, 4978.502149784992, 4696.812127514998, 4734.0, 4824.300476430828, 4886.242632391985, 5003.124453220599], "value": 4233.753910649344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.96988786065316, 323.2162007132703, 323.2581226086131, 328.2859779978549, 328.77807479951025, 5608.971955140229, 5623.662580245188, 5648.350439699436, 5663.377028526864, 5669.659820410773, 5255.632105752599, 5320.414754377025, 5460.453954604547, 5529.0, 5543.695096769686, 4287.592678695534, 4314.590113939171, 4319.632831209351, 4328.3074708046715, 4328.783560821962, 4305.137083839243, 4307.784610769465, 4320.416743739602, 4326.156399502099, 4333.718308309965, 4075.857344992926, 4157.272477316473, 4261.595148460907, 4287.378330142127, 4322.135572885435, 4256.382824490432, 4260.0, 4260.573942605745, 4286.185624731306, 4295.8330419493195, 3761.4733937248534, 3766.4162054881535, 3782.7541209821275, 3790.4503846942316, 3797.1456422305037, 5244.632875698702, 5362.0616392131615, 5378.865528361783, 5392.649477783932, 5400.729963501848, 4937.5556199942175, 4953.777080031407, 4954.925676114825, 4990.251462280687, 4994.101061808873, 5791.102379131242, 5825.359210486843, 5827.941720582782, 5833.32916714579, 5850.619709718854, 4060.167665628539, 4130.586941305875, 4132.896677583054, 4142.668586513072, 4157.210130075276, 6037.939620603782, 6060.757569697207, 6073.665948372838, 6074.453299203049, 6080.8750381179625, 4247.957520424818, 4251.532331443539, 4259.254630439661, 4259.42497762798, 4260.062786187033, 4223.788810559521, 4343.326784348431, 4346.782660866944, 4357.346398040256, 4364.388985542027, 4901.260052681247, 4910.754462276872, 4934.555889969848, 4937.901241975141, 4957.256411538298, 5760.654360738369, 5879.823605291848, 5880.411958804171, 5904.468597826216, 5914.852128696731, 1400.4958215042577, 1444.949426770058, 1456.2354763749117, 1490.5155824357128, 1497.445945000357, 1007.4056306779036, 1013.8735347137228, 1024.1601886453036, 1025.2464438637596, 1025.47700672656, 5618.410066942912, 5636.774529018875, 5640.746166422521, 5646.88241909284, 5647.887042259214, 5885.852853678693, 5945.256842894638, 5976.880462390728, 5988.341282458926, 5993.790217342372, 5411.0, 5593.888122237532, 5608.1027035674915, 5608.69152196625, 5615.466530679579, 3169.3819705157734, 3171.5401266816184, 3174.1429813950103, 3196.1210667066744, 3201.6318123416104, 5972.940270597325, 6134.263888333339, 6136.570440069241, 6158.291796443376, 6161.045038019114, 5946.554008449383, 6012.30858451275, 6057.666828324396, 6087.1173679816175, 6093.299270583851, 6023.488003519662, 6063.120847477091, 6080.270367555921, 6113.296970848321, 6119.724612392453, 5749.115959351495, 5909.438603332676, 5928.110783382354, 5950.732217050157, 5953.642781433128, 5776.913346299725, 5824.805914787374, 5845.269341332333, 5859.472647461749, 5868.530517558671, 5958.76164953397, 6114.357992410733, 6128.142060111499, 6142.692865356625, 6149.385061493815, 4246.810892949979, 4249.36259561056, 4265.445492086009, 4269.4449721536, 4270.743755374688, 5789.1605717171615, 5951.345352011362, 5952.0, 5958.672273025025, 5968.8806223876145, 5741.885162296814, 5905.143754155709, 5906.1140828874295, 5920.230370051866, 5931.4114960448305, 5857.297124345106, 5912.586118971631, 5917.5857689961285, 5918.881622367615, 5926.822195334147, 5637.718114094361, 5761.711914404347, 5770.307563092456, 5809.390014048464, 5822.254862287223, 5883.058710606282, 5929.495992840484, 5949.970250148722, 5950.166976623363, 5969.164316995711, 5717.338766053508, 5763.5965482417505, 5813.302403711582, 5822.563307752021, 5827.854303642443], "value": 4431.421714984107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5057987018502, 757.1784613694145, 784.6508303804806, 814.6049166154411, 885.6103314541599, 12644.810327845078, 12949.22304661721, 13113.868861311385, 13133.737325253489, 13137.73724525509, 11941.0, 13031.869681303184, 13057.804132938014, 13173.34133293334, 13225.404856781444, 812.1999830167296, 817.3502065857627, 821.9630116644736, 823.6170180865896, 824.381713714714, 811.7280710961805, 812.0255693168192, 812.3866480806983, 817.1175130858688, 820.5281962871343, 845.5222799118509, 846.6613354658156, 846.7967687754925, 847.0132295875297, 847.8812966184739, 835.9122292159296, 837.7277384849917, 844.1727107434748, 844.3835999720177, 846.2130218896424, 615.575253075381, 622.8069298517474, 622.8878801815671, 622.9345918678564, 623.0498489803041, 11548.364839933884, 11631.360275184861, 11780.410979450993, 11811.055115590732, 11851.822222666668, 11948.70128246792, 12015.219010764273, 12016.639500814903, 12115.0, 12143.210691305037, 10491.58033678652, 10492.685219443429, 10593.364398136137, 10718.356898586031, 10806.891931080667, 3691.9261614767825, 3742.7754334740002, 3754.8685795997008, 3789.4315852622053, 3790.65884070435, 54273.0, 57050.714746426005, 57204.71397643027, 57217.14174287389, 57233.427665723226, 9066.773330666787, 9277.67528136512, 9379.90620093804, 9428.292878034175, 9595.0, 18420.0, 18677.252909883453, 18677.439676809718, 18678.626427471645, 18691.0, 7766.611669416619, 7833.686652533835, 7967.402444816662, 8078.919210807934, 8113.269805717396, 4485.102979404132, 4546.795394207269, 4585.931211031837, 4595.655325850507, 4633.7683115844075, 3068.094912000965, 3137.1843320736316, 3166.8099914005234, 3177.3645270945904, 3183.8567264473154, 597.9790707325222, 599.5623195067625, 604.0576700347472, 605.6971514242879, 606.5541826757329, 636.9867756006403, 649.9512536559777, 682.8258794007596, 708.9007538944552, 722.7553934010157, 9048.728538143867, 9147.664773909677, 9204.447733136034, 9211.585478653476, 9449.38578992377, 713.7957430732987, 720.3664085930124, 747.5701471653712, 765.2768134113321, 780.7852840468803, 4054.779272922418, 4097.610726980932, 4108.650764685035, 4157.272477316457, 4167.708260421741, 64327.0, 65037.67481162564, 65825.67087164533, 65829.6708516464, 65913.0, 39629.80185099056, 51217.0, 52541.7372913133, 54272.185917211275, 55968.0, 50475.74762126166, 51523.48476515187, 51679.93280268822, 52181.7390913043, 52515.0, 7962.482438641469, 8106.918930810616, 9522.61909523639, 9542.810800591287, 9823.115919567274, 29913.0, 29990.25024374408, 30685.69857260759, 31197.220069497536, 31380.686193137775, 41747.0, 42085.36871946984, 42413.15173696571, 44815.327770082826, 45005.774971124934, 11803.114766392726, 11891.924155906156, 11974.700632484257, 12104.09219308573, 12349.876501234872, 12891.355432228163, 13036.283004434847, 13211.66970825737, 13686.794698079337, 13736.725265494435, 11192.496337664661, 11295.209335346446, 11536.712037069396, 11554.94222528882, 11602.535898563963, 11897.702557436134, 11991.520339186334, 12040.698982525508, 12185.634430967086, 12467.314297713712, 11028.779424411627, 11083.0, 11183.496742646763, 11271.492782824957, 12248.14263001617, 9562.952185239308, 9686.814641627814, 9826.754331141492, 9902.900970990486, 9920.305578609428, 9559.486645855122, 10247.600403511537, 10282.794344113225, 10475.423851687925, 10485.423301718478], "value": 6464.4678586427135, "unit": "score"}], "name": "dromaeo_css", "value": 6905.916936669076, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 111.0, 113.0, 113.0, 100.0, 113.0, 112.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 136.0, 160.0, 193.0, 125.0, 155.0, 153.0, 128.0, 182.0, 135.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 162.0, 162.0, 164.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 103.0, 111.0, 74.0, 76.0, 72.0, 120.0, 102.0, 76.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 154.0, 93.0, 93.0, 93.0, 146.0, 94.0, 92.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 153.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 70.0, 57.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 62.0, 66.0, 62.0, 63.0, 63.0, 68.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 89.0, 80.0, 81.0, 81.0, 82.0, 90.0, 82.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 131.0, 137.0, 134.0, 129.0, 139.0, 128.0, 161.0, 128.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 166.0, 166.0, 168.0, 172.0, 176.0, 173.0, 171.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 67.0, 68.0, 67.0, 67.0, 69.0, 66.0, 68.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1556.1000000000004, "alertThreshold": 2.0}]} 08:27:44 INFO - Return code: 0 08:27:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:27:44 ERROR - # TBPL SUCCESS # 08:27:44 INFO - Running post-action listener: _resource_record_post_action 08:27:44 INFO - Running post-run listener: _resource_record_post_run 08:27:45 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545931264; Read time: 16; Write time: 411272 08:27:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 181477376; Read time: 0; Write time: 171024 08:27:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289935360; Read time: 16; Write time: 174508 08:27:45 INFO - Running post-run listener: _upload_blobber_files 08:27:45 INFO - Blob upload gear active. 08:27:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:45 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 08:27:45 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:27:45 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:27:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:27:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:47 INFO - (blobuploader) - INFO - Done attempting. 08:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:27:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:47 INFO - (blobuploader) - INFO - Done attempting. 08:27:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:47 INFO - Return code: 0 08:27:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db3059622026b2d7603976e3ef2a826515817d8961bb771d416d936e6917a2fb266ab76dc9a296565d84a4b964090ff27ca1923a23036d126ee4de688c438ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8bac3fd9ac8954c27bbb44a7ce0baf68716a73903a2deb1794f3dfd0315b5d884302e0825d7da699221e16c161a455347f4cd8470f263d674adb0554c6c50a"} 08:27:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:47 INFO - Contents: 08:27:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db3059622026b2d7603976e3ef2a826515817d8961bb771d416d936e6917a2fb266ab76dc9a296565d84a4b964090ff27ca1923a23036d126ee4de688c438ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8bac3fd9ac8954c27bbb44a7ce0baf68716a73903a2deb1794f3dfd0315b5d884302e0825d7da699221e16c161a455347f4cd8470f263d674adb0554c6c50a"} 08:27:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:47 INFO - Copying logs to upload dir... 08:27:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.029573 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-14 08:27:47.648792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:27:47.652734) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db3059622026b2d7603976e3ef2a826515817d8961bb771d416d936e6917a2fb266ab76dc9a296565d84a4b964090ff27ca1923a23036d126ee4de688c438ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8bac3fd9ac8954c27bbb44a7ce0baf68716a73903a2deb1794f3dfd0315b5d884302e0825d7da699221e16c161a455347f4cd8470f263d674adb0554c6c50a"} build_url:https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/MXEGvURcRS2CewFG3-xAEA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3db3059622026b2d7603976e3ef2a826515817d8961bb771d416d936e6917a2fb266ab76dc9a296565d84a4b964090ff27ca1923a23036d126ee4de688c438ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3f8bac3fd9ac8954c27bbb44a7ce0baf68716a73903a2deb1794f3dfd0315b5d884302e0825d7da699221e16c161a455347f4cd8470f263d674adb0554c6c50a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 08:27:47.677931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:27:47.678285) ========= 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=8887e36bb8e381bfd44124ac000001a8-1460646416.606376-960941835 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 08:27:47.761110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:27:47.761434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 08:27:47.761744) ========= ========= Total master_lag: 0.27 =========