builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1461243499.24 results: success (0) buildid: 20160421052914 builduid: d83d6f202070484f8bbc1da66725bbc1 revision: f789cf6c7a5564260a6427492999dbf8bc93e065 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.239754) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.240317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.240609) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.331161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.331606) ========= 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=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 05:58:19-- 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% 89.1M=0s 2016-04-21 05:58:19 (89.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.471789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.472193) ========= 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=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019338 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.522464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:19.522845) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f789cf6c7a5564260a6427492999dbf8bc93e065 --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 f789cf6c7a5564260a6427492999dbf8bc93e065 --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=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 05:58:20,038 truncating revision to first 12 chars 2016-04-21 05:58:20,038 Setting DEBUG logging. 2016-04-21 05:58:20,038 attempt 1/10 2016-04-21 05:58:20,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f789cf6c7a55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 05:58:20,294 unpacking tar archive at: fx-team-f789cf6c7a55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:20.062136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:20.062823) ========= script_repo_revision: f789cf6c7a5564260a6427492999dbf8bc93e065 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:20.063627) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:20.064139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 05:58:20.076485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 15 secs) (at 2016-04-21 05:58:20.077226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:20 INFO - MultiFileLogger online at 20160421 05:58:20 in /builds/slave/test 05:58:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:58:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:20 INFO - {'append_to_log': False, 05:58:20 INFO - 'base_work_dir': '/builds/slave/test', 05:58:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:58:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:20 INFO - 'branch': 'Fx-Team-Non-PGO', 05:58:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:20 INFO - 'config_files': ('talos/linux_config.py',), 05:58:20 INFO - 'default_actions': ('clobber', 05:58:20 INFO - 'read-buildbot-config', 05:58:20 INFO - 'download-and-extract', 05:58:20 INFO - 'populate-webroot', 05:58:20 INFO - 'create-virtualenv', 05:58:20 INFO - 'install', 05:58:20 INFO - 'run-tests'), 05:58:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:20 INFO - 'download_minidump_stackwalk': True, 05:58:20 INFO - 'download_symbols': 'ondemand', 05:58:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:20 INFO - 'installer_path': 'installer.exe', 05:58:20 INFO - 'log_level': 'info', 05:58:20 INFO - 'log_name': 'talos', 05:58:20 INFO - 'log_to_console': True, 05:58:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:20 INFO - 'opt_config_files': (), 05:58:20 INFO - 'pip_index': False, 05:58:20 INFO - 'sps_profile': False, 05:58:20 INFO - 'sps_profile_interval': 0, 05:58:20 INFO - 'suite': 'dromaeojs-e10s', 05:58:20 INFO - 'system_bits': '32', 05:58:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:20 INFO - 'title': 'talos-linux64-ix-009', 05:58:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:20 INFO - 'use_talos_json': True, 05:58:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:20 INFO - 'work_dir': 'build'} 05:58:20 INFO - ##### 05:58:20 INFO - ##### Running clobber step. 05:58:20 INFO - ##### 05:58:20 INFO - Running pre-action listener: _resource_record_pre_action 05:58:20 INFO - Running main action method: clobber 05:58:20 INFO - rmtree: /builds/slave/test/build 05:58:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:21 INFO - Running post-action listener: _resource_record_post_action 05:58:21 INFO - ##### 05:58:21 INFO - ##### Running read-buildbot-config step. 05:58:21 INFO - ##### 05:58:21 INFO - Running pre-action listener: _resource_record_pre_action 05:58:21 INFO - Running main action method: read_buildbot_config 05:58:21 INFO - Using buildbot properties: 05:58:21 INFO - { 05:58:21 INFO - "project": "", 05:58:21 INFO - "product": "firefox", 05:58:21 INFO - "script_repo_revision": "production", 05:58:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:58:21 INFO - "repository": "", 05:58:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:58:21 INFO - "buildid": "20160421052914", 05:58:21 INFO - "pgo_build": "False", 05:58:21 INFO - "basedir": "/builds/slave/test", 05:58:21 INFO - "buildnumber": 1424, 05:58:21 INFO - "slavename": "talos-linux64-ix-009", 05:58:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:58:21 INFO - "platform": "ubuntu64_hw", 05:58:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:58:21 INFO - "branch": "fx-team", 05:58:21 INFO - "repo_path": "integration/fx-team", 05:58:21 INFO - "revision": "f789cf6c7a5564260a6427492999dbf8bc93e065", 05:58:21 INFO - "stage_platform": "linux64", 05:58:21 INFO - "builduid": "d83d6f202070484f8bbc1da66725bbc1", 05:58:21 INFO - "slavebuilddir": "test" 05:58:21 INFO - } 05:58:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:58:21 INFO - Running post-action listener: _resource_record_post_action 05:58:21 INFO - ##### 05:58:21 INFO - ##### Running download-and-extract step. 05:58:21 INFO - ##### 05:58:21 INFO - Running pre-action listener: _resource_record_pre_action 05:58:21 INFO - Running main action method: download_and_extract 05:58:21 INFO - mkdir: /builds/slave/test/build/tests 05:58:21 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')]} 05:58:21 INFO - https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:23 INFO - Downloaded 1361 bytes. 05:58:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:58:23 INFO - Using the following test package requirements: 05:58:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'jsshell-linux-x86_64.zip'], 05:58:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:23 INFO - https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:29 INFO - Downloaded 22275480 bytes. 05:58:29 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'] 05:58:29 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 05:58:31 INFO - Return code: 0 05:58:31 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 05:58: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')]} 05:58:31 INFO - https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:58:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:58:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:58:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:35 INFO - Downloaded 22275480 bytes. 05:58:35 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'] 05:58:35 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 05:58:36 INFO - Return code: 0 05:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:36 INFO - https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:37 INFO - Downloaded 10845952 bytes. 05:58:37 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'] 05:58:37 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 05:58:37 INFO - Return code: 0 05:58: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')]} 05:58:37 INFO - https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NC8Ae84DRuSphwVKDaw5dg/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 05:58:39 INFO - Downloaded 54622995 bytes. 05:58:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:58:39 INFO - mkdir: /builds/slave/test/properties 05:58:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:39 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:39 INFO - Contents: 05:58:39 INFO - build_url:https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:58:41 INFO - Running post-action listener: _resource_record_post_action 05:58:41 INFO - Running post-action listener: set_extra_try_arguments 05:58:41 INFO - ##### 05:58:41 INFO - ##### Running populate-webroot step. 05:58:41 INFO - ##### 05:58:41 INFO - Running pre-action listener: _resource_record_pre_action 05:58:41 INFO - Running main action method: populate_webroot 05:58:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:41 INFO - '--tppagecycles', 05:58:41 INFO - '7'], 05:58:41 INFO - 'tests': ['tsvgm']}}, 05:58:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['damp', 'tps']}, 05:58:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'tests': ['damp', 'tps']}, 05:58:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['dromaeo_dom']}, 05:58:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['a11yr', 05:58:41 INFO - 'ts_paint', 05:58:41 INFO - 'tpaint', 05:58:41 INFO - 'sessionrestore', 05:58:41 INFO - 'sessionrestore_no_auto_restore', 05:58:41 INFO - 'tabpaint']}, 05:58:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['tsvgx', 05:58:41 INFO - 'tsvgr_opacity', 05:58:41 INFO - 'tart', 05:58:41 INFO - 'tscrollx', 05:58:41 INFO - 'cart']}, 05:58:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:41 INFO - 'tsvgr_opacity', 05:58:41 INFO - 'tart', 05:58:41 INFO - 'tscrollx', 05:58:41 INFO - 'cart']}, 05:58:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'talos_options': ['--disable-e10s'], 05:58:41 INFO - 'tests': ['tp5o']}, 05:58:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'tests': ['tp5o']}, 05:58:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'talos_options': ['--disable-e10s', 05:58:41 INFO - '--xperf_path', 05:58:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:41 INFO - 'tests': ['tp5n']}, 05:58:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:41 INFO - 'talos_options': ['--xperf_path', 05:58:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:41 INFO - 'tests': ['tp5n']}}, 05:58:41 INFO - 'talos.zip': {'path': '', 05:58:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:41 INFO - Running post-action listener: _resource_record_post_action 05:58:41 INFO - ##### 05:58:41 INFO - ##### Running create-virtualenv step. 05:58:41 INFO - ##### 05:58:41 INFO - Running pre-action listener: _resource_record_pre_action 05:58:41 INFO - Running main action method: create_virtualenv 05:58:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:41 INFO - Using real prefix '/usr' 05:58:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:44 INFO - Installing pip.................done. 05:58:44 INFO - Return code: 0 05:58:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:44 INFO - Using env: {'DISPLAY': ':0', 05:58:44 INFO - 'HOME': '/home/cltbld', 05:58:44 INFO - 'LANG': 'en_US.UTF-8', 05:58:44 INFO - 'LANGUAGE': 'en_US:en', 05:58:44 INFO - 'LOGNAME': 'cltbld', 05:58:44 INFO - 'MAIL': '/var/mail/cltbld', 05:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:44 INFO - 'MOZ_NO_REMOTE': '1', 05:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:44 INFO - 'NO_EM_RESTART': '1', 05:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:44 INFO - 'PWD': '/builds/slave/test', 05:58:44 INFO - 'SHELL': '/bin/bash', 05:58:44 INFO - 'SHLVL': '1', 05:58:44 INFO - 'TERM': 'linux', 05:58:44 INFO - 'TMOUT': '86400', 05:58:44 INFO - 'USER': 'cltbld', 05:58:44 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:44 INFO - '_': '/tools/buildbot/bin/python'} 05:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:44 INFO - Cleaning up... 05:58:44 INFO - Return code: 0 05:58:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:58:44 INFO - Using env: {'DISPLAY': ':0', 05:58:44 INFO - 'HOME': '/home/cltbld', 05:58:44 INFO - 'LANG': 'en_US.UTF-8', 05:58:44 INFO - 'LANGUAGE': 'en_US:en', 05:58:44 INFO - 'LOGNAME': 'cltbld', 05:58:44 INFO - 'MAIL': '/var/mail/cltbld', 05:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:44 INFO - 'MOZ_NO_REMOTE': '1', 05:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:44 INFO - 'NO_EM_RESTART': '1', 05:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:44 INFO - 'PWD': '/builds/slave/test', 05:58:44 INFO - 'SHELL': '/bin/bash', 05:58:44 INFO - 'SHLVL': '1', 05:58:44 INFO - 'TERM': 'linux', 05:58:44 INFO - 'TMOUT': '86400', 05:58:44 INFO - 'USER': 'cltbld', 05:58:44 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:44 INFO - '_': '/tools/buildbot/bin/python'} 05:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:44 INFO - Downloading/unpacking psutil>=0.7.1 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:46 INFO - Installing collected packages: psutil 05:58:46 INFO - Running setup.py install for psutil 05:58:46 INFO - building 'psutil._psutil_linux' extension 05:58:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:46 INFO - building 'psutil._psutil_posix' extension 05:58:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:47 INFO - Successfully installed psutil 05:58:47 INFO - Cleaning up... 05:58:47 INFO - Return code: 0 05:58:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:58:47 INFO - Using env: {'DISPLAY': ':0', 05:58:47 INFO - 'HOME': '/home/cltbld', 05:58:47 INFO - 'LANG': 'en_US.UTF-8', 05:58:47 INFO - 'LANGUAGE': 'en_US:en', 05:58:47 INFO - 'LOGNAME': 'cltbld', 05:58:47 INFO - 'MAIL': '/var/mail/cltbld', 05:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:47 INFO - 'MOZ_NO_REMOTE': '1', 05:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:47 INFO - 'NO_EM_RESTART': '1', 05:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:47 INFO - 'PWD': '/builds/slave/test', 05:58:47 INFO - 'SHELL': '/bin/bash', 05:58:47 INFO - 'SHLVL': '1', 05:58:47 INFO - 'TERM': 'linux', 05:58:47 INFO - 'TMOUT': '86400', 05:58:47 INFO - 'USER': 'cltbld', 05:58:47 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:47 INFO - '_': '/tools/buildbot/bin/python'} 05:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:58:49 INFO - Installing collected packages: mozsystemmonitor 05:58:49 INFO - Running setup.py install for mozsystemmonitor 05:58:49 INFO - Successfully installed mozsystemmonitor 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:49 INFO - Using env: {'DISPLAY': ':0', 05:58:49 INFO - 'HOME': '/home/cltbld', 05:58:49 INFO - 'LANG': 'en_US.UTF-8', 05:58:49 INFO - 'LANGUAGE': 'en_US:en', 05:58:49 INFO - 'LOGNAME': 'cltbld', 05:58:49 INFO - 'MAIL': '/var/mail/cltbld', 05:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:49 INFO - 'MOZ_NO_REMOTE': '1', 05:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:49 INFO - 'NO_EM_RESTART': '1', 05:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:49 INFO - 'PWD': '/builds/slave/test', 05:58:49 INFO - 'SHELL': '/bin/bash', 05:58:49 INFO - 'SHLVL': '1', 05:58:49 INFO - 'TERM': 'linux', 05:58:49 INFO - 'TMOUT': '86400', 05:58:49 INFO - 'USER': 'cltbld', 05:58:49 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:49 INFO - '_': '/tools/buildbot/bin/python'} 05:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:52 INFO - Downloading docopt-0.6.1.tar.gz 05:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:52 INFO - Running setup.py install for blobuploader 05:58:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:52 INFO - Running setup.py install for requests 05:58:52 INFO - Running setup.py install for docopt 05:58:52 INFO - Successfully installed blobuploader requests docopt 05:58:52 INFO - Cleaning up... 05:58:52 INFO - Return code: 0 05:58:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:52 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 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:52 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 05:58:52 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 05:58:52 INFO - Using env: {'DISPLAY': ':0', 05:58:52 INFO - 'HOME': '/home/cltbld', 05:58:52 INFO - 'LANG': 'en_US.UTF-8', 05:58:52 INFO - 'LANGUAGE': 'en_US:en', 05:58:52 INFO - 'LOGNAME': 'cltbld', 05:58:52 INFO - 'MAIL': '/var/mail/cltbld', 05:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:52 INFO - 'MOZ_NO_REMOTE': '1', 05:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:52 INFO - 'NO_EM_RESTART': '1', 05:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:52 INFO - 'PWD': '/builds/slave/test', 05:58:52 INFO - 'SHELL': '/bin/bash', 05:58:52 INFO - 'SHLVL': '1', 05:58:52 INFO - 'TERM': 'linux', 05:58:52 INFO - 'TMOUT': '86400', 05:58:52 INFO - 'USER': 'cltbld', 05:58:52 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:52 INFO - '_': '/tools/buildbot/bin/python'} 05:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:52 INFO - Running setup.py (path:/tmp/pip-4E8fSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:53 INFO - Running setup.py (path:/tmp/pip-mt9bo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:53 INFO - Running setup.py (path:/tmp/pip-YtGKGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:53 INFO - Running setup.py (path:/tmp/pip-xxl4wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:53 INFO - Running setup.py (path:/tmp/pip-k2irum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:53 INFO - Running setup.py (path:/tmp/pip-EBl_Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:53 INFO - Running setup.py (path:/tmp/pip-ZVsxAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:53 INFO - Running setup.py (path:/tmp/pip-YNtmQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:53 INFO - Running setup.py (path:/tmp/pip-5i4DY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:53 INFO - Running setup.py (path:/tmp/pip-OfJ2hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:53 INFO - Running setup.py (path:/tmp/pip-rkqL8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:53 INFO - Running setup.py (path:/tmp/pip-EveHcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:53 INFO - Running setup.py (path:/tmp/pip-ZcdngC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:53 INFO - Running setup.py (path:/tmp/pip-eVRY2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:53 INFO - Running setup.py (path:/tmp/pip-slcAMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:54 INFO - Running setup.py (path:/tmp/pip-wT02Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:54 INFO - Running setup.py (path:/tmp/pip-W_WFWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:54 INFO - Running setup.py install for manifestparser 05:58:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Running setup.py install for mozcrash 05:58:54 INFO - Running setup.py install for mozdebug 05:58:54 INFO - Running setup.py install for mozdevice 05:58:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Running setup.py install for mozfile 05:58:54 INFO - Running setup.py install for mozhttpd 05:58:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Running setup.py install for mozinfo 05:58:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Running setup.py install for mozInstall 05:58:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:54 INFO - Running setup.py install for mozleak 05:58:55 INFO - Running setup.py install for mozlog 05:58:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Running setup.py install for moznetwork 05:58:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Running setup.py install for mozprocess 05:58:55 INFO - Running setup.py install for mozprofile 05:58:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Running setup.py install for mozrunner 05:58:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Running setup.py install for mozscreenshot 05:58:55 INFO - Running setup.py install for moztest 05:58:55 INFO - Running setup.py install for mozversion 05:58:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:55 INFO - Cleaning up... 05:58:55 INFO - Return code: 0 05:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:55 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 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:55 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 05:58:55 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 05:58:55 INFO - Using env: {'DISPLAY': ':0', 05:58:55 INFO - 'HOME': '/home/cltbld', 05:58:55 INFO - 'LANG': 'en_US.UTF-8', 05:58:55 INFO - 'LANGUAGE': 'en_US:en', 05:58:55 INFO - 'LOGNAME': 'cltbld', 05:58:55 INFO - 'MAIL': '/var/mail/cltbld', 05:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:55 INFO - 'MOZ_NO_REMOTE': '1', 05:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:55 INFO - 'NO_EM_RESTART': '1', 05:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:55 INFO - 'PWD': '/builds/slave/test', 05:58:55 INFO - 'SHELL': '/bin/bash', 05:58:55 INFO - 'SHLVL': '1', 05:58:55 INFO - 'TERM': 'linux', 05:58:55 INFO - 'TMOUT': '86400', 05:58:55 INFO - 'USER': 'cltbld', 05:58:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:55 INFO - '_': '/tools/buildbot/bin/python'} 05:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:56 INFO - Running setup.py (path:/tmp/pip-X0mzZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:56 INFO - Running setup.py (path:/tmp/pip-VFPdZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:56 INFO - Running setup.py (path:/tmp/pip-JeYbg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:56 INFO - Running setup.py (path:/tmp/pip-6L8LPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:56 INFO - Running setup.py (path:/tmp/pip-mbpZNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:56 INFO - Running setup.py (path:/tmp/pip-EjjrbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:56 INFO - Running setup.py (path:/tmp/pip-lN33eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:56 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)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:56 INFO - Running setup.py (path:/tmp/pip-CYawF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:56 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)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:56 INFO - Running setup.py (path:/tmp/pip-JvqlPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:56 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)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:56 INFO - Running setup.py (path:/tmp/pip-6WtOc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:56 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)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:56 INFO - Running setup.py (path:/tmp/pip-t6hayi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:56 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)) 05:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:56 INFO - Running setup.py (path:/tmp/pip-h57jZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:57 INFO - Running setup.py (path:/tmp/pip-SEWJYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:57 INFO - Running setup.py (path:/tmp/pip-SgcI0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:57 INFO - Running setup.py (path:/tmp/pip-z5rjn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:57 INFO - Running setup.py (path:/tmp/pip-QidxGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:57 INFO - Running setup.py (path:/tmp/pip-iiOLEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - Downloading blessings-1.6.tar.gz 05:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:59 INFO - Installing collected packages: blessings 05:58:59 INFO - Running setup.py install for blessings 05:58:59 INFO - Successfully installed blessings 05:58:59 INFO - Cleaning up... 05:58:59 INFO - Return code: 0 05:58:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:59 INFO - Reading from file tmpfile_stdout 05:58:59 INFO - Current package versions: 05:58:59 INFO - argparse == 1.2.1 05:58:59 INFO - blessings == 1.6 05:58:59 INFO - blobuploader == 1.2.4 05:58:59 INFO - docopt == 0.6.1 05:58:59 INFO - manifestparser == 1.1 05:58:59 INFO - mozInstall == 1.12 05:58:59 INFO - mozcrash == 0.17 05:58:59 INFO - mozdebug == 0.1 05:58:59 INFO - mozdevice == 0.48 05:58:59 INFO - mozfile == 1.2 05:58:59 INFO - mozhttpd == 0.7 05:58:59 INFO - mozinfo == 0.9 05:58:59 INFO - mozleak == 0.1 05:58:59 INFO - mozlog == 3.1 05:58:59 INFO - moznetwork == 0.27 05:58:59 INFO - mozprocess == 0.22 05:58:59 INFO - mozprofile == 0.28 05:58:59 INFO - mozrunner == 6.11 05:58:59 INFO - mozscreenshot == 0.1 05:58:59 INFO - mozsystemmonitor == 0.0 05:58:59 INFO - moztest == 0.7 05:58:59 INFO - mozversion == 1.4 05:58:59 INFO - psutil == 3.1.1 05:58:59 INFO - requests == 1.2.3 05:58:59 INFO - wsgiref == 0.1.2 05:58:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:59 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')]} 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:59 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')]} 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:59 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 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:58:59 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 05:58:59 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 05:58:59 INFO - Using env: {'DISPLAY': ':0', 05:58:59 INFO - 'HOME': '/home/cltbld', 05:58:59 INFO - 'LANG': 'en_US.UTF-8', 05:58:59 INFO - 'LANGUAGE': 'en_US:en', 05:58:59 INFO - 'LOGNAME': 'cltbld', 05:58:59 INFO - 'MAIL': '/var/mail/cltbld', 05:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:59 INFO - 'MOZ_NO_REMOTE': '1', 05:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:59 INFO - 'NO_EM_RESTART': '1', 05:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:59 INFO - 'PWD': '/builds/slave/test', 05:58:59 INFO - 'SHELL': '/bin/bash', 05:58:59 INFO - 'SHLVL': '1', 05:58:59 INFO - 'TERM': 'linux', 05:58:59 INFO - 'TMOUT': '86400', 05:58:59 INFO - 'USER': 'cltbld', 05:58:59 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:59 INFO - '_': '/tools/buildbot/bin/python'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:00 INFO - Cleaning up... 05:59:00 INFO - Return code: 0 05:59:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:00 INFO - Using env: {'DISPLAY': ':0', 05:59:00 INFO - 'HOME': '/home/cltbld', 05:59:00 INFO - 'LANG': 'en_US.UTF-8', 05:59:00 INFO - 'LANGUAGE': 'en_US:en', 05:59:00 INFO - 'LOGNAME': 'cltbld', 05:59:00 INFO - 'MAIL': '/var/mail/cltbld', 05:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:00 INFO - 'MOZ_NO_REMOTE': '1', 05:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:00 INFO - 'NO_EM_RESTART': '1', 05:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:00 INFO - 'PWD': '/builds/slave/test', 05:59:00 INFO - 'SHELL': '/bin/bash', 05:59:00 INFO - 'SHLVL': '1', 05:59:00 INFO - 'TERM': 'linux', 05:59:00 INFO - 'TMOUT': '86400', 05:59:00 INFO - 'USER': 'cltbld', 05:59:00 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:00 INFO - '_': '/tools/buildbot/bin/python'} 05:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:00 INFO - Downloading/unpacking jsonschema 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:02 INFO - warning: no files found matching '*.txt' 05:59:02 INFO - no previously-included directories found matching 'build' 05:59:02 INFO - no previously-included directories found matching 'dist' 05:59:02 INFO - no previously-included directories found matching '.git*' 05:59:02 INFO - Installing collected packages: jsonschema, functools32 05:59:02 INFO - Running setup.py install for functools32 05:59:02 INFO - warning: no files found matching '*.txt' 05:59:02 INFO - no previously-included directories found matching 'build' 05:59:02 INFO - no previously-included directories found matching 'dist' 05:59:02 INFO - no previously-included directories found matching '.git*' 05:59:02 INFO - Successfully installed jsonschema functools32 05:59:02 INFO - Cleaning up... 05:59:02 INFO - Return code: 0 05:59:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f294788ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aeb7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', '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 05:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:59:02 INFO - Using env: {'DISPLAY': ':0', 05:59:02 INFO - 'HOME': '/home/cltbld', 05:59:02 INFO - 'LANG': 'en_US.UTF-8', 05:59:02 INFO - 'LANGUAGE': 'en_US:en', 05:59:02 INFO - 'LOGNAME': 'cltbld', 05:59:02 INFO - 'MAIL': '/var/mail/cltbld', 05:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:02 INFO - 'MOZ_NO_REMOTE': '1', 05:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:02 INFO - 'NO_EM_RESTART': '1', 05:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:02 INFO - 'PWD': '/builds/slave/test', 05:59:02 INFO - 'SHELL': '/bin/bash', 05:59:02 INFO - 'SHLVL': '1', 05:59:02 INFO - 'TERM': 'linux', 05:59:02 INFO - 'TMOUT': '86400', 05:59:02 INFO - 'USER': 'cltbld', 05:59:02 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:02 INFO - '_': '/tools/buildbot/bin/python'} 05:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:02 INFO - Downloading/unpacking flake8 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:59:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:59:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:04 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 05:59:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:05 INFO - no previously-included directories found matching 'docs/_build' 05:59:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:59:05 INFO - Running setup.py install for pep8 05:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:59:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:59:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:59:05 INFO - no previously-included directories found matching 'docs/_build' 05:59:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:59:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:59:05 INFO - Cleaning up... 05:59:05 INFO - Return code: 0 05:59:05 INFO - Running post-action listener: _resource_record_post_action 05:59:05 INFO - Running post-action listener: _start_resource_monitoring 05:59:05 INFO - Starting resource monitoring. 05:59:05 INFO - ##### 05:59:05 INFO - ##### Running install step. 05:59:05 INFO - ##### 05:59:05 INFO - Running pre-action listener: _resource_record_pre_action 05:59:05 INFO - Running main action method: install 05:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:05 INFO - Reading from file tmpfile_stdout 05:59:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:06 INFO - Reading from file tmpfile_stdout 05:59:06 INFO - Output received: 05:59:06 INFO - Usage: mozinstall [options] installer 05:59:06 INFO - Options: 05:59:06 INFO - -h, --help show this help message and exit 05:59:06 INFO - -d DEST, --destination=DEST 05:59:06 INFO - Directory to install application into. [default: 05:59:06 INFO - "/builds/slave/test"] 05:59:06 INFO - --app=APP Application being installed. [default: firefox] 05:59:06 INFO - mkdir: /builds/slave/test/build/application 05:59:06 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'] 05:59:06 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 05:59:21 INFO - Reading from file tmpfile_stdout 05:59:21 INFO - Output received: 05:59:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:21 INFO - Running post-action listener: _resource_record_post_action 05:59:21 INFO - ##### 05:59:21 INFO - ##### Running run-tests step. 05:59:21 INFO - ##### 05:59:21 INFO - Running pre-action listener: _resource_record_pre_action 05:59:21 INFO - Running main action method: run_tests 05:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:21 INFO - Python 2.7.3 05:59:21 INFO - Return code: 0 05:59:21 INFO - grabbing minidump binary from tooltool 05:59:21 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')]} 05:59:21 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 0x1b7a640>, '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 0x1b7b540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:21 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 05:59:21 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 05:59:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:21 INFO - Return code: 0 05:59:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:59:22 INFO - Return code: 0 05:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:59:22 INFO - Using env: {'DISPLAY': ':0', 05:59:22 INFO - 'HOME': '/home/cltbld', 05:59:22 INFO - 'LANG': 'en_US.UTF-8', 05:59:22 INFO - 'LANGUAGE': 'en_US:en', 05:59:22 INFO - 'LOGNAME': 'cltbld', 05:59:22 INFO - 'MAIL': '/var/mail/cltbld', 05:59:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:22 INFO - 'MOZ_NO_REMOTE': '1', 05:59:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:22 INFO - 'NO_EM_RESTART': '1', 05:59:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:22 INFO - 'PWD': '/builds/slave/test', 05:59:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:22 INFO - 'SHELL': '/bin/bash', 05:59:22 INFO - 'SHLVL': '1', 05:59:22 INFO - 'TERM': 'linux', 05:59:22 INFO - 'TMOUT': '86400', 05:59:22 INFO - 'USER': 'cltbld', 05:59:22 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564', 05:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:22 INFO - '_': '/tools/buildbot/bin/python'} 05:59:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:59:22 INFO - mozversion application_buildid: 20160421052914 05:59:22 INFO - mozversion application_changeset: f789cf6c7a5564260a6427492999dbf8bc93e065 05:59:22 INFO - mozversion application_display_name: Nightly 05:59:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:22 INFO - mozversion application_name: Firefox 05:59:22 INFO - mozversion application_remotingname: firefox 05:59:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:59:22 INFO - mozversion application_vendor: Mozilla 05:59:22 INFO - mozversion application_version: 48.0a1 05:59:22 INFO - mozversion platform_buildid: 20160421052914 05:59:22 INFO - mozversion platform_changeset: f789cf6c7a5564260a6427492999dbf8bc93e065 05:59:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:59:22 INFO - mozversion platform_version: 48.0a1 05:59:22 INFO - using testdate: 1461243562 05:59:22 INFO - actual date: 1461243562 05:59:22 INFO - starting webserver on 'localhost:38962' 05:59:22 INFO - SUITE-START | Running 2 tests 05:59:22 INFO - TEST-START | dromaeo_css 05:59:22 INFO - operating with platform_type : linux_ 05:59:22 INFO - Initialising browser for dromaeo_css test... 05:59:23 INFO - TEST-INFO | started process 25414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61x92_/profile http://localhost:38962/getInfo.html) 05:59:27 INFO - PROCESS | 25414 | 05:59:27 INFO - PROCESS | 25414 | (process:25480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:28 INFO - PROCESS | 25414 | __metrics Screen width/height:1600/1200 05:59:28 INFO - PROCESS | 25414 | colorDepth:24 05:59:28 INFO - PROCESS | 25414 | Browser inner width/height: 1024/697 05:59:28 INFO - PROCESS | 25414 | __metrics 05:59:29 ERROR - PROCESS | 25414 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:59:29 INFO - TEST-INFO | 25414: exit 0 05:59:29 INFO - Browser initialized. 05:59:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:29 INFO - TEST-INFO | started process 25532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61x92_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:31 INFO - PROCESS | 25532 | 05:59:31 INFO - PROCESS | 25532 | (process:25592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:59:41 INFO - PROCESS | 25532 | RSS: Main: 164433920 05:59:41 INFO - PROCESS | 25532 | 06:00:31 INFO - PROCESS | 25532 | 1461243631471 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] 06:02:43 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38962/tests/dromaeo/cssquery-ext.html) 06:02:44 INFO - PROCESS | 25532 | RSS: Main: 170348544 06:02:44 INFO - PROCESS | 25532 | 06:05:46 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-ext.html (next: http://localhost:38962/tests/dromaeo/cssquery-jquery.html) 06:05:47 INFO - PROCESS | 25532 | RSS: Main: 166567936 06:05:47 INFO - PROCESS | 25532 | 06:08:49 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38962/tests/dromaeo/cssquery-mootools.html) 06:08:49 INFO - PROCESS | 25532 | RSS: Main: 167493632 06:08:49 INFO - PROCESS | 25532 | 06:11:51 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38962/tests/dromaeo/cssquery-prototype.html) 06:11:52 INFO - PROCESS | 25532 | RSS: Main: 165011456 06:11:52 INFO - PROCESS | 25532 | 06:14:54 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38962/tests/dromaeo/cssquery-yui.html) 06:14:55 INFO - PROCESS | 25532 | RSS: Main: 166318080 06:14:55 INFO - PROCESS | 25532 | 06:17:57 INFO - PROCESS | 25532 | Cycle 1(1): loaded http://localhost:38962/tests/dromaeo/cssquery-yui.html (next: http://localhost:38962/tests/dromaeo/cssquery-dojo.html) 06:17:58 INFO - PROCESS | 25532 | RSS: Main: 168325120 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | __start_tp_report 06:17:58 INFO - PROCESS | 25532 | _x_x_mozilla_page_load 06:17:58 INFO - PROCESS | 25532 | _x_x_mozilla_page_load_details 06:17:58 INFO - PROCESS | 25532 | |i|pagename|runs| 06:17:58 INFO - PROCESS | 25532 | |0;dojo.html;2585.7284985076567;2645.6692913385828;2651.986740066302;2707.12018593957;2708.5666293393047;4662.090892276007;4680.836170734025;4703.623710103192;4719.69321994071;4732.337472753818;4582.839600613979;4725.480197178307;4735.952640473594;4788.114198873211;4805.687630304028;4322.7190232634775;4327.978360108195;4428.689991700582;4432.601065904068;4434.733915965036;4399.2521271383785;4436.889077773066;4444.022315090675;4446.1107778444275;4480.19356515827;4274.221755858701;4299.505556860939;4303.483581970184;4310.374995625617;4373.759443230621;4349.173657005159;4364.214441400547;4365.061511774984;4415.580519850609;4424.889377765581;4330.675199360061;4337.414449049369;4346.521882592912;4349.043210493686;4393.253146964992;4601.792919318638;4633.235516139833;4667.486576476619;4670;4699.412573428322;5028.371453568304;5032.547070763612;5046.343975283226;5052.368453943257;5112.079825631385;4917.680350777224;5066.746662666888;5090.796368145269;5126.615503837227;5148.6910785353;4769.189237829577;4770.308305295713;4788.233882578806;4801.207800712913;4818.229083346648;5196.714180720021;5226.216067589892;5228.816991405359;5238.60710446718;5243;4805.975970120127;4992.450830408652;5049.065922804293;5050.217216331474;5050.292958985745;4898.583620392235;5013.298138260647;5032.974835125801;5060.898782024413;5111.3355263815465;5012.323336349619;5040.1179793535985;5058.013687331008;5060.266261392151;5101.591872650179;4910.459849416561;4923.261510773341;4945.381827271591;5025.79896804131;5091.9236211456855;4153.1486045360625;4170.812313445902;4181.540030596632;4200.831966721358;4207.558206388347;3692.9446058309145;3709.888703338904;3739.7382183247455;3747.3254814133174;3751.737378383487;4415.779211039435;4453.087117140978;4459.44256967879;4490.977545112319;4495.527969563149;5135.717535535507;5158.174692049329;5166.896662066738;5200.739963001834;5242.1088414969545;4291.420658211102;4464.665150113755;4535.7732113394195;4537.047220083753;4585.082983403333;4563.475200352002;4577.725336479822;4598.218302888517;4611.953880461219;4640.559146881041;4826.806927722922;4832.057748738962;4842.612590992641;4843.95156048435;4865.683730557503;4865.416150062015;5013.674111182761;5068.163752980717;5072.391313042459;5123.590112790893;4857.684250523705;4858.4898585648;4871.123197824426;4889.559939605452;4892.168331383745;5051.599406868808;5072.619553533426;5073.720945348041;5080.136376815876;5114.386273647037;4927.063857866994;5083.771230294572;5114.105031619526;5127.717975511383;5198.9740051299505;4784.330193772944;4907.484714104968;4914.459409464885;4972.900541989067;4991.775370108281;4825.420949486084;4828.5412885775795;4841.612670986383;4844.079624871263;4844.733539655353;4766.880827979328;4790.065937142223;4803.471618121934;4848.757562121809;4903.877403064952;4894.33926419943;4968.22992436173;4971.825986090469;4976.925346119739;5000.424951130521;4798.760061996816;4818.373611430632;4868.537488938545;4896.82861099874;4902.63230257725 06:17:58 INFO - PROCESS | 25532 | |1;ext.html;545.5749970772767;584.1092334190362;587.5740088435884;604.9667268300243;623.5323507369473;33129.83435082824;34118.829405853;34193.82903085481;34204.144896377606;34236.82881585595;35663;36267;36424.63575364252;36444;36544.269114617695;7609.999999999986;7731.613419329011;7756.806079847993;7764.844703105934;7778.222177782233;7587.241275872424;7683.346915512188;7692.384609231248;7699.499532530395;7707;7654.158042615308;7712.57580833054;7720.575368354738;7730.18833022533;7732.226777322251;7591;7624.580648064354;7684.231576842327;7705.961470192669;7709.3061624453785;7653.885191722128;7736.9613151934445;7791.805204869924;7794.3764498839955;7810.414218933603;34283;34871.30257394838;34876.651233487595;34972.825135874155;35005.299894001975;3114.112477943775;3264.853081611333;3313.933721325584;3375.05498460429;3511.5961664408665;27385.589216161774;27562.173134805988;27660.861695691394;28014.159575212776;28075.29811754702;3477.8434970426392;3485.128717820545;3528.5942116656656;3528.964710352889;3539.380608393521;216762;217024;217378;217485;217962;32606.836965815495;50089.74955125201;50283.74858125759;50390.96872250211;50396.49603503991;31680.36639267202;31690.366192676018;31740.523892141635;31799.364012719616;31832.204194895312;12414.068944829174;12559.497620095093;12640.367981600883;12669.366531673379;12734.172278801849;10260.230482713827;10299.639512617023;10324.380537167794;10330;10362.585496580052;7982.201779822088;8071.23323284287;8071.434999549975;8141.267285944294;8159.143289954469;3155.763317751178;3157.952630710541;3162.3991441626017;3186.9362612747614;3200.8879689210767;871.2246100970142;878.6529320918202;888.7733627924838;979.5836769372988;1006.2151521812998;27395.863020685167;27657.308567285578;28179.154625361272;28515.287117821805;28566.42867142687;950.8858936927613;1007.8387458006683;1035.171862509989;1077.9730506737394;1079.4926384599225;13172;13563.597362357903;13613.319334033258;13909.79135312971;14154.292285385896;337284;343086;344833;345146;345743;42939.570604293556;43361.783191084476;43368;43627.34558981618;43824.780876095414;1202.77352332393;1209.673388185185;1221.407617305606;1224.9816252756216;1235.3946566182685;25139.120130795334;26193.4761304769;26492.205233843015;26634.200973970812;26667;39329;39861.20277594374;40293;40378;40553.391699123946;253437;254602;255108;256447;256636;24435.87782061078;37716.81141594274;38598.6140138595;38911.6108838908;39458;35378.82310588431;36378.4543231857;36531;36768.08079798026;36935.63064369322;32876;32953.505697414075;34233.48649770305;34440.65559344374;34578.48132278068;33131.33737325192;33237.833810830794;34255.31489370248;34371.656283436845;34719.305613888086;34560.308793824486;34781.13047173739;35085.47371789476;37674.62325376821;39042.609573903894;29368.26579335534;30446.695533044385;30921.072367829;30933.0720078398;31116;24087.486019634645;24277.878610606833;24535.63196552089;25015.374615634755;25040.37399065038 06:17:58 INFO - PROCESS | 25532 | |2;jquery.html;365.7567717467884;368.1110119062464;372.8247723569922;375.3974870333115;377.8337531486144;14908;15621.297041633125;16735.748963765553;16821.327146914125;16883.155842207903;15101.6979660407;15732.213389330545;16395.508134755946;16436.424725134624;16510;4991.550760431561;5127.359080114986;5206.297149884755;5216.191490319006;5239.5546378557865;3654.506641603376;5010.5240002199735;5503.147012213093;6033.758649654031;6040.154378387029;5971.790987315445;5978.52171826255;5982.341942386334;5998.52011839054;6002.549808764338;5777.768889244425;5842.152887831262;5967.015442452033;5970.373110823344;5971.775785963889;5043.798248070073;5162.74186290684;5165.173572228463;5169.896602067975;5189.195674670432;18681;18880.244790208377;19107.61784764311;19120.80879191204;19914.701279480818;1873.5878106816615;1906.9904650476658;1930.4112245765036;2022.5449273913398;2337.357226762637;12406.25562466255;13100.672483187902;13673.589792306248;13702.177869327872;14337.78493322601;1785.9107044647847;1812.2116879157609;1846.0585101598147;1856.4523465577688;1942.359021522894;71009.64495177542;74051;74992.87567681116;75084.85336239278;75264.24735752682;15695.607609809846;15847.207639617973;16088.356465741239;16142.192890355434;16164.515064548083;28016;28088.157355279374;28138.85930570334;28322.291942701184;28456.857715711703;8627.6980305689;8700.216980471789;8706.1729135732;8910.955445222862;8951.32865035125;7229.710811567584;7240.384567311838;7246.963765181245;7300.853982920312;7369.299916507923;8154.347652187929;8311.709090181814;8359.164083591591;8398.538080405515;8406.411551191359;1796.5418818201535;1876.1371658099451;1932.6424611446928;1940.3014914630721;3050.283183451887;872.6596627315353;909.6134142989204;948.5636607160645;960.5341409416427;991.2466525440573;15712;15902;15928.92035539815;16200.189990500428;16475.423360182336;877.5392918717597;891.3715830339595;897.3852910756153;910.4673765846921;948.5636607160783;8669.739907802776;8905.064968178249;8926.285897128215;9067.682631108011;9143.314251431037;381499;390652;393599;393980;395190;72691.27308726845;72810.2718972814;74348.62825685945;74812.25187748161;75032.62483687655;921.9032001639865;922.6678395777515;929.5956259027209;941.8163458125737;965.0831709875646;14150.504732334319;14234.14595124296;14311.141331520143;14504.709905801614;14541.781873271697;32610.51084233786;32853.835730822146;33299.667003329654;33767;34097;45126.77436612796;46002.30996534988;46229.76885115553;46274.768626158;46702.766486167355;7637.961810190914;7719.035120609924;7787.610619468891;7805.609719514116;7827.45207835446;8493.193146651058;10257.743556410851;10575.788484230427;11194.720131996764;11272.549098035986;10065.496725163566;10366.688999330032;10440;10459.47702614851;10594.841077383999;9268.490233037248;9393.201577865959;9599.280053996117;9781.706548803548;10093.343932644355;9789.216862650828;10401.115905147844;10495.947520262349;10734.624288149877;10740.624078157227;7379.151397589346;7740.14858365568;7757.534547927143;7815;7956.164602716863;7807.297343239135;9311.534423278674;10038.196944244297;10145.746356341151;10384.065434110966 06:17:58 INFO - PROCESS | 25532 | |3;mootools.html;1381.2734082397008;1419.8580141985801;1532.5402379286218;1738.4350086221982;1739.6433731085112;6834.760783372583;7532.322091011808;7587.544747315165;7810.492317999326;7810.765677029691;7605.353544948686;7640.694372225118;7642.235776422369;7642.885356719654;7695.769126926187;2244.9775502244934;2263.9886800566055;2265.2071774878827;2266.0369343029147;2267.4671452208718;2200.7249093863265;2215;2223.2552095048177;2227.0535022615322;2238.7985081342676;2207.9779202207933;2248.5615305015526;2251.8423710340285;2265.8413911026237;2284.554511870186;2199.450137465634;2202.1521714140013;2205.095910676615;2208.326460429568;2209.3924170853065;2156.2345367394505;2161.9351419457444;2167.7723838996994;2169.5010147666126;2173.7282839645045;7741.57421341826;7788;7816.687332506693;7860.646270917822;7867.921320786776;4355.5208927018;4518.27707566791;4524.977375113136;4570.9943812361225;4602.815887364502;2843.5023870822524;2872.540393537024;2917.9124626261246;2941.3970136122043;2954.9409011819644;943.4622265308777;947.0718695678205;954.494118117392;962.2494454325637;984.1437948984429;10230.335028223142;10244.692659220309;10307.94846025765;10309.07218350352;10326;4154.480689913761;4246.639035682002;4268.274393353137;4381.605655491021;4427.822887084545;8882.911170888337;8893.777655558662;8942.73171804847;8942.955285223663;8947.776305592412;4518.186726389282;4521.84173553924;4550.203714349976;4550.294704320836;4552.11233809404;3632.582253040934;4008.0581063450068;4145.481814773153;4151.335786274181;4155.335146376565;3617.6382361763613;3654.1778099927305;3691.593924668284;3727.7390582658954;3751.643593858579;1186.4067966016992;1212.805951047828;1219.762146381447;1222.2177806204036;1225.6874497003207;802.2899733735686;871.1419252036738;879.9032106468284;882.3117967984854;895.7133717210561;5150.201718733602;5251.264822924793;5265.499777521206;5306.602004849652;5313.282706834605;432.84201266537485;435.5296280017573;437.1693781814578;442.23493356493447;445.39648775908177;3839.6352346527037;3927.7446965947693;3953.367461206193;3991.401289806552;4003.7797921114034;9198.356115072014;9475.289353298393;9505.952470237742;9587.328886977844;9590.08894155054;8757.56212189388;9333.20667743236;9386.624535018524;9408.247340212767;9429.575669094907;6988.825279367955;7043.823904402431;7089.042979197742;7132.572045677172;7165.498415110892;5416.9729151353995;5562.388137304974;5619.353774315842;5633.887322253614;5638.60529762929;8160.877586836321;8378.49729016261;8438.240558349778;8484.236418722345;8510.191531804468;8351.24838764514;8384.413091083565;8618.827623447622;8786.736397908073;8787.428817126865;6164.691765411621;6385.616862988236;6569.178852643419;6641.236257830218;6742.86514269702;7105.360517553445;7205.423566114593;7234.782956511102;7242.529235599669;7243.492955493065;6418;6726.966365168143;6855.177378714387;6934.8613027740175;7015.824604384931;6635.933640663531;6702.396784289437;6823.147106611674;6891.517593768388;6898.344657257552;6323.683815809283;6440.29156792743;6499.870002600016;6512.348765123639;6516.380943810331;4726.71639701619;4831.468538460696;4888.9755551222015;4889.805451338045;4936.481669424658;4837.4920633332995;4869.683470574401;4903.313536104877;4916;4961.900761984668 06:17:58 INFO - PROCESS | 25532 | |4;prototype.html;302.5129541438284;309.7908911484749;310.33742958783;316.93661267746455;319.8880391862847;5357.08929481988;5393.379761327448;5402.6758394496355;5410.648307859987;5413.377461591913;5311.7344132793305;5330.227117068022;5346.385165705945;5347.679139251648;5348.598855085875;3935.232629637222;3943.507061617298;4085.673146148301;4098.610631989971;4099.836006559749;4075.8369665213354;4078.9796051019703;4088.121053973395;4089.427480152781;4104.794760261975;3997.2605068062358;4038.1519880825063;4038.9394159087637;4043.575424580421;4065.471488706479;3792.355299599075;4001.199760048002;4025.7181997260204;4080.8163632636456;4081.857135000276;3403.5745531808525;3439.5356626855305;3441;3452.498163298973;3454.3436747017986;5087.56755675768;5092.541671249605;5092.949070509321;5095.821646242401;5122.231665250205;4536.637069034469;4599.586037256663;4601.654875884322;4603.884902877455;4608.746518941457;5622.775088996435;5625.128105143668;5627.2684551008515;5653.236813030229;5658.0381335173115;3976.5029371328583;3978.661813745835;3993.221321842242;3999.280129576675;4001.0597509585223;5821.7380217890295;5846.152307915371;5864.589478736448;5894.58737888348;5911.822645320647;4099.61053699898;4122.196171746541;4122.814473348706;4128.1330920506425;4130.442390277274;4085.9591404085577;4152.688548358885;4184.456020717348;4186.6859985501205;4194.182134483746;4632.374629424984;4725.149473094807;4732.645051621143;4743.193657078305;4776.116418462526;5623.831285061455;5635.267415236075;5640.8871822563315;5649.293838270216;5672.4611161940375;1432.5773896700498;1453.9709205816037;1459.306829256095;1463.758479850834;1464.436192066041;911.544227886057;951.8477043672979;964.1756298364937;984.8378912882724;1010.9545070471846;4904.204603376042;4917.877053073702;4924.729139897268;4954.578860796801;4966.5281798229835;5748.080307150919;5753.367129615739;5757.510611597977;5759.798407055733;5769.769209231667;4738.336632871401;4943.110240156734;4950.158473059589;4956.5786908112495;4969.130402179604;3098.3338582204933;3117.7817552771544;3127.749780017593;3131.467650499375;3140.7487401007866;5485.753141108659;5534;5544.390117087117;5573.665580065209;5591.105423132361;5813.82558523245;5953.583249172603;5998.550108741862;6017.939820601738;6033.099573634291;5504.669719816824;5506.03644362243;5509.752061157257;5522.30971128609;5541.861453463695;5573.526250268773;5764.394738552392;5795.478406943395;5816.1857339973285;5853.970730146322;5684.687342196054;5687.118496633028;5695.174199740932;5722.284714410699;5725.456081672234;5425.240466334637;5499.560035197254;5500;5519.2824932758485;5531.2532808072;3899.3566061599518;3970.7021973352694;3984.143409167043;3997.9000524985945;4000.7199496035;5764.13537969308;5778.682172480554;5780.653160810365;5787.131930210502;5825.883482330414;5629.0712032514175;5630.296212973379;5631.971840140773;5640.5769567281795;5644.407337229696;5428.647137936022;5570.498655121059;5615.803446879339;5643.88712225745;5663.32040155184;5242.842714718565;5549.472800083986;5565.471280228372;5571.860703482445;5576.741419725018;5447.774250793698;5631.577631677558;5640.802571909963;5662.292213473316;5726.226959360433;5527.2538207343105;5531.197976293495;5539.861503462445;5546.4453554644215;5552.916706249491 06:17:58 INFO - PROCESS | 25532 | |5;yui.html;700.7652436433794;715.0204220218302;725.4957804325995;787.933025692816;803.2810634482137;10917.563297468092;11902.16684832061;12068.69828254293;12069.155159138852;12629.621111366674;14125.576232713009;14206.076605020666;14256.358463869125;14258.50095246664;14272.072315299498;624.8156793745833;794.7099308752307;805.122416565943;805.6495424490336;805.7542449552884;787.9842403151933;814.861473549495;816.0574536410455;820.0978923184479;821.1747194069951;843.4601854812894;846.9872951905726;847.4406891451644;848.240824462106;848.7241646464893;832.8792325112855;833.0212000898949;840.260570697782;841.066416277931;842.1452225990563;619.3899009475663;619.6653806944245;620.5687047501988;620.5966122020723;623.2863371439677;11853.525858965631;11959.342236177006;12006.939965300118;12016.69958251042;12018.879811201863;12503.187292826027;12516.499340026388;12567.874321256762;12695.450871608538;12914.031447641464;10051.849222261671;10303.587856485732;10394.792104157874;10587.15302775776;10673.35959842412;3334.3498017886523;3375.2405708715587;3381.1040074380307;3421.6920477156928;3455.1189446691183;44568.77715611434;44722;45086.54913450856;45890.999999999665;46122.53877461216;9756.560954757053;9953.353032053039;10053.497325133714;10068.446235456973;10070.395776253301;17068.146592670317;17072.829271707124;17157.056361900217;17236.396726114526;17253.482395528154;6616.27221005689;6677.76627818024;6744.831379215559;6822.795316140524;6874.415674667609;3928.332183528807;3968.9603103969166;3983.9203215935518;4000.7999600019884;4037.7577345358786;2972.7175918287726;3004.6544647365395;3011.4428830666398;3032.1964679359985;3034.2717747740385;504.1907738080328;509.1217649554489;529.4493726524448;531.5747402078322;538.9083855744533;605.1769593353036;628.3936001758234;647.1263793878321;651.947844172465;655.9606423614598;7570.94006839043;7847.764567062997;7955.562444065632;7975.800604984922;8050.919490805017;519.8466452396552;555.2393221286782;635.0093853588417;637.4740838808002;645.6643637971047;3736.9898402762146;3845.2693988142164;3880.2239552089695;3882.8446862125197;3902.1610353774076;54277.1858422124;54518;54709.72645136749;55069.173962390596;55233.447665523636;45042;45494;45791.313130303075;47036.7648161757;48048.27927581089;42432.15135697269;43534.12931741348;44272;44391;44560;6981.301869813181;7302.622786915074;7360;7395.593242371721;7494.5128566643;24621.50756984886;24823.007079716608;25589.744102558736;26132.34669133287;29157.271068223465;33874.66125338715;34167.4874876882;34290.82854585811;34727.4790878132;35203;10649.306796964867;10949.178811589321;11034.889651103707;11053.171012173958;11082.889171108185;11531.192816502764;11563.826542601699;11751.823722643996;11794.46924888365;11998.160128790902;11102.333859968428;11512.712182195512;11582.131340149692;11638.476268568103;11743.17797754149;10781.568737250736;11166.553337866395;11369.943150284527;11620.128490363088;11680.883191167979;10832.729181770519;11046.779064418506;11189.552417903193;11282.43587820622;11493.712657183638;9093.704129805223;9209.493477858781;9353.438793672402;9445.952770236105;9456.196223321094;8512.70205542803;8793.3785400876;9093.454392736458;9175.587098580447;9192.954035230048 06:17:58 INFO - PROCESS | 25532 | __end_tp_report 06:17:58 INFO - PROCESS | 25532 | __start_cc_report 06:17:58 INFO - PROCESS | 25532 | _x_x_mozilla_cycle_collect,355 06:17:58 INFO - PROCESS | 25532 | __end_cc_report 06:17:58 INFO - PROCESS | 25532 | __startTimestamp1461244678189__endTimestamp 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | ------- Summary: start ------- 06:17:58 INFO - PROCESS | 25532 | Number of tests: 6 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#0] dojo.html Cycles:165 Average:4689.38 Median:4825.42 stddev:490.96 (10.2%) stddev-sans-first:463.90 06:17:58 INFO - PROCESS | 25532 | Values: 2585.7 2645.7 2652.0 2707.1 2708.6 4662.1 4680.8 4703.6 4719.7 4732.3 4582.8 4725.5 4736.0 4788.1 4805.7 4322.7 4328.0 4428.7 4432.6 4434.7 4399.3 4436.9 4444.0 4446.1 4480.2 4274.2 4299.5 4303.5 4310.4 4373.8 4349.2 4364.2 4365.1 4415.6 4424.9 4330.7 4337.4 4346.5 4349.0 4393.3 4601.8 4633.2 4667.5 4670.0 4699.4 5028.4 5032.5 5046.3 5052.4 5112.1 4917.7 5066.7 5090.8 5126.6 5148.7 4769.2 4770.3 4788.2 4801.2 4818.2 5196.7 5226.2 5228.8 5238.6 5243.0 4806.0 4992.5 5049.1 5050.2 5050.3 4898.6 5013.3 5033.0 5060.9 5111.3 5012.3 5040.1 5058.0 5060.3 5101.6 4910.5 4923.3 4945.4 5025.8 5091.9 4153.1 4170.8 4181.5 4200.8 4207.6 3692.9 3709.9 3739.7 3747.3 3751.7 4415.8 4453.1 4459.4 4491.0 4495.5 5135.7 5158.2 5166.9 5200.7 5242.1 4291.4 4464.7 4535.8 4537.0 4585.1 4563.5 4577.7 4598.2 4612.0 4640.6 4826.8 4832.1 4842.6 4844.0 4865.7 4865.4 5013.7 5068.2 5072.4 5123.6 4857.7 4858.5 4871.1 4889.6 4892.2 5051.6 5072.6 5073.7 5080.1 5114.4 4927.1 5083.8 5114.1 5127.7 5199.0 4784.3 4907.5 4914.5 4972.9 4991.8 4825.4 4828.5 4841.6 4844.1 4844.7 4766.9 4790.1 4803.5 4848.8 4903.9 4894.3 4968.2 4971.8 4976.9 5000.4 4798.8 4818.4 4868.5 4896.8 4902.6 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#1] ext.html Cycles:180 Average:41478.14 Median:34406.16 stddev:72766.91 (211.5%) stddev-sans-first:72906.14 06:17:58 INFO - PROCESS | 25532 | Values: 545.6 584.1 587.6 605.0 623.5 33129.8 34118.8 34193.8 34204.1 34236.8 35663.0 36267.0 36424.6 36444.0 36544.3 7610.0 7731.6 7756.8 7764.8 7778.2 7587.2 7683.3 7692.4 7699.5 7707.0 7654.2 7712.6 7720.6 7730.2 7732.2 7591.0 7624.6 7684.2 7706.0 7709.3 7653.9 7737.0 7791.8 7794.4 7810.4 34283.0 34871.3 34876.7 34972.8 35005.3 3114.1 3264.9 3313.9 3375.1 3511.6 27385.6 27562.2 27660.9 28014.2 28075.3 3477.8 3485.1 3528.6 3529.0 3539.4 216762.0 217024.0 217378.0 217485.0 217962.0 32606.8 50089.7 50283.7 50391.0 50396.5 31680.4 31690.4 31740.5 31799.4 31832.2 12414.1 12559.5 12640.4 12669.4 12734.2 10260.2 10299.6 10324.4 10330.0 10362.6 7982.2 8071.2 8071.4 8141.3 8159.1 3155.8 3158.0 3162.4 3186.9 3200.9 871.2 878.7 888.8 979.6 1006.2 27395.9 27657.3 28179.2 28515.3 28566.4 950.9 1007.8 1035.2 1078.0 1079.5 13172.0 13563.6 13613.3 13909.8 14154.3 337284.0 343086.0 344833.0 345146.0 345743.0 42939.6 43361.8 43368.0 43627.3 43824.8 1202.8 1209.7 1221.4 1225.0 1235.4 25139.1 26193.5 26492.2 26634.2 26667.0 39329.0 39861.2 40293.0 40378.0 40553.4 253437.0 254602.0 255108.0 256447.0 256636.0 24435.9 37716.8 38598.6 38911.6 39458.0 35378.8 36378.5 36531.0 36768.1 36935.6 32876.0 32953.5 34233.5 34440.7 34578.5 33131.3 33237.8 34255.3 34371.7 34719.3 34560.3 34781.1 35085.5 37674.6 39042.6 29368.3 30446.7 30921.1 30933.1 31116.0 24087.5 24277.9 24535.6 25015.4 25040.4 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#2] jquery.html Cycles:180 Average:24820.03 Median:46252.27 stddev:64419.73 (139.3%) stddev-sans-first:64574.27 06:17:58 INFO - PROCESS | 25532 | Values: 365.8 368.1 372.8 375.4 377.8 14908.0 15621.3 16735.7 16821.3 16883.2 15101.7 15732.2 16395.5 16436.4 16510.0 4991.6 5127.4 5206.3 5216.2 5239.6 3654.5 5010.5 5503.1 6033.8 6040.2 5971.8 5978.5 5982.3 5998.5 6002.5 5777.8 5842.2 5967.0 5970.4 5971.8 5043.8 5162.7 5165.2 5169.9 5189.2 18681.0 18880.2 19107.6 19120.8 19914.7 1873.6 1907.0 1930.4 2022.5 2337.4 12406.3 13100.7 13673.6 13702.2 14337.8 1785.9 1812.2 1846.1 1856.5 1942.4 71009.6 74051.0 74992.9 75084.9 75264.2 15695.6 15847.2 16088.4 16142.2 16164.5 28016.0 28088.2 28138.9 28322.3 28456.9 8627.7 8700.2 8706.2 8911.0 8951.3 7229.7 7240.4 7247.0 7300.9 7369.3 8154.3 8311.7 8359.2 8398.5 8406.4 1796.5 1876.1 1932.6 1940.3 3050.3 872.7 909.6 948.6 960.5 991.2 15712.0 15902.0 15928.9 16200.2 16475.4 877.5 891.4 897.4 910.5 948.6 8669.7 8905.1 8926.3 9067.7 9143.3 381499.0 390652.0 393599.0 393980.0 395190.0 72691.3 72810.3 74348.6 74812.3 75032.6 921.9 922.7 929.6 941.8 965.1 14150.5 14234.1 14311.1 14504.7 14541.8 32610.5 32853.8 33299.7 33767.0 34097.0 45126.8 46002.3 46229.8 46274.8 46702.8 7638.0 7719.0 7787.6 7805.6 7827.5 8493.2 10257.7 10575.8 11194.7 11272.5 10065.5 10366.7 10440.0 10459.5 10594.8 9268.5 9393.2 9599.3 9781.7 10093.3 9789.2 10401.1 10495.9 10734.6 10740.6 7379.2 7740.1 7757.5 7815.0 7956.2 7807.3 9311.5 10038.2 10145.7 10384.1 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#3] mootools.html Cycles:180 Average:5093.30 Median:5200.73 stddev:2775.74 (53.4%) stddev-sans-first:2769.51 06:17:58 INFO - PROCESS | 25532 | Values: 1381.3 1419.9 1532.5 1738.4 1739.6 6834.8 7532.3 7587.5 7810.5 7810.8 7605.4 7640.7 7642.2 7642.9 7695.8 2245.0 2264.0 2265.2 2266.0 2267.5 2200.7 2215.0 2223.3 2227.1 2238.8 2208.0 2248.6 2251.8 2265.8 2284.6 2199.5 2202.2 2205.1 2208.3 2209.4 2156.2 2161.9 2167.8 2169.5 2173.7 7741.6 7788.0 7816.7 7860.6 7867.9 4355.5 4518.3 4525.0 4571.0 4602.8 2843.5 2872.5 2917.9 2941.4 2954.9 943.5 947.1 954.5 962.2 984.1 10230.3 10244.7 10307.9 10309.1 10326.0 4154.5 4246.6 4268.3 4381.6 4427.8 8882.9 8893.8 8942.7 8943.0 8947.8 4518.2 4521.8 4550.2 4550.3 4552.1 3632.6 4008.1 4145.5 4151.3 4155.3 3617.6 3654.2 3691.6 3727.7 3751.6 1186.4 1212.8 1219.8 1222.2 1225.7 802.3 871.1 879.9 882.3 895.7 5150.2 5251.3 5265.5 5306.6 5313.3 432.8 435.5 437.2 442.2 445.4 3839.6 3927.7 3953.4 3991.4 4003.8 9198.4 9475.3 9506.0 9587.3 9590.1 8757.6 9333.2 9386.6 9408.2 9429.6 6988.8 7043.8 7089.0 7132.6 7165.5 5417.0 5562.4 5619.4 5633.9 5638.6 8160.9 8378.5 8438.2 8484.2 8510.2 8351.2 8384.4 8618.8 8786.7 8787.4 6164.7 6385.6 6569.2 6641.2 6742.9 7105.4 7205.4 7234.8 7242.5 7243.5 6418.0 6727.0 6855.2 6934.9 7015.8 6635.9 6702.4 6823.1 6891.5 6898.3 6323.7 6440.3 6499.9 6512.3 6516.4 4726.7 4831.5 4889.0 4889.8 4936.5 4837.5 4869.7 4903.3 4916.0 4961.9 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#4] prototype.html Cycles:180 Average:4645.46 Median:5348.14 stddev:1372.19 (25.7%) stddev-sans-first:1336.76 06:17:58 INFO - PROCESS | 25532 | Values: 302.5 309.8 310.3 316.9 319.9 5357.1 5393.4 5402.7 5410.6 5413.4 5311.7 5330.2 5346.4 5347.7 5348.6 3935.2 3943.5 4085.7 4098.6 4099.8 4075.8 4079.0 4088.1 4089.4 4104.8 3997.3 4038.2 4038.9 4043.6 4065.5 3792.4 4001.2 4025.7 4080.8 4081.9 3403.6 3439.5 3441.0 3452.5 3454.3 5087.6 5092.5 5092.9 5095.8 5122.2 4536.6 4599.6 4601.7 4603.9 4608.7 5622.8 5625.1 5627.3 5653.2 5658.0 3976.5 3978.7 3993.2 3999.3 4001.1 5821.7 5846.2 5864.6 5894.6 5911.8 4099.6 4122.2 4122.8 4128.1 4130.4 4086.0 4152.7 4184.5 4186.7 4194.2 4632.4 4725.1 4732.6 4743.2 4776.1 5623.8 5635.3 5640.9 5649.3 5672.5 1432.6 1454.0 1459.3 1463.8 1464.4 911.5 951.8 964.2 984.8 1011.0 4904.2 4917.9 4924.7 4954.6 4966.5 5748.1 5753.4 5757.5 5759.8 5769.8 4738.3 4943.1 4950.2 4956.6 4969.1 3098.3 3117.8 3127.7 3131.5 3140.7 5485.8 5534.0 5544.4 5573.7 5591.1 5813.8 5953.6 5998.6 6017.9 6033.1 5504.7 5506.0 5509.8 5522.3 5541.9 5573.5 5764.4 5795.5 5816.2 5854.0 5684.7 5687.1 5695.2 5722.3 5725.5 5425.2 5499.6 5500.0 5519.3 5531.3 3899.4 3970.7 3984.1 3997.9 4000.7 5764.1 5778.7 5780.7 5787.1 5825.9 5629.1 5630.3 5632.0 5640.6 5644.4 5428.6 5570.5 5615.8 5643.9 5663.3 5242.8 5549.5 5565.5 5571.9 5576.7 5447.8 5631.6 5640.8 5662.3 5726.2 5527.3 5531.2 5539.9 5546.4 5552.9 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - PROCESS | 25532 | [#5] yui.html Cycles:180 Average:12680.21 Median:44331.50 stddev:14351.31 (32.4%) stddev-sans-first:14363.37 06:17:58 INFO - PROCESS | 25532 | Values: 700.8 715.0 725.5 787.9 803.3 10917.6 11902.2 12068.7 12069.2 12629.6 14125.6 14206.1 14256.4 14258.5 14272.1 624.8 794.7 805.1 805.6 805.8 788.0 814.9 816.1 820.1 821.2 843.5 847.0 847.4 848.2 848.7 832.9 833.0 840.3 841.1 842.1 619.4 619.7 620.6 620.6 623.3 11853.5 11959.3 12006.9 12016.7 12018.9 12503.2 12516.5 12567.9 12695.5 12914.0 10051.8 10303.6 10394.8 10587.2 10673.4 3334.3 3375.2 3381.1 3421.7 3455.1 44568.8 44722.0 45086.5 45891.0 46122.5 9756.6 9953.4 10053.5 10068.4 10070.4 17068.1 17072.8 17157.1 17236.4 17253.5 6616.3 6677.8 6744.8 6822.8 6874.4 3928.3 3969.0 3983.9 4000.8 4037.8 2972.7 3004.7 3011.4 3032.2 3034.3 504.2 509.1 529.4 531.6 538.9 605.2 628.4 647.1 651.9 656.0 7570.9 7847.8 7955.6 7975.8 8050.9 519.8 555.2 635.0 637.5 645.7 3737.0 3845.3 3880.2 3882.8 3902.2 54277.2 54518.0 54709.7 55069.2 55233.4 45042.0 45494.0 45791.3 47036.8 48048.3 42432.2 43534.1 44272.0 44391.0 44560.0 6981.3 7302.6 7360.0 7395.6 7494.5 24621.5 24823.0 25589.7 26132.3 29157.3 33874.7 34167.5 34290.8 34727.5 35203.0 10649.3 10949.2 11034.9 11053.2 11082.9 11531.2 11563.8 11751.8 11794.5 11998.2 11102.3 11512.7 11582.1 11638.5 11743.2 10781.6 11166.6 11369.9 11620.1 11680.9 10832.7 11046.8 11189.6 11282.4 11493.7 9093.7 9209.5 9353.4 9446.0 9456.2 8512.7 8793.4 9093.5 9175.6 9193.0 06:17:58 INFO - PROCESS | 25532 | -------- Summary: end -------- 06:17:58 INFO - PROCESS | 25532 | 06:17:58 INFO - TEST-INFO | 25532: exit 0 06:17:58 INFO - TEST-OK | dromaeo_css | took 1115940ms 06:17:58 INFO - TEST-START | kraken 06:17:58 INFO - operating with platform_type : linux_ 06:17:58 INFO - Initialising browser for kraken test... 06:17:58 INFO - TEST-INFO | started process 25771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGO40B/profile http://localhost:38962/getInfo.html) 06:18:02 INFO - PROCESS | 25771 | 06:18:02 INFO - PROCESS | 25771 | (process:25838): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:18:03 INFO - PROCESS | 25771 | __metrics Screen width/height:1600/1200 06:18:03 INFO - PROCESS | 25771 | colorDepth:24 06:18:03 INFO - PROCESS | 25771 | Browser inner width/height: 1024/697 06:18:03 INFO - PROCESS | 25771 | __metrics 06:18:04 ERROR - PROCESS | 25771 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:18:05 INFO - TEST-INFO | 25771: exit 0 06:18:05 INFO - Browser initialized. 06:18:05 INFO - Running cycle 1/1 for kraken test... 06:18:05 INFO - TEST-INFO | started process 25889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGO40B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:07 INFO - PROCESS | 25889 | 06:18:07 INFO - PROCESS | 25889 | (process:25948): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:18:17 INFO - PROCESS | 25889 | RSS: Main: 164687872 06:18:17 INFO - PROCESS | 25889 | 06:18:20 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38962/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:21 INFO - PROCESS | 25889 | RSS: Main: 168071168 06:18:21 INFO - PROCESS | 25889 | 06:18:23 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38962/tests/kraken/driver.html?testName=audio-dft) 06:18:24 INFO - PROCESS | 25889 | RSS: Main: 172040192 06:18:24 INFO - PROCESS | 25889 | 06:18:27 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38962/tests/kraken/driver.html?testName=audio-fft) 06:18:28 INFO - PROCESS | 25889 | RSS: Main: 163192832 06:18:28 INFO - PROCESS | 25889 | 06:18:30 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38962/tests/kraken/driver.html?testName=audio-oscillator) 06:18:30 INFO - PROCESS | 25889 | RSS: Main: 164179968 06:18:30 INFO - PROCESS | 25889 | 06:18:33 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:33 INFO - PROCESS | 25889 | RSS: Main: 164859904 06:18:33 INFO - PROCESS | 25889 | 06:18:37 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38962/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:37 INFO - PROCESS | 25889 | RSS: Main: 165203968 06:18:37 INFO - PROCESS | 25889 | 06:18:41 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38962/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:41 INFO - PROCESS | 25889 | RSS: Main: 164454400 06:18:41 INFO - PROCESS | 25889 | 06:18:44 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38962/tests/kraken/driver.html?testName=json-parse-financial) 06:18:45 INFO - PROCESS | 25889 | RSS: Main: 165339136 06:18:45 INFO - PROCESS | 25889 | 06:18:47 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:47 INFO - PROCESS | 25889 | RSS: Main: 165576704 06:18:47 INFO - PROCESS | 25889 | 06:18:49 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:50 INFO - PROCESS | 25889 | RSS: Main: 165408768 06:18:50 INFO - PROCESS | 25889 | 06:18:52 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:53 INFO - PROCESS | 25889 | RSS: Main: 166244352 06:18:53 INFO - PROCESS | 25889 | 06:18:55 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:56 INFO - PROCESS | 25889 | RSS: Main: 166907904 06:18:56 INFO - PROCESS | 25889 | 06:18:59 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:00 INFO - PROCESS | 25889 | RSS: Main: 166408192 06:19:00 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | Cycle 1(1): loaded http://localhost:38962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38962/tests/kraken/driver.html?testName=ai-astar) 06:19:02 INFO - PROCESS | 25889 | RSS: Main: 167981056 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | __start_tp_report 06:19:02 INFO - PROCESS | 25889 | _x_x_mozilla_page_load 06:19:02 INFO - PROCESS | 25889 | _x_x_mozilla_page_load_details 06:19:02 INFO - PROCESS | 25889 | |i|pagename|runs| 06:19:02 INFO - PROCESS | 25889 | |0;ai-astar;113;113;115;115;115;125;115;114;113;115 06:19:02 INFO - PROCESS | 25889 | |1;audio-beat-detection;159;133;159;185;135;166;166;137;190;135 06:19:02 INFO - PROCESS | 25889 | |2;audio-dft;162;164;164;167;166;164;162;163;166;165 06:19:02 INFO - PROCESS | 25889 | |3;audio-fft;76;74;77;178;76;74;73;78;157;77 06:19:02 INFO - PROCESS | 25889 | |4;audio-oscillator;95;94;149;94;95;95;152;93;94;142 06:19:02 INFO - PROCESS | 25889 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;118;117 06:19:02 INFO - PROCESS | 25889 | |6;imaging-darkroom;148;147;147;149;147;149;149;152;149;150 06:19:02 INFO - PROCESS | 25889 | |7;imaging-desaturate;95;95;95;95;95;97;96;96;95;96 06:19:02 INFO - PROCESS | 25889 | |8;json-parse-financial;64;66;68;64;66;64;66;67;65;66 06:19:02 INFO - PROCESS | 25889 | |9;json-stringify-tinderbox;65;65;63;64;65;64;64;66;64;65 06:19:02 INFO - PROCESS | 25889 | |10;stanford-crypto-aes;79;79;80;88;79;81;81;81;109;81 06:19:02 INFO - PROCESS | 25889 | |11;stanford-crypto-ccm;148;138;141;140;136;138;138;145;137;138 06:19:02 INFO - PROCESS | 25889 | |12;stanford-crypto-pbkdf2;180;183;186;190;185;178;184;177;184;183 06:19:02 INFO - PROCESS | 25889 | |13;stanford-crypto-sha256-iterative;83;83;72;75;82;72;74;73;77;75 06:19:02 INFO - PROCESS | 25889 | __end_tp_report 06:19:02 INFO - PROCESS | 25889 | __start_cc_report 06:19:02 INFO - PROCESS | 25889 | _x_x_mozilla_cycle_collect,908 06:19:02 INFO - PROCESS | 25889 | __end_cc_report 06:19:02 INFO - PROCESS | 25889 | __startTimestamp1461244742257__endTimestamp 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | ------- Summary: start ------- 06:19:02 INFO - PROCESS | 25889 | Number of tests: 14 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:3.53 (3.1%) stddev-sans-first:3.64 06:19:02 INFO - PROCESS | 25889 | Values: 113.0 113.0 115.0 115.0 115.0 125.0 115.0 114.0 113.0 115.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:162.50 stddev:21.04 (12.9%) stddev-sans-first:22.30 06:19:02 INFO - PROCESS | 25889 | Values: 159.0 133.0 159.0 185.0 135.0 166.0 166.0 137.0 190.0 135.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.70 (1.0%) stddev-sans-first:1.59 06:19:02 INFO - PROCESS | 25889 | Values: 162.0 164.0 164.0 167.0 166.0 164.0 162.0 163.0 166.0 165.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:39.08 (51.4%) stddev-sans-first:40.91 06:19:02 INFO - PROCESS | 25889 | Values: 76.0 74.0 77.0 178.0 76.0 74.0 73.0 78.0 157.0 77.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:94.00 stddev:25.91 (27.6%) stddev-sans-first:26.88 06:19:02 INFO - PROCESS | 25889 | Values: 95.0 94.0 149.0 94.0 95.0 95.0 152.0 93.0 94.0 142.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:19:02 INFO - PROCESS | 25889 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.57 (1.1%) stddev-sans-first:1.64 06:19:02 INFO - PROCESS | 25889 | Values: 148.0 147.0 147.0 149.0 147.0 149.0 149.0 152.0 149.0 150.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:19:02 INFO - PROCESS | 25889 | Values: 95.0 95.0 95.0 95.0 95.0 97.0 96.0 96.0 95.0 96.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:1.35 (2.0%) stddev-sans-first:1.30 06:19:02 INFO - PROCESS | 25889 | Values: 64.0 66.0 68.0 64.0 66.0 64.0 66.0 67.0 65.0 66.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 06:19:02 INFO - PROCESS | 25889 | Values: 65.0 65.0 63.0 64.0 65.0 64.0 64.0 66.0 64.0 65.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:9.24 (11.4%) stddev-sans-first:9.63 06:19:02 INFO - PROCESS | 25889 | Values: 79.0 79.0 80.0 88.0 79.0 81.0 81.0 81.0 109.0 81.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:139.00 stddev:3.81 (2.7%) stddev-sans-first:2.69 06:19:02 INFO - PROCESS | 25889 | Values: 148.0 138.0 141.0 140.0 136.0 138.0 138.0 145.0 137.0 138.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:184.00 stddev:3.86 (2.1%) stddev-sans-first:3.94 06:19:02 INFO - PROCESS | 25889 | Values: 180.0 183.0 186.0 190.0 185.0 178.0 184.0 177.0 184.0 183.0 06:19:02 INFO - PROCESS | 25889 | 06:19:02 INFO - PROCESS | 25889 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:76.00 stddev:4.45 (5.9%) stddev-sans-first:4.08 06:19:02 INFO - PROCESS | 25889 | Values: 83.0 83.0 72.0 75.0 82.0 72.0 74.0 73.0 77.0 75.0 06:19:02 INFO - PROCESS | 25889 | -------- Summary: end -------- 06:19:02 INFO - PROCESS | 25889 | 06:19:03 INFO - TEST-INFO | 25889: exit 0 06:19:03 INFO - TEST-OK | kraken | took 64389ms 06:19:03 INFO - SUITE-END | took 1180s 06:19:03 INFO - Completed test suite (00:19:40) 06:19:03 INFO - javascript benchmark 06:19:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.7284985076567, 2645.6692913385828, 2651.986740066302, 2707.12018593957, 2708.5666293393047, 4662.090892276007, 4680.836170734025, 4703.623710103192, 4719.69321994071, 4732.337472753818, 4582.839600613979, 4725.480197178307, 4735.952640473594, 4788.114198873211, 4805.687630304028, 4322.7190232634775, 4327.978360108195, 4428.689991700582, 4432.601065904068, 4434.733915965036, 4399.2521271383785, 4436.889077773066, 4444.022315090675, 4446.1107778444275, 4480.19356515827, 4274.221755858701, 4299.505556860939, 4303.483581970184, 4310.374995625617, 4373.759443230621, 4349.173657005159, 4364.214441400547, 4365.061511774984, 4415.580519850609, 4424.889377765581, 4330.675199360061, 4337.414449049369, 4346.521882592912, 4349.043210493686, 4393.253146964992, 4601.792919318638, 4633.235516139833, 4667.486576476619, 4670.0, 4699.412573428322, 5028.371453568304, 5032.547070763612, 5046.343975283226, 5052.368453943257, 5112.079825631385, 4917.680350777224, 5066.746662666888, 5090.796368145269, 5126.615503837227, 5148.6910785353, 4769.189237829577, 4770.308305295713, 4788.233882578806, 4801.207800712913, 4818.229083346648, 5196.714180720021, 5226.216067589892, 5228.816991405359, 5238.60710446718, 5243.0, 4805.975970120127, 4992.450830408652, 5049.065922804293, 5050.217216331474, 5050.292958985745, 4898.583620392235, 5013.298138260647, 5032.974835125801, 5060.898782024413, 5111.3355263815465, 5012.323336349619, 5040.1179793535985, 5058.013687331008, 5060.266261392151, 5101.591872650179, 4910.459849416561, 4923.261510773341, 4945.381827271591, 5025.79896804131, 5091.9236211456855, 4153.1486045360625, 4170.812313445902, 4181.540030596632, 4200.831966721358, 4207.558206388347, 3692.9446058309145, 3709.888703338904, 3739.7382183247455, 3747.3254814133174, 3751.737378383487, 4415.779211039435, 4453.087117140978, 4459.44256967879, 4490.977545112319, 4495.527969563149, 5135.717535535507, 5158.174692049329, 5166.896662066738, 5200.739963001834, 5242.1088414969545, 4291.420658211102, 4464.665150113755, 4535.7732113394195, 4537.047220083753, 4585.082983403333, 4563.475200352002, 4577.725336479822, 4598.218302888517, 4611.953880461219, 4640.559146881041, 4826.806927722922, 4832.057748738962, 4842.612590992641, 4843.95156048435, 4865.683730557503, 4865.416150062015, 5013.674111182761, 5068.163752980717, 5072.391313042459, 5123.590112790893, 4857.684250523705, 4858.4898585648, 4871.123197824426, 4889.559939605452, 4892.168331383745, 5051.599406868808, 5072.619553533426, 5073.720945348041, 5080.136376815876, 5114.386273647037, 4927.063857866994, 5083.771230294572, 5114.105031619526, 5127.717975511383, 5198.9740051299505, 4784.330193772944, 4907.484714104968, 4914.459409464885, 4972.900541989067, 4991.775370108281, 4825.420949486084, 4828.5412885775795, 4841.612670986383, 4844.079624871263, 4844.733539655353, 4766.880827979328, 4790.065937142223, 4803.471618121934, 4848.757562121809, 4903.877403064952, 4894.33926419943, 4968.22992436173, 4971.825986090469, 4976.925346119739, 5000.424951130521, 4798.760061996816, 4818.373611430632, 4868.537488938545, 4896.82861099874, 4902.63230257725], "value": 4658.13525892509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5749970772767, 584.1092334190362, 587.5740088435884, 604.9667268300243, 623.5323507369473, 33129.83435082824, 34118.829405853, 34193.82903085481, 34204.144896377606, 34236.82881585595, 35663.0, 36267.0, 36424.63575364252, 36444.0, 36544.269114617695, 7609.999999999986, 7731.613419329011, 7756.806079847993, 7764.844703105934, 7778.222177782233, 7587.241275872424, 7683.346915512188, 7692.384609231248, 7699.499532530395, 7707.0, 7654.158042615308, 7712.57580833054, 7720.575368354738, 7730.18833022533, 7732.226777322251, 7591.0, 7624.580648064354, 7684.231576842327, 7705.961470192669, 7709.3061624453785, 7653.885191722128, 7736.9613151934445, 7791.805204869924, 7794.3764498839955, 7810.414218933603, 34283.0, 34871.30257394838, 34876.651233487595, 34972.825135874155, 35005.299894001975, 3114.112477943775, 3264.853081611333, 3313.933721325584, 3375.05498460429, 3511.5961664408665, 27385.589216161774, 27562.173134805988, 27660.861695691394, 28014.159575212776, 28075.29811754702, 3477.8434970426392, 3485.128717820545, 3528.5942116656656, 3528.964710352889, 3539.380608393521, 216762.0, 217024.0, 217378.0, 217485.0, 217962.0, 32606.836965815495, 50089.74955125201, 50283.74858125759, 50390.96872250211, 50396.49603503991, 31680.36639267202, 31690.366192676018, 31740.523892141635, 31799.364012719616, 31832.204194895312, 12414.068944829174, 12559.497620095093, 12640.367981600883, 12669.366531673379, 12734.172278801849, 10260.230482713827, 10299.639512617023, 10324.380537167794, 10330.0, 10362.585496580052, 7982.201779822088, 8071.23323284287, 8071.434999549975, 8141.267285944294, 8159.143289954469, 3155.763317751178, 3157.952630710541, 3162.3991441626017, 3186.9362612747614, 3200.8879689210767, 871.2246100970142, 878.6529320918202, 888.7733627924838, 979.5836769372988, 1006.2151521812998, 27395.863020685167, 27657.308567285578, 28179.154625361272, 28515.287117821805, 28566.42867142687, 950.8858936927613, 1007.8387458006683, 1035.171862509989, 1077.9730506737394, 1079.4926384599225, 13172.0, 13563.597362357903, 13613.319334033258, 13909.79135312971, 14154.292285385896, 337284.0, 343086.0, 344833.0, 345146.0, 345743.0, 42939.570604293556, 43361.783191084476, 43368.0, 43627.34558981618, 43824.780876095414, 1202.77352332393, 1209.673388185185, 1221.407617305606, 1224.9816252756216, 1235.3946566182685, 25139.120130795334, 26193.4761304769, 26492.205233843015, 26634.200973970812, 26667.0, 39329.0, 39861.20277594374, 40293.0, 40378.0, 40553.391699123946, 253437.0, 254602.0, 255108.0, 256447.0, 256636.0, 24435.87782061078, 37716.81141594274, 38598.6140138595, 38911.6108838908, 39458.0, 35378.82310588431, 36378.4543231857, 36531.0, 36768.08079798026, 36935.63064369322, 32876.0, 32953.505697414075, 34233.48649770305, 34440.65559344374, 34578.48132278068, 33131.33737325192, 33237.833810830794, 34255.31489370248, 34371.656283436845, 34719.305613888086, 34560.308793824486, 34781.13047173739, 35085.47371789476, 37674.62325376821, 39042.609573903894, 29368.26579335534, 30446.695533044385, 30921.072367829, 30933.0720078398, 31116.0, 24087.486019634645, 24277.878610606833, 24535.63196552089, 25015.374615634755, 25040.37399065038], "value": 15890.740596465941, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7567717467884, 368.1110119062464, 372.8247723569922, 375.3974870333115, 377.8337531486144, 14908.0, 15621.297041633125, 16735.748963765553, 16821.327146914125, 16883.155842207903, 15101.6979660407, 15732.213389330545, 16395.508134755946, 16436.424725134624, 16510.0, 4991.550760431561, 5127.359080114986, 5206.297149884755, 5216.191490319006, 5239.5546378557865, 3654.506641603376, 5010.5240002199735, 5503.147012213093, 6033.758649654031, 6040.154378387029, 5971.790987315445, 5978.52171826255, 5982.341942386334, 5998.52011839054, 6002.549808764338, 5777.768889244425, 5842.152887831262, 5967.015442452033, 5970.373110823344, 5971.775785963889, 5043.798248070073, 5162.74186290684, 5165.173572228463, 5169.896602067975, 5189.195674670432, 18681.0, 18880.244790208377, 19107.61784764311, 19120.80879191204, 19914.701279480818, 1873.5878106816615, 1906.9904650476658, 1930.4112245765036, 2022.5449273913398, 2337.357226762637, 12406.25562466255, 13100.672483187902, 13673.589792306248, 13702.177869327872, 14337.78493322601, 1785.9107044647847, 1812.2116879157609, 1846.0585101598147, 1856.4523465577688, 1942.359021522894, 71009.64495177542, 74051.0, 74992.87567681116, 75084.85336239278, 75264.24735752682, 15695.607609809846, 15847.207639617973, 16088.356465741239, 16142.192890355434, 16164.515064548083, 28016.0, 28088.157355279374, 28138.85930570334, 28322.291942701184, 28456.857715711703, 8627.6980305689, 8700.216980471789, 8706.1729135732, 8910.955445222862, 8951.32865035125, 7229.710811567584, 7240.384567311838, 7246.963765181245, 7300.853982920312, 7369.299916507923, 8154.347652187929, 8311.709090181814, 8359.164083591591, 8398.538080405515, 8406.411551191359, 1796.5418818201535, 1876.1371658099451, 1932.6424611446928, 1940.3014914630721, 3050.283183451887, 872.6596627315353, 909.6134142989204, 948.5636607160645, 960.5341409416427, 991.2466525440573, 15712.0, 15902.0, 15928.92035539815, 16200.189990500428, 16475.423360182336, 877.5392918717597, 891.3715830339595, 897.3852910756153, 910.4673765846921, 948.5636607160783, 8669.739907802776, 8905.064968178249, 8926.285897128215, 9067.682631108011, 9143.314251431037, 381499.0, 390652.0, 393599.0, 393980.0, 395190.0, 72691.27308726845, 72810.2718972814, 74348.62825685945, 74812.25187748161, 75032.62483687655, 921.9032001639865, 922.6678395777515, 929.5956259027209, 941.8163458125737, 965.0831709875646, 14150.504732334319, 14234.14595124296, 14311.141331520143, 14504.709905801614, 14541.781873271697, 32610.51084233786, 32853.835730822146, 33299.667003329654, 33767.0, 34097.0, 45126.77436612796, 46002.30996534988, 46229.76885115553, 46274.768626158, 46702.766486167355, 7637.961810190914, 7719.035120609924, 7787.610619468891, 7805.609719514116, 7827.45207835446, 8493.193146651058, 10257.743556410851, 10575.788484230427, 11194.720131996764, 11272.549098035986, 10065.496725163566, 10366.688999330032, 10440.0, 10459.47702614851, 10594.841077383999, 9268.490233037248, 9393.201577865959, 9599.280053996117, 9781.706548803548, 10093.343932644355, 9789.216862650828, 10401.115905147844, 10495.947520262349, 10734.624288149877, 10740.624078157227, 7379.151397589346, 7740.14858365568, 7757.534547927143, 7815.0, 7956.164602716863, 7807.297343239135, 9311.534423278674, 10038.196944244297, 10145.746356341151, 10384.065434110966], "value": 8736.589352948198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.2734082397008, 1419.8580141985801, 1532.5402379286218, 1738.4350086221982, 1739.6433731085112, 6834.760783372583, 7532.322091011808, 7587.544747315165, 7810.492317999326, 7810.765677029691, 7605.353544948686, 7640.694372225118, 7642.235776422369, 7642.885356719654, 7695.769126926187, 2244.9775502244934, 2263.9886800566055, 2265.2071774878827, 2266.0369343029147, 2267.4671452208718, 2200.7249093863265, 2215.0, 2223.2552095048177, 2227.0535022615322, 2238.7985081342676, 2207.9779202207933, 2248.5615305015526, 2251.8423710340285, 2265.8413911026237, 2284.554511870186, 2199.450137465634, 2202.1521714140013, 2205.095910676615, 2208.326460429568, 2209.3924170853065, 2156.2345367394505, 2161.9351419457444, 2167.7723838996994, 2169.5010147666126, 2173.7282839645045, 7741.57421341826, 7788.0, 7816.687332506693, 7860.646270917822, 7867.921320786776, 4355.5208927018, 4518.27707566791, 4524.977375113136, 4570.9943812361225, 4602.815887364502, 2843.5023870822524, 2872.540393537024, 2917.9124626261246, 2941.3970136122043, 2954.9409011819644, 943.4622265308777, 947.0718695678205, 954.494118117392, 962.2494454325637, 984.1437948984429, 10230.335028223142, 10244.692659220309, 10307.94846025765, 10309.07218350352, 10326.0, 4154.480689913761, 4246.639035682002, 4268.274393353137, 4381.605655491021, 4427.822887084545, 8882.911170888337, 8893.777655558662, 8942.73171804847, 8942.955285223663, 8947.776305592412, 4518.186726389282, 4521.84173553924, 4550.203714349976, 4550.294704320836, 4552.11233809404, 3632.582253040934, 4008.0581063450068, 4145.481814773153, 4151.335786274181, 4155.335146376565, 3617.6382361763613, 3654.1778099927305, 3691.593924668284, 3727.7390582658954, 3751.643593858579, 1186.4067966016992, 1212.805951047828, 1219.762146381447, 1222.2177806204036, 1225.6874497003207, 802.2899733735686, 871.1419252036738, 879.9032106468284, 882.3117967984854, 895.7133717210561, 5150.201718733602, 5251.264822924793, 5265.499777521206, 5306.602004849652, 5313.282706834605, 432.84201266537485, 435.5296280017573, 437.1693781814578, 442.23493356493447, 445.39648775908177, 3839.6352346527037, 3927.7446965947693, 3953.367461206193, 3991.401289806552, 4003.7797921114034, 9198.356115072014, 9475.289353298393, 9505.952470237742, 9587.328886977844, 9590.08894155054, 8757.56212189388, 9333.20667743236, 9386.624535018524, 9408.247340212767, 9429.575669094907, 6988.825279367955, 7043.823904402431, 7089.042979197742, 7132.572045677172, 7165.498415110892, 5416.9729151353995, 5562.388137304974, 5619.353774315842, 5633.887322253614, 5638.60529762929, 8160.877586836321, 8378.49729016261, 8438.240558349778, 8484.236418722345, 8510.191531804468, 8351.24838764514, 8384.413091083565, 8618.827623447622, 8786.736397908073, 8787.428817126865, 6164.691765411621, 6385.616862988236, 6569.178852643419, 6641.236257830218, 6742.86514269702, 7105.360517553445, 7205.423566114593, 7234.782956511102, 7242.529235599669, 7243.492955493065, 6418.0, 6726.966365168143, 6855.177378714387, 6934.8613027740175, 7015.824604384931, 6635.933640663531, 6702.396784289437, 6823.147106611674, 6891.517593768388, 6898.344657257552, 6323.683815809283, 6440.29156792743, 6499.870002600016, 6512.348765123639, 6516.380943810331, 4726.71639701619, 4831.468538460696, 4888.9755551222015, 4889.805451338045, 4936.481669424658, 4837.4920633332995, 4869.683470574401, 4903.313536104877, 4916.0, 4961.900761984668], "value": 4084.6568069131877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5129541438284, 309.7908911484749, 310.33742958783, 316.93661267746455, 319.8880391862847, 5357.08929481988, 5393.379761327448, 5402.6758394496355, 5410.648307859987, 5413.377461591913, 5311.7344132793305, 5330.227117068022, 5346.385165705945, 5347.679139251648, 5348.598855085875, 3935.232629637222, 3943.507061617298, 4085.673146148301, 4098.610631989971, 4099.836006559749, 4075.8369665213354, 4078.9796051019703, 4088.121053973395, 4089.427480152781, 4104.794760261975, 3997.2605068062358, 4038.1519880825063, 4038.9394159087637, 4043.575424580421, 4065.471488706479, 3792.355299599075, 4001.199760048002, 4025.7181997260204, 4080.8163632636456, 4081.857135000276, 3403.5745531808525, 3439.5356626855305, 3441.0, 3452.498163298973, 3454.3436747017986, 5087.56755675768, 5092.541671249605, 5092.949070509321, 5095.821646242401, 5122.231665250205, 4536.637069034469, 4599.586037256663, 4601.654875884322, 4603.884902877455, 4608.746518941457, 5622.775088996435, 5625.128105143668, 5627.2684551008515, 5653.236813030229, 5658.0381335173115, 3976.5029371328583, 3978.661813745835, 3993.221321842242, 3999.280129576675, 4001.0597509585223, 5821.7380217890295, 5846.152307915371, 5864.589478736448, 5894.58737888348, 5911.822645320647, 4099.61053699898, 4122.196171746541, 4122.814473348706, 4128.1330920506425, 4130.442390277274, 4085.9591404085577, 4152.688548358885, 4184.456020717348, 4186.6859985501205, 4194.182134483746, 4632.374629424984, 4725.149473094807, 4732.645051621143, 4743.193657078305, 4776.116418462526, 5623.831285061455, 5635.267415236075, 5640.8871822563315, 5649.293838270216, 5672.4611161940375, 1432.5773896700498, 1453.9709205816037, 1459.306829256095, 1463.758479850834, 1464.436192066041, 911.544227886057, 951.8477043672979, 964.1756298364937, 984.8378912882724, 1010.9545070471846, 4904.204603376042, 4917.877053073702, 4924.729139897268, 4954.578860796801, 4966.5281798229835, 5748.080307150919, 5753.367129615739, 5757.510611597977, 5759.798407055733, 5769.769209231667, 4738.336632871401, 4943.110240156734, 4950.158473059589, 4956.5786908112495, 4969.130402179604, 3098.3338582204933, 3117.7817552771544, 3127.749780017593, 3131.467650499375, 3140.7487401007866, 5485.753141108659, 5534.0, 5544.390117087117, 5573.665580065209, 5591.105423132361, 5813.82558523245, 5953.583249172603, 5998.550108741862, 6017.939820601738, 6033.099573634291, 5504.669719816824, 5506.03644362243, 5509.752061157257, 5522.30971128609, 5541.861453463695, 5573.526250268773, 5764.394738552392, 5795.478406943395, 5816.1857339973285, 5853.970730146322, 5684.687342196054, 5687.118496633028, 5695.174199740932, 5722.284714410699, 5725.456081672234, 5425.240466334637, 5499.560035197254, 5500.0, 5519.2824932758485, 5531.2532808072, 3899.3566061599518, 3970.7021973352694, 3984.143409167043, 3997.9000524985945, 4000.7199496035, 5764.13537969308, 5778.682172480554, 5780.653160810365, 5787.131930210502, 5825.883482330414, 5629.0712032514175, 5630.296212973379, 5631.971840140773, 5640.5769567281795, 5644.407337229696, 5428.647137936022, 5570.498655121059, 5615.803446879339, 5643.88712225745, 5663.32040155184, 5242.842714718565, 5549.472800083986, 5565.471280228372, 5571.860703482445, 5576.741419725018, 5447.774250793698, 5631.577631677558, 5640.802571909963, 5662.292213473316, 5726.226959360433, 5527.2538207343105, 5531.197976293495, 5539.861503462445, 5546.4453554644215, 5552.916706249491], "value": 4206.864036382442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7652436433794, 715.0204220218302, 725.4957804325995, 787.933025692816, 803.2810634482137, 10917.563297468092, 11902.16684832061, 12068.69828254293, 12069.155159138852, 12629.621111366674, 14125.576232713009, 14206.076605020666, 14256.358463869125, 14258.50095246664, 14272.072315299498, 624.8156793745833, 794.7099308752307, 805.122416565943, 805.6495424490336, 805.7542449552884, 787.9842403151933, 814.861473549495, 816.0574536410455, 820.0978923184479, 821.1747194069951, 843.4601854812894, 846.9872951905726, 847.4406891451644, 848.240824462106, 848.7241646464893, 832.8792325112855, 833.0212000898949, 840.260570697782, 841.066416277931, 842.1452225990563, 619.3899009475663, 619.6653806944245, 620.5687047501988, 620.5966122020723, 623.2863371439677, 11853.525858965631, 11959.342236177006, 12006.939965300118, 12016.69958251042, 12018.879811201863, 12503.187292826027, 12516.499340026388, 12567.874321256762, 12695.450871608538, 12914.031447641464, 10051.849222261671, 10303.587856485732, 10394.792104157874, 10587.15302775776, 10673.35959842412, 3334.3498017886523, 3375.2405708715587, 3381.1040074380307, 3421.6920477156928, 3455.1189446691183, 44568.77715611434, 44722.0, 45086.54913450856, 45890.999999999665, 46122.53877461216, 9756.560954757053, 9953.353032053039, 10053.497325133714, 10068.446235456973, 10070.395776253301, 17068.146592670317, 17072.829271707124, 17157.056361900217, 17236.396726114526, 17253.482395528154, 6616.27221005689, 6677.76627818024, 6744.831379215559, 6822.795316140524, 6874.415674667609, 3928.332183528807, 3968.9603103969166, 3983.9203215935518, 4000.7999600019884, 4037.7577345358786, 2972.7175918287726, 3004.6544647365395, 3011.4428830666398, 3032.1964679359985, 3034.2717747740385, 504.1907738080328, 509.1217649554489, 529.4493726524448, 531.5747402078322, 538.9083855744533, 605.1769593353036, 628.3936001758234, 647.1263793878321, 651.947844172465, 655.9606423614598, 7570.94006839043, 7847.764567062997, 7955.562444065632, 7975.800604984922, 8050.919490805017, 519.8466452396552, 555.2393221286782, 635.0093853588417, 637.4740838808002, 645.6643637971047, 3736.9898402762146, 3845.2693988142164, 3880.2239552089695, 3882.8446862125197, 3902.1610353774076, 54277.1858422124, 54518.0, 54709.72645136749, 55069.173962390596, 55233.447665523636, 45042.0, 45494.0, 45791.313130303075, 47036.7648161757, 48048.27927581089, 42432.15135697269, 43534.12931741348, 44272.0, 44391.0, 44560.0, 6981.301869813181, 7302.622786915074, 7360.0, 7395.593242371721, 7494.5128566643, 24621.50756984886, 24823.007079716608, 25589.744102558736, 26132.34669133287, 29157.271068223465, 33874.66125338715, 34167.4874876882, 34290.82854585811, 34727.4790878132, 35203.0, 10649.306796964867, 10949.178811589321, 11034.889651103707, 11053.171012173958, 11082.889171108185, 11531.192816502764, 11563.826542601699, 11751.823722643996, 11794.46924888365, 11998.160128790902, 11102.333859968428, 11512.712182195512, 11582.131340149692, 11638.476268568103, 11743.17797754149, 10781.568737250736, 11166.553337866395, 11369.943150284527, 11620.128490363088, 11680.883191167979, 10832.729181770519, 11046.779064418506, 11189.552417903193, 11282.43587820622, 11493.712657183638, 9093.704129805223, 9209.493477858781, 9353.438793672402, 9445.952770236105, 9456.196223321094, 8512.70205542803, 8793.3785400876, 9093.454392736458, 9175.587098580447, 9192.954035230048], "value": 5959.687198932892, "unit": "score"}], "name": "dromaeo_css", "value": 6360.820163507591, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 115.0, 115.0, 125.0, 115.0, 114.0, 113.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 133.0, 159.0, 185.0, 135.0, 166.0, 166.0, 137.0, 190.0, 135.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 167.0, 166.0, 164.0, 162.0, 163.0, 166.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 178.0, 76.0, 74.0, 73.0, 78.0, 157.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 149.0, 94.0, 95.0, 95.0, 152.0, 93.0, 94.0, 142.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 149.0, 147.0, 149.0, 149.0, 152.0, 149.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 68.0, 64.0, 66.0, 64.0, 66.0, 67.0, 65.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 88.0, 79.0, 81.0, 81.0, 81.0, 109.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 138.0, 141.0, 140.0, 136.0, 138.0, 138.0, 145.0, 137.0, 138.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 186.0, 190.0, 185.0, 178.0, 184.0, 177.0, 184.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 72.0, 75.0, 82.0, 72.0, 74.0, 73.0, 77.0, 75.0], "value": 76.6, "unit": "score"}], "name": "kraken", "value": 1615.6999999999998, "alertThreshold": 2.0}]} 06:19:03 INFO - Return code: 0 06:19:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:19:03 ERROR - # TBPL SUCCESS # 06:19:03 INFO - Running post-action listener: _resource_record_post_action 06:19:03 INFO - Running post-run listener: _resource_record_post_run 06:19:04 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518209536; Read time: 28; Write time: 844768 06:19:04 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 234360832; Read time: 0; Write time: 482596 06:19:04 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283848704; Read time: 28; Write time: 362172 06:19:04 INFO - Running post-run listener: _upload_blobber_files 06:19:04 INFO - Blob upload gear active. 06:19:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:04 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 06:19:04 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:04 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:05 INFO - (blobuploader) - INFO - Done attempting. 06:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:06 INFO - (blobuploader) - INFO - Done attempting. 06:19:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:06 INFO - Return code: 0 06:19:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbdd8fc54fd22321c4d554b3af950a2706ec04d98ee4ba40e558e3abe8e82f58d4caee7ece3b0b90a0cbdcff523df9528e5a7168d40d19b31b4bd574fcae2448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/995d1ee64091ae62f25e46270711ac6e57831b9d2622cba98fd20614889983ee8560e061e0422d180a1472eed8d85e2baea4209772bbfc21100e669a4ecf995a"} 06:19:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:06 INFO - Contents: 06:19:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbdd8fc54fd22321c4d554b3af950a2706ec04d98ee4ba40e558e3abe8e82f58d4caee7ece3b0b90a0cbdcff523df9528e5a7168d40d19b31b4bd574fcae2448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/995d1ee64091ae62f25e46270711ac6e57831b9d2622cba98fd20614889983ee8560e061e0422d180a1472eed8d85e2baea4209772bbfc21100e669a4ecf995a"} 06:19:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:06 INFO - Copying logs to upload dir... 06:19:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.399508 ========= master_lag: 328.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 15 secs) (at 2016-04-21 06:24:35.274237) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:24:35.278410) ========= 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=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbdd8fc54fd22321c4d554b3af950a2706ec04d98ee4ba40e558e3abe8e82f58d4caee7ece3b0b90a0cbdcff523df9528e5a7168d40d19b31b4bd574fcae2448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/995d1ee64091ae62f25e46270711ac6e57831b9d2622cba98fd20614889983ee8560e061e0422d180a1472eed8d85e2baea4209772bbfc21100e669a4ecf995a"} build_url:https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/NC8Ae84DRuSphwVKDaw5dg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbdd8fc54fd22321c4d554b3af950a2706ec04d98ee4ba40e558e3abe8e82f58d4caee7ece3b0b90a0cbdcff523df9528e5a7168d40d19b31b4bd574fcae2448", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/995d1ee64091ae62f25e46270711ac6e57831b9d2622cba98fd20614889983ee8560e061e0422d180a1472eed8d85e2baea4209772bbfc21100e669a4ecf995a"}' ========= master_lag: 0.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 06:24:35.871860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:24:35.873678) ========= 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=aa52b8aba932b19cc50b5275000001de-1461243330.992722-60855564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 06:24:36.039097) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-21 06:24:36.039407) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-04-21 06:24:40.412466) ========= ========= Total master_lag: 329.60 =========