builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1461320689.51 results: success (0) buildid: 20160422004039 builduid: 7509c782a3eb4759a4d442890646c0cb revision: a704f4cf969cf5925e9cddae92a59ff502501f8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.506493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.507015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.507313) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.521218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.521559) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 03:24:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.7M=0s 2016-04-22 03:24:49 (81.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.627962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.628321) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013319 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.678105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:49.678483) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a704f4cf969cf5925e9cddae92a59ff502501f8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a704f4cf969cf5925e9cddae92a59ff502501f8f --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=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 03:24:49,804 truncating revision to first 12 chars 2016-04-22 03:24:49,804 Setting DEBUG logging. 2016-04-22 03:24:49,804 attempt 1/10 2016-04-22 03:24:49,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a704f4cf969c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 03:24:50,079 unpacking tar archive at: mozilla-aurora-a704f4cf969c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:50.278878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:50.279216) ========= script_repo_revision: a704f4cf969cf5925e9cddae92a59ff502501f8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:50.279613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:50.279879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 03:24:50.288246) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-22 03:24:50.288579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:50 INFO - MultiFileLogger online at 20160422 03:24:50 in /builds/slave/test 03:24:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:24:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:50 INFO - {'append_to_log': False, 03:24:50 INFO - 'base_work_dir': '/builds/slave/test', 03:24:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:50 INFO - 'branch': 'Mozilla-Aurora', 03:24:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:50 INFO - 'config_files': ('talos/linux_config.py',), 03:24:50 INFO - 'default_actions': ('clobber', 03:24:50 INFO - 'read-buildbot-config', 03:24:50 INFO - 'download-and-extract', 03:24:50 INFO - 'populate-webroot', 03:24:50 INFO - 'create-virtualenv', 03:24:50 INFO - 'install', 03:24:50 INFO - 'run-tests'), 03:24:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:50 INFO - 'download_minidump_stackwalk': True, 03:24:50 INFO - 'download_symbols': 'ondemand', 03:24:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:50 INFO - 'installer_path': 'installer.exe', 03:24:50 INFO - 'log_level': 'info', 03:24:50 INFO - 'log_name': 'talos', 03:24:50 INFO - 'log_to_console': True, 03:24:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:50 INFO - 'opt_config_files': (), 03:24:50 INFO - 'pip_index': False, 03:24:50 INFO - 'sps_profile': False, 03:24:50 INFO - 'sps_profile_interval': 0, 03:24:50 INFO - 'suite': 'dromaeojs-e10s', 03:24:50 INFO - 'system_bits': '32', 03:24:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:50 INFO - 'title': 'talos-linux64-ix-064', 03:24:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:50 INFO - 'use_talos_json': True, 03:24:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:50 INFO - 'work_dir': 'build'} 03:24:50 INFO - ##### 03:24:50 INFO - ##### Running clobber step. 03:24:50 INFO - ##### 03:24:50 INFO - Running pre-action listener: _resource_record_pre_action 03:24:50 INFO - Running main action method: clobber 03:24:50 INFO - rmtree: /builds/slave/test/build 03:24:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:51 INFO - Running post-action listener: _resource_record_post_action 03:24:51 INFO - ##### 03:24:51 INFO - ##### Running read-buildbot-config step. 03:24:51 INFO - ##### 03:24:51 INFO - Running pre-action listener: _resource_record_pre_action 03:24:51 INFO - Running main action method: read_buildbot_config 03:24:51 INFO - Using buildbot properties: 03:24:51 INFO - { 03:24:51 INFO - "project": "", 03:24:51 INFO - "product": "firefox", 03:24:51 INFO - "script_repo_revision": "production", 03:24:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:24:51 INFO - "repository": "", 03:24:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:24:51 INFO - "buildid": "20160422004039", 03:24:51 INFO - "stage_platform": "linux64-pgo", 03:24:51 INFO - "basedir": "/builds/slave/test", 03:24:51 INFO - "nightly_build": "True", 03:24:51 INFO - "buildnumber": 230, 03:24:51 INFO - "slavename": "talos-linux64-ix-064", 03:24:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:24:51 INFO - "platform": "ubuntu64_hw", 03:24:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:24:51 INFO - "branch": "mozilla-aurora", 03:24:51 INFO - "repo_path": "releases/mozilla-aurora", 03:24:51 INFO - "revision": "a704f4cf969cf5925e9cddae92a59ff502501f8f", 03:24:51 INFO - "pgo_build": "True", 03:24:51 INFO - "builduid": "7509c782a3eb4759a4d442890646c0cb", 03:24:51 INFO - "slavebuilddir": "test" 03:24:51 INFO - } 03:24:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:24:51 INFO - Running post-action listener: _resource_record_post_action 03:24:51 INFO - ##### 03:24:51 INFO - ##### Running download-and-extract step. 03:24:51 INFO - ##### 03:24:51 INFO - Running pre-action listener: _resource_record_pre_action 03:24:51 INFO - Running main action method: download_and_extract 03:24:51 INFO - mkdir: /builds/slave/test/build/tests 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:51 INFO - https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:24:52 INFO - Downloaded 1448 bytes. 03:24:52 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:52 INFO - Using the following test package requirements: 03:24:52 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:24:52 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:24:52 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:24:52 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'jsshell-linux-x86_64.zip'], 03:24:52 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:24:52 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:24:52 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:24:52 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:24:52 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:24:52 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:24:52 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:24:52 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:24:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:24: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')]} 03:24:52 INFO - https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:53 INFO - Downloaded 23356524 bytes. 03:24:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:54 INFO - Return code: 0 03:24:54 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:54 INFO - https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:24:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:24:55 INFO - Downloaded 23356524 bytes. 03:24:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:24:57 INFO - Return code: 0 03:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:57 INFO - https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:24:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:24:58 INFO - Downloaded 10845198 bytes. 03:24:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:24:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:24:58 INFO - Return code: 0 03:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:58 INFO - https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:24:59 INFO - Downloaded 60821742 bytes. 03:24:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:24:59 INFO - mkdir: /builds/slave/test/properties 03:24:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:59 INFO - Contents: 03:24:59 INFO - build_url:https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:01 INFO - Running post-action listener: _resource_record_post_action 03:25:01 INFO - Running post-action listener: set_extra_try_arguments 03:25:01 INFO - ##### 03:25:01 INFO - ##### Running populate-webroot step. 03:25:01 INFO - ##### 03:25:01 INFO - Running pre-action listener: _resource_record_pre_action 03:25:01 INFO - Running main action method: populate_webroot 03:25:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:01 INFO - '--tppagecycles', 03:25:01 INFO - '7'], 03:25:01 INFO - 'tests': ['tsvgm']}}, 03:25:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:25:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:25:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'tests': ['damp', 'tps']}, 03:25:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['damp', 'tps']}, 03:25:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:25:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:01 INFO - 'other': {'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'other_l64': {'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'other_nol64': {'tests': ['a11yr', 03:25:01 INFO - 'ts_paint', 03:25:01 INFO - 'tpaint', 03:25:01 INFO - 'sessionrestore', 03:25:01 INFO - 'sessionrestore_no_auto_restore', 03:25:01 INFO - 'tabpaint']}, 03:25:01 INFO - 'svgr': {'tests': ['tsvgx', 03:25:01 INFO - 'tsvgr_opacity', 03:25:01 INFO - 'tart', 03:25:01 INFO - 'tscrollx', 03:25:01 INFO - 'cart']}, 03:25:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['tsvgx', 03:25:01 INFO - 'tsvgr_opacity', 03:25:01 INFO - 'tart', 03:25:01 INFO - 'tscrollx', 03:25:01 INFO - 'cart']}, 03:25:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'tests': ['tp5o']}, 03:25:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'talos_options': ['--e10s'], 03:25:01 INFO - 'tests': ['tp5o']}, 03:25:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'talos_options': ['--xperf_path', 03:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:01 INFO - 'tests': ['tp5n']}, 03:25:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:01 INFO - 'talos_options': ['--e10s', 03:25:01 INFO - '--xperf_path', 03:25:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:01 INFO - 'tests': ['tp5n']}}, 03:25:01 INFO - 'talos.zip': {'path': '', 03:25:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:01 INFO - Running post-action listener: _resource_record_post_action 03:25:01 INFO - ##### 03:25:01 INFO - ##### Running create-virtualenv step. 03:25:01 INFO - ##### 03:25:01 INFO - Running pre-action listener: _resource_record_pre_action 03:25:01 INFO - Running main action method: create_virtualenv 03:25:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:01 INFO - Using real prefix '/usr' 03:25:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:03 INFO - Installing pip.................done. 03:25:03 INFO - Return code: 0 03:25:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:03 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:03 INFO - Using env: {'DISPLAY': ':0', 03:25:03 INFO - 'HOME': '/home/cltbld', 03:25:03 INFO - 'LANG': 'en_US.UTF-8', 03:25:03 INFO - 'LANGUAGE': 'en_US:en', 03:25:03 INFO - 'LOGNAME': 'cltbld', 03:25:03 INFO - 'MAIL': '/var/mail/cltbld', 03:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:03 INFO - 'MOZ_NO_REMOTE': '1', 03:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:03 INFO - 'NO_EM_RESTART': '1', 03:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:03 INFO - 'PWD': '/builds/slave/test', 03:25:03 INFO - 'SHELL': '/bin/bash', 03:25:03 INFO - 'SHLVL': '1', 03:25:03 INFO - 'TERM': 'linux', 03:25:03 INFO - 'TMOUT': '86400', 03:25:03 INFO - 'USER': 'cltbld', 03:25:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:03 INFO - '_': '/tools/buildbot/bin/python'} 03:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:03 INFO - Cleaning up... 03:25:03 INFO - Return code: 0 03:25:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:03 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:25:03 INFO - Using env: {'DISPLAY': ':0', 03:25:03 INFO - 'HOME': '/home/cltbld', 03:25:03 INFO - 'LANG': 'en_US.UTF-8', 03:25:03 INFO - 'LANGUAGE': 'en_US:en', 03:25:03 INFO - 'LOGNAME': 'cltbld', 03:25:03 INFO - 'MAIL': '/var/mail/cltbld', 03:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:03 INFO - 'MOZ_NO_REMOTE': '1', 03:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:03 INFO - 'NO_EM_RESTART': '1', 03:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:03 INFO - 'PWD': '/builds/slave/test', 03:25:03 INFO - 'SHELL': '/bin/bash', 03:25:03 INFO - 'SHLVL': '1', 03:25:03 INFO - 'TERM': 'linux', 03:25:03 INFO - 'TMOUT': '86400', 03:25:03 INFO - 'USER': 'cltbld', 03:25:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:03 INFO - '_': '/tools/buildbot/bin/python'} 03:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:04 INFO - Downloading/unpacking psutil>=0.7.1 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:06 INFO - Installing collected packages: psutil 03:25:06 INFO - Running setup.py install for psutil 03:25:06 INFO - building 'psutil._psutil_linux' extension 03:25:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:06 INFO - building 'psutil._psutil_posix' extension 03:25:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:06 INFO - Successfully installed psutil 03:25:06 INFO - Cleaning up... 03:25:06 INFO - Return code: 0 03:25:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:25:06 INFO - Using env: {'DISPLAY': ':0', 03:25:06 INFO - 'HOME': '/home/cltbld', 03:25:06 INFO - 'LANG': 'en_US.UTF-8', 03:25:06 INFO - 'LANGUAGE': 'en_US:en', 03:25:06 INFO - 'LOGNAME': 'cltbld', 03:25:06 INFO - 'MAIL': '/var/mail/cltbld', 03:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:06 INFO - 'MOZ_NO_REMOTE': '1', 03:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:06 INFO - 'NO_EM_RESTART': '1', 03:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:06 INFO - 'PWD': '/builds/slave/test', 03:25:06 INFO - 'SHELL': '/bin/bash', 03:25:06 INFO - 'SHLVL': '1', 03:25:06 INFO - 'TERM': 'linux', 03:25:06 INFO - 'TMOUT': '86400', 03:25:06 INFO - 'USER': 'cltbld', 03:25:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:06 INFO - '_': '/tools/buildbot/bin/python'} 03:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:25:08 INFO - Installing collected packages: mozsystemmonitor 03:25:08 INFO - Running setup.py install for mozsystemmonitor 03:25:08 INFO - Successfully installed mozsystemmonitor 03:25:08 INFO - Cleaning up... 03:25:08 INFO - Return code: 0 03:25:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:08 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:08 INFO - Using env: {'DISPLAY': ':0', 03:25:08 INFO - 'HOME': '/home/cltbld', 03:25:08 INFO - 'LANG': 'en_US.UTF-8', 03:25:08 INFO - 'LANGUAGE': 'en_US:en', 03:25:08 INFO - 'LOGNAME': 'cltbld', 03:25:08 INFO - 'MAIL': '/var/mail/cltbld', 03:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:08 INFO - 'MOZ_NO_REMOTE': '1', 03:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:08 INFO - 'NO_EM_RESTART': '1', 03:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:08 INFO - 'PWD': '/builds/slave/test', 03:25:08 INFO - 'SHELL': '/bin/bash', 03:25:08 INFO - 'SHLVL': '1', 03:25:08 INFO - 'TERM': 'linux', 03:25:08 INFO - 'TMOUT': '86400', 03:25:08 INFO - 'USER': 'cltbld', 03:25:08 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:08 INFO - '_': '/tools/buildbot/bin/python'} 03:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:11 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:11 INFO - Downloading docopt-0.6.1.tar.gz 03:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:11 INFO - Running setup.py install for blobuploader 03:25:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:11 INFO - Running setup.py install for requests 03:25:12 INFO - Running setup.py install for docopt 03:25:12 INFO - Successfully installed blobuploader requests docopt 03:25:12 INFO - Cleaning up... 03:25:12 INFO - Return code: 0 03:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:12 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:12 INFO - Using env: {'DISPLAY': ':0', 03:25:12 INFO - 'HOME': '/home/cltbld', 03:25:12 INFO - 'LANG': 'en_US.UTF-8', 03:25:12 INFO - 'LANGUAGE': 'en_US:en', 03:25:12 INFO - 'LOGNAME': 'cltbld', 03:25:12 INFO - 'MAIL': '/var/mail/cltbld', 03:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:12 INFO - 'MOZ_NO_REMOTE': '1', 03:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:12 INFO - 'NO_EM_RESTART': '1', 03:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:12 INFO - 'PWD': '/builds/slave/test', 03:25:12 INFO - 'SHELL': '/bin/bash', 03:25:12 INFO - 'SHLVL': '1', 03:25:12 INFO - 'TERM': 'linux', 03:25:12 INFO - 'TMOUT': '86400', 03:25:12 INFO - 'USER': 'cltbld', 03:25:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:12 INFO - '_': '/tools/buildbot/bin/python'} 03:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:12 INFO - Running setup.py (path:/tmp/pip-eO96ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:12 INFO - Running setup.py (path:/tmp/pip-eaVxJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:12 INFO - Running setup.py (path:/tmp/pip-DMkcT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:12 INFO - Running setup.py (path:/tmp/pip-DflLHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:12 INFO - Running setup.py (path:/tmp/pip-gYIp8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:13 INFO - Running setup.py (path:/tmp/pip-yclwsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:13 INFO - Running setup.py (path:/tmp/pip-jcH31D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:13 INFO - Running setup.py (path:/tmp/pip-FDMcfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:13 INFO - Running setup.py (path:/tmp/pip-Zdg4pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:13 INFO - Running setup.py (path:/tmp/pip-tDMhFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:13 INFO - Running setup.py (path:/tmp/pip-mXvvBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:13 INFO - Running setup.py (path:/tmp/pip-KZLcLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:13 INFO - Running setup.py (path:/tmp/pip-4WJ7RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:13 INFO - Running setup.py (path:/tmp/pip-vxAP2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:13 INFO - Running setup.py (path:/tmp/pip-t7b7NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:13 INFO - Running setup.py (path:/tmp/pip-6IYwtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:13 INFO - Running setup.py (path:/tmp/pip-S7GvZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:13 INFO - Running setup.py install for manifestparser 03:25:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:13 INFO - Running setup.py install for mozcrash 03:25:14 INFO - Running setup.py install for mozdebug 03:25:14 INFO - Running setup.py install for mozdevice 03:25:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Running setup.py install for mozfile 03:25:14 INFO - Running setup.py install for mozhttpd 03:25:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Running setup.py install for mozinfo 03:25:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Running setup.py install for mozInstall 03:25:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Running setup.py install for mozleak 03:25:14 INFO - Running setup.py install for mozlog 03:25:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:14 INFO - Running setup.py install for moznetwork 03:25:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Running setup.py install for mozprocess 03:25:15 INFO - Running setup.py install for mozprofile 03:25:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Running setup.py install for mozrunner 03:25:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Running setup.py install for mozscreenshot 03:25:15 INFO - Running setup.py install for moztest 03:25:15 INFO - Running setup.py install for mozversion 03:25:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:15 INFO - Cleaning up... 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:15 INFO - Using env: {'DISPLAY': ':0', 03:25:15 INFO - 'HOME': '/home/cltbld', 03:25:15 INFO - 'LANG': 'en_US.UTF-8', 03:25:15 INFO - 'LANGUAGE': 'en_US:en', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MAIL': '/var/mail/cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SHLVL': '1', 03:25:15 INFO - 'TERM': 'linux', 03:25:15 INFO - 'TMOUT': '86400', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - '_': '/tools/buildbot/bin/python'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:15 INFO - Running setup.py (path:/tmp/pip-c1x0Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:25:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:15 INFO - Running setup.py (path:/tmp/pip-TbLxKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:16 INFO - Running setup.py (path:/tmp/pip-PkfXzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:16 INFO - Running setup.py (path:/tmp/pip-96Ars_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:16 INFO - Running setup.py (path:/tmp/pip-z2VA6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:16 INFO - Running setup.py (path:/tmp/pip-qfhhJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:16 INFO - Running setup.py (path:/tmp/pip-bNZPd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:16 INFO - Running setup.py (path:/tmp/pip-wU8q7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:16 INFO - Running setup.py (path:/tmp/pip-2cedfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:16 INFO - Running setup.py (path:/tmp/pip-4aYRe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:16 INFO - Running setup.py (path:/tmp/pip-ex5vkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:16 INFO - Running setup.py (path:/tmp/pip-TUsYUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:16 INFO - Running setup.py (path:/tmp/pip-yXZ9CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:16 INFO - Running setup.py (path:/tmp/pip-zVSxin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:16 INFO - Running setup.py (path:/tmp/pip-eCkUpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:17 INFO - Running setup.py (path:/tmp/pip-28IUW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:17 INFO - Running setup.py (path:/tmp/pip-jaH75p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:19 INFO - Downloading blessings-1.6.tar.gz 03:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:19 INFO - Installing collected packages: blessings 03:25:19 INFO - Running setup.py install for blessings 03:25:19 INFO - Successfully installed blessings 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:19 INFO - Reading from file tmpfile_stdout 03:25:19 INFO - Current package versions: 03:25:19 INFO - argparse == 1.2.1 03:25:19 INFO - blessings == 1.6 03:25:19 INFO - blobuploader == 1.2.4 03:25:19 INFO - docopt == 0.6.1 03:25:19 INFO - manifestparser == 1.1 03:25:19 INFO - mozInstall == 1.12 03:25:19 INFO - mozcrash == 0.17 03:25:19 INFO - mozdebug == 0.1 03:25:19 INFO - mozdevice == 0.48 03:25:19 INFO - mozfile == 1.2 03:25:19 INFO - mozhttpd == 0.7 03:25:19 INFO - mozinfo == 0.9 03:25:19 INFO - mozleak == 0.1 03:25:19 INFO - mozlog == 3.1 03:25:19 INFO - moznetwork == 0.27 03:25:19 INFO - mozprocess == 0.22 03:25:19 INFO - mozprofile == 0.28 03:25:19 INFO - mozrunner == 6.11 03:25:19 INFO - mozscreenshot == 0.1 03:25:19 INFO - mozsystemmonitor == 0.0 03:25:19 INFO - moztest == 0.7 03:25:19 INFO - mozversion == 1.4 03:25:19 INFO - psutil == 3.1.1 03:25:19 INFO - requests == 1.2.3 03:25:19 INFO - wsgiref == 0.1.2 03:25:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 INFO - Downloading/unpacking jsonschema 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:21 INFO - Downloading/unpacking functools32 (from jsonschema) 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:21 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:22 INFO - warning: no files found matching '*.txt' 03:25:22 INFO - no previously-included directories found matching 'build' 03:25:22 INFO - no previously-included directories found matching 'dist' 03:25:22 INFO - no previously-included directories found matching '.git*' 03:25:22 INFO - Installing collected packages: jsonschema, functools32 03:25:22 INFO - Running setup.py install for functools32 03:25:22 INFO - warning: no files found matching '*.txt' 03:25:22 INFO - no previously-included directories found matching 'build' 03:25:22 INFO - no previously-included directories found matching 'dist' 03:25:22 INFO - no previously-included directories found matching '.git*' 03:25:22 INFO - Successfully installed jsonschema functools32 03:25:22 INFO - Cleaning up... 03:25:22 INFO - Return code: 0 03:25:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:22 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 0x7f55e363ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:25:22 INFO - Using env: {'DISPLAY': ':0', 03:25:22 INFO - 'HOME': '/home/cltbld', 03:25:22 INFO - 'LANG': 'en_US.UTF-8', 03:25:22 INFO - 'LANGUAGE': 'en_US:en', 03:25:22 INFO - 'LOGNAME': 'cltbld', 03:25:22 INFO - 'MAIL': '/var/mail/cltbld', 03:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:22 INFO - 'MOZ_NO_REMOTE': '1', 03:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:22 INFO - 'NO_EM_RESTART': '1', 03:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:22 INFO - 'PWD': '/builds/slave/test', 03:25:22 INFO - 'SHELL': '/bin/bash', 03:25:22 INFO - 'SHLVL': '1', 03:25:22 INFO - 'TERM': 'linux', 03:25:22 INFO - 'TMOUT': '86400', 03:25:22 INFO - 'USER': 'cltbld', 03:25:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:22 INFO - '_': '/tools/buildbot/bin/python'} 03:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:22 INFO - Downloading/unpacking flake8 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:25:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:25:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:25 INFO - no previously-included directories found matching 'docs/_build' 03:25:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:25:25 INFO - Running setup.py install for pep8 03:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:25 INFO - no previously-included directories found matching 'docs/_build' 03:25:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:25:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:25:25 INFO - Cleaning up... 03:25:25 INFO - Return code: 0 03:25:25 INFO - Running post-action listener: _resource_record_post_action 03:25:25 INFO - Running post-action listener: _start_resource_monitoring 03:25:25 INFO - Starting resource monitoring. 03:25:25 INFO - ##### 03:25:25 INFO - ##### Running install step. 03:25:25 INFO - ##### 03:25:25 INFO - Running pre-action listener: _resource_record_pre_action 03:25:25 INFO - Running main action method: install 03:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:25 INFO - Reading from file tmpfile_stdout 03:25:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:25 INFO - Reading from file tmpfile_stdout 03:25:25 INFO - Output received: 03:25:25 INFO - Usage: mozinstall [options] installer 03:25:25 INFO - Options: 03:25:25 INFO - -h, --help show this help message and exit 03:25:25 INFO - -d DEST, --destination=DEST 03:25:25 INFO - Directory to install application into. [default: 03:25:25 INFO - "/builds/slave/test"] 03:25:25 INFO - --app=APP Application being installed. [default: firefox] 03:25:25 INFO - mkdir: /builds/slave/test/build/application 03:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:25:40 INFO - Reading from file tmpfile_stdout 03:25:40 INFO - Output received: 03:25:40 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:40 INFO - Running post-action listener: _resource_record_post_action 03:25:40 INFO - ##### 03:25:40 INFO - ##### Running run-tests step. 03:25:40 INFO - ##### 03:25:40 INFO - Running pre-action listener: _resource_record_pre_action 03:25:40 INFO - Running main action method: run_tests 03:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:40 INFO - Python 2.7.3 03:25:40 INFO - Return code: 0 03:25:40 INFO - grabbing minidump binary from tooltool 03:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:40 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 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:25:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:25:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:40 INFO - Return code: 0 03:25:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:25:41 INFO - Return code: 0 03:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 03:25:41 INFO - Using env: {'DISPLAY': ':0', 03:25:41 INFO - 'HOME': '/home/cltbld', 03:25:41 INFO - 'LANG': 'en_US.UTF-8', 03:25:41 INFO - 'LANGUAGE': 'en_US:en', 03:25:41 INFO - 'LOGNAME': 'cltbld', 03:25:41 INFO - 'MAIL': '/var/mail/cltbld', 03:25:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:41 INFO - 'MOZ_NO_REMOTE': '1', 03:25:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:41 INFO - 'NO_EM_RESTART': '1', 03:25:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:41 INFO - 'PWD': '/builds/slave/test', 03:25:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:41 INFO - 'SHELL': '/bin/bash', 03:25:41 INFO - 'SHLVL': '1', 03:25:41 INFO - 'TERM': 'linux', 03:25:41 INFO - 'TMOUT': '86400', 03:25:41 INFO - 'USER': 'cltbld', 03:25:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027', 03:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:41 INFO - '_': '/tools/buildbot/bin/python'} 03:25:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:25:42 INFO - mozversion application_buildid: 20160422004039 03:25:42 INFO - mozversion application_changeset: a704f4cf969cf5925e9cddae92a59ff502501f8f 03:25:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:25:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:42 INFO - mozversion application_name: Firefox 03:25:42 INFO - mozversion application_remotingname: firefox-dev 03:25:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:42 INFO - mozversion application_vendor: Mozilla 03:25:42 INFO - mozversion application_version: 47.0a2 03:25:42 INFO - mozversion platform_buildid: 20160422004039 03:25:42 INFO - mozversion platform_changeset: a704f4cf969cf5925e9cddae92a59ff502501f8f 03:25:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:42 INFO - mozversion platform_version: 47.0a2 03:25:42 INFO - using testdate: 1461320742 03:25:42 INFO - actual date: 1461320742 03:25:42 INFO - starting webserver on 'localhost:42809' 03:25:42 INFO - SUITE-START | Running 2 tests 03:25:42 INFO - TEST-START | dromaeo_css 03:25:42 INFO - operating with platform_type : linux_ 03:25:42 INFO - Initialising browser for dromaeo_css test... 03:25:42 INFO - TEST-INFO | started process 24334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXK1ECZ/profile http://localhost:42809/getInfo.html) 03:25:46 INFO - PROCESS | 24334 | 03:25:46 INFO - PROCESS | 24334 | (process:24410): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:47 INFO - PROCESS | 24334 | __metrics Screen width/height:1600/1200 03:25:47 INFO - PROCESS | 24334 | colorDepth:24 03:25:47 INFO - PROCESS | 24334 | Browser inner width/height: 1024/697 03:25:47 INFO - PROCESS | 24334 | __metrics 03:25:47 ERROR - PROCESS | 24334 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:25:48 INFO - TEST-INFO | 24334: exit 0 03:25:48 INFO - Browser initialized. 03:25:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:48 INFO - TEST-INFO | started process 24461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXK1ECZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:50 INFO - PROCESS | 24461 | 03:25:50 INFO - PROCESS | 24461 | (process:24527): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:00 INFO - PROCESS | 24461 | RSS: Main: 151412736 03:26:00 INFO - PROCESS | 24461 | 03:26:50 INFO - PROCESS | 24461 | 1461320810318 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:28:58 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42809/tests/dromaeo/cssquery-ext.html) 03:28:59 INFO - PROCESS | 24461 | RSS: Main: 154730496 03:28:59 INFO - PROCESS | 24461 | 03:32:00 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-ext.html (next: http://localhost:42809/tests/dromaeo/cssquery-jquery.html) 03:32:01 INFO - PROCESS | 24461 | RSS: Main: 152903680 03:32:01 INFO - PROCESS | 24461 | 03:35:03 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42809/tests/dromaeo/cssquery-mootools.html) 03:35:03 INFO - PROCESS | 24461 | RSS: Main: 152805376 03:35:03 INFO - PROCESS | 24461 | 03:38:05 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42809/tests/dromaeo/cssquery-prototype.html) 03:38:05 INFO - PROCESS | 24461 | RSS: Main: 152428544 03:38:05 INFO - PROCESS | 24461 | 03:41:08 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42809/tests/dromaeo/cssquery-yui.html) 03:41:08 INFO - PROCESS | 24461 | RSS: Main: 153858048 03:41:08 INFO - PROCESS | 24461 | 03:44:10 INFO - PROCESS | 24461 | Cycle 1(1): loaded http://localhost:42809/tests/dromaeo/cssquery-yui.html (next: http://localhost:42809/tests/dromaeo/cssquery-dojo.html) 03:44:11 INFO - PROCESS | 24461 | RSS: Main: 155590656 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | __start_tp_report 03:44:11 INFO - PROCESS | 24461 | _x_x_mozilla_page_load 03:44:11 INFO - PROCESS | 24461 | _x_x_mozilla_page_load_details 03:44:11 INFO - PROCESS | 24461 | |i|pagename|runs| 03:44:11 INFO - PROCESS | 24461 | |0;dojo.html;3270.329582435601;3336.4494858348376;3368.89893303201;3380.2056516718553;3405.489176623506;5372.167314066316;5377.381601115872;5410.323709536308;5422.593305502089;5456.263404440399;5417.756200970956;5432.864178395532;5433.646812957155;5441.020616289066;5451.863703407407;4977.328060711812;5002.349694539723;5042.142835717918;5073.0107629012355;5094.668846524983;4870.537298956593;4912;5006.173981293082;5026.597872170236;5081.695098294114;4989.550940415362;4989.925151122736;4993.900121997558;5045.344105266328;5067.01193267313;5012.122878496267;5048.469910659402;5063.139266324733;5077.619178561604;5087.872803179913;4890.682105663156;4944.456109827916;4965.924511982327;4980.526849949249;4988.102141614508;5237.764300606444;5240.502152295526;5243.711595862226;5264.052470555299;5289.814856480043;5852.67810270435;5865.120231965197;5882.764689412418;5887.087501437284;5909.172715819789;5717.628354156966;5742.425757424266;5789.855253618651;5812.534997200214;5864.970675146639;5476.17857321401;5505.532029777473;5517.36550296717;5522.66863988162;5528.308961379827;5721.713914304268;5930.644161350333;5982.581219314693;5996.640201587918;6002;5596.804111856066;5684.772609095672;5716.685582292931;5725;5773.595848290579;5833.79581714638;5839.474447299764;5853.648781073064;5876.7649294028615;5897.616654917417;5664.291963504562;5813.88372232553;5830.183774271605;5850.8537286567325;5856.677882716492;5840.065589505743;5864.06175011996;5864.266966629171;5865.090910908816;5916;4435.622972047412;4456.309272062836;4463.486699029653;4463.709858859163;4512.909741805145;3968.7420317679835;3976.6222208890686;4015.217032678658;4042.4542686736913;4083.4487344208746;5320.574354051744;5635;5691.601587888808;5696.117101849137;5747.08046712524;5883.823485295448;5898.262717160355;5905.232319798399;5908.4091590841435;5918.112283157561;5399.541039011728;5577.191307260425;5615.550755939515;5623.437656234344;5635.436456354331;4977.726225057657;5037.345145131109;5048.469910659402;5062.4684408137355;5097.158968770185;6119.571629985859;6122.26532816056;6132.816015519542;6134;6135.07973803933;5623.493885550321;5796.188533605215;5832.620879642979;5836.912446313394;5889.116632505158;6084.543659225487;6095.664738439428;6100.938990610037;6106;6107.816765497042;5783.363829978614;5786.971065144648;5789.9710501447225;5793.246877905845;5795.623284486495;5754.539636829128;5802.912956305574;5881.05903055509;5904.409559044061;5929.6145750526075;5697.914531282117;5749.137629355463;5750.281214848144;5752.9712351437975;5771.249737534094;5555.638883472561;5756.884862302814;5771.105478650816;5771.7402716877;5774.8845023098465;5563.193336966198;5600.355959064596;5608.186812912023;5623.775048998158;5663;5721.713914304185;5726.055200891807;5773.91339129905;5779.306483222041;5800.912986305125;5445.673259604437;5596.104623260258;5667.291588551431;5671.688057156731;5713.514351280188 03:44:11 INFO - PROCESS | 24461 | |1;ext.html;570.2216474512292;590.9982579527702;602.1178972804842;638.2819328255713;648.0506058624117;39828.601713982855;40174.799126004364;40177.7991110044;40497.59502404975;40540;43867.56132438675;43890.56109438905;44017.559824401746;44113.7794311028;44341;8848.690295839662;9080;9091.318151138657;9112.179903808656;9137.954310228473;8971;9092.909070909305;9155.67955121571;9359.298052646045;9365.969743328229;9228.769280767967;9295.07049295072;9354.485503297316;9359;9380.484073375961;9220.769480762967;9233.169014788702;9240.214581760525;9266.305027122926;9340.813183736322;9116.361854670176;9233.722988310294;9235.076492350778;9259.398139121004;9273.119053689888;43281;43725;43999;44131;44180;3237.3525294941105;3697.9369404437666;3828.0812604974603;4010.2581022510635;4323.4163387942535;29662.40675186506;29666.555001674777;29726.256843578867;29914;30349.24126896823;3966.543157141842;4029.435878976946;4056.898577535556;4073.1446396256524;4124.793760311973;253529;255160;255307;256202;256476;59958.70020649869;60247.69876150591;60814;60824.69587652033;60924;72860;73609;74496;74509.6274518624;75019.62490187514;17621.7356739649;17694.469165925042;17733.911330443265;17770.022648754442;17822.821771782375;13135.605931822061;13140.34298285082;13156.473741050442;13220.140690855063;13300.733985320432;22018.559628807336;22399.55200895973;22417.215397461336;22551.887240563694;23250;8039.959800200962;8424.663013479514;8556.229939305493;8571.657133714582;8691.782705432288;988.6391467114452;1025.825609646362;1076.7361996310954;1083.5774048121239;1126.6732647532288;29556;29942.40115197684;30118;30223;30249.243768905955;1063.3832377221192;1087.217203613397;1136.8578927634046;1187.2698290551248;1255.6735248835369;14511.274436278354;14647.92676036613;14705.338259778335;14917.104973701396;15057.17185554805;341159;519509;524860;527430;738809;60880;61391.38608613857;62064.379356206766;62086.37913620896;62352.688236559436;1493.081754720839;1508.5700575335977;1509.0945432740268;1512.6898985707903;1529.5870115068647;29922;30547.236319091313;30755.53866692046;30774.384512310076;31062.22344441407;49702.502974969786;49780;50280;50287.74856125842;50419.49580504148;309115;310386;311333;311601;312214;34668.47997279993;35049.299014020085;47491;48112.518874810805;48485.75757121192;42830.78584607057;43088.35367469553;43664;43878.34182487201;44126.779366102965;36533;37406.2518749618;37585.684501042335;37625.43561846629;39533.80233098816;38696.41955370728;39401.211975760896;39484.210315794095;40180;40272.19455610813;38774.2245155101;39074.2185156301;39522;39583.20833583255;39622.40566391564;34109.65890341065;34622.82688586541;34658.48012279868;34818.65181348154;35225.29549408946;26260.343491412867;27143;27198.864005679847;27201.31996700098;27300.31749206286 03:44:11 INFO - PROCESS | 24461 | |2;jquery.html;373.4472979989615;377.27374803503267;388.6560394051267;391.5829641431875;392.0668808236397;18744;19638.214471421124;19730.408087757372;20272.087756050958;20388.286409975655;17476.82523174768;17857.642847143048;18123.72814407785;18236.17937192826;18269.269229230817;5588.441155884409;5783.797567085153;5825.330087040003;5838.737256823453;5864.736086876101;6835.043093966849;7153.391961683237;7173.282671732837;7180.389666878322;7185.101862267216;6297.149884765567;6561.606303621774;7115.8221044473785;7126.714931402737;7131;6598.5051121165625;6629.370209830058;6634.601923884534;6646.6676666166495;6677.1987361516685;6656.567323123982;6666.799996000128;6670.132882725263;6681.331866813329;6717.966410167918;22244.332670019925;23600.29199124029;24505.754942450527;24866.5026699465;25661.10186143476;2369.9289021329387;2412.6381042843536;2540.1109611635966;2544.4783819316995;2577.1624222127884;14600.12399256048;14801.233019749325;14991.175485348302;15059.849401506064;15129.848701512954;1875.1561797191182;1916.1856211110362;1954.0620502159043;1985.8411327093797;2043.4482689673853;72801;75308.62345688291;76729;77750.99999999943;79050.20949790544;15438.614034649223;16231.188440577924;16283.267252973645;16543;16557;27309.726902731116;27450.5882411764;28156.43687126246;28173.71826281711;28217.153485395473;9859.211263098934;10153.4923253837;10259.846102308471;10318.742031449274;10395.272330936914;8675.913240867636;8778.780530486662;8851.380403371702;8859.468431894107;8899.33255005877;4733.763311834395;7924;8185.959070204611;8236.382271329554;8298.585070746438;1988.3637236084314;2043.1520918818821;2050.7334046574147;2063.8968051597662;2069.6585063464663;939.8684184214216;981.3719219699398;1034.4052170002278;1089.629525961177;1101.680512651322;17547.73678394825;17630.41326280641;17937.910310448366;18491.722624160648;18509.35217267389;969.5055521683851;977.5845265762023;1006.9848952265722;1008.253892119826;1041.8489319048847;9965.55155018026;10309.896901030894;10345.37927724339;10399.32404393712;10590.523426445674;399984;405438;407633;409182;413966;76106;82499.5875020621;82571.5871420639;82783;84548.57725711333;1065.3607835298758;1067.9839802402814;1071.276888100529;1089.5260561655705;1091.0834898685143;15892.52322430329;15987.920060399623;16202.351905923631;16206.756898646765;16437.506874793777;35688.464673030445;36134.63865361418;36653.45019824758;36699.08252293607;37975.43036854504;49268.2609760861;51121;51568.22647660213;51640.74179629078;51756;8440.324774018187;8638.13618638131;8764.474131552128;9010.234130099016;9074.682386116454;11394.601188958346;12985;13558.186508809504;13635.86364136346;13657.317134143452;11216.158788090763;11875;12201.755964880474;12403.317817519763;12696.6825829355;11403.258788178742;11610.94194529022;11752.412379381169;12462.252264864137;12522.436490358137;12064.155509114278;12182.269063856196;12321.260724356567;12536.185147965352;12823.230606163661;9028.142326478974;9082.273418126402;9107.772305692411;9256.629734810533;9283.72148835536;9736.75658108553;12453.750924981268;12579.622611321674;12582.811257831323;12657.303848288433 03:44:11 INFO - PROCESS | 24461 | |3;mootools.html;1518.3850540531084;1519.772034194871;1754.3947338168337;1934.1973081171316;1945.2608008956595;7176.56940583564;8193.91806081939;8239.752807415773;8367.539785311814;8447.324214062875;8287.91712082879;8323.58382080895;8335.624896879639;8341.207585279404;8351.91648083519;2394.162043284845;2457.8402403843693;2458.6434966929783;2462.384403899025;2463.6674049003423;2424.2969538833804;2450.779429851313;2482.4042229864795;2484.5776218042975;2486.8507889526686;2480.913168039119;2485.6768620079456;2509.887055082526;2511.1462102885016;2512.937176570582;2463.2363967170236;2469.444375015625;2484.1305543059784;2488.2659615413404;2490.9875450622812;2439.7194322652767;2449.6815413996064;2473.9980307975297;2478.578641630927;2505.987470062656;8526.87209691855;8592.441491303045;8616.741497755078;8643.222110010129;8697.7825554361;5102.617303702237;5177.430482646906;5204.089284375219;5206.088934436459;5207.323048003773;3155.8737650493954;3176.9205769855707;3188.091393952712;3210.646828848825;3244.3997860395903;965.4738167698621;974.4396971741206;983.395211944656;1004.3371374892608;1008.4151192308443;12027.51889924402;12089.637310880687;12098.637040888787;12109.697257568543;12114.757704845942;4585.541445855454;4631.536846315409;4636.976815115971;4640.721556706609;4752.809887604457;10341.327813692085;10355.63755268577;10365.118964887919;10398.636047738293;10429.5828166874;5245.108331583564;5263.973680131575;5266;5270.235815806686;5285.101532739443;4603.49361570227;4699.083678682624;4730.5032971538185;4756.16767065769;4767.976160119247;3695.5380577427823;3796.52543432071;3808.8286027128847;3810.904727381838;3812.4090765931323;1163.7896587548855;1169.5672601137633;1170.6195486466931;1172.2907640877318;1179.351356753782;1208.3837243005955;1238.3374894431436;1250.781113305168;1494.3574263066769;1498.4530646314017;7948.165442628557;8155.959220203979;8207.71273005442;8220.095789463154;8223.095459499451;1209.5524655877382;1247.089624574066;1252.8872401483911;1262.2489618677057;1265.7088869559868;6251.062340648939;6331.05034244867;6372.936270637234;6395.488360931115;6411.294757576663;10120.493975301206;10316.948415258026;10423.42671153094;10481.895181048245;10523.21075919309;10335.328203666737;10487.580496780043;10517.9474102629;10552.630657926935;10628.25602207838;7997.360211183091;8099.676012959533;8111.756647300708;8185.918140818635;8190.5904704764525;7795.844083118419;7896.881546776688;7911.367090632851;7935.801604959691;8040.5979701015885;9262.259019278306;9334.206592439446;9414.529273536433;9434.85847712271;9519.762005949906;9056.456612603264;9079.909200907907;9130.634774608941;9525.952370238381;9785.755356116155;6569.80290591283;7121.67952442131;7294.525855819355;7520.323170914644;7685.193054729397;7974.162712915292;7974.8006299840645;7986.480878742863;8010.799730006796;8015.078265999485;6900.930990690029;7181.964090179516;7205.855882882418;7259.455540834353;7415;7039.120109986252;7150.7497237596435;7153.749618763319;7165.856682866418;7339.816504587428;7377.299156580117;7388.741394051182;7419.703211871465;7450.813729656585;7471.626418679153;6429.7106630200815;6516.706748196248;6525.119108920425;6528.21661400635;6533.934660653333;6787.117674702257;6908.48186386013;6970.059042029261;7001.054857594363;7008.264132266038 03:44:11 INFO - PROCESS | 24461 | |4;prototype.html;370.6830659785883;372.0828158589079;374.5393166405323;377.69595475642114;382.2107348325707;6223.1287619733275;6328.683565821713;6342.207224096988;6365.649889256089;6377.489800815935;6204.069389591564;6205.658688772116;6222.626642401459;6227.53293502988;6247.219097612799;4715.198416269225;4837.7339246341435;4865.4161500619975;4868.586170175539;4872.610191184696;4827.927581086269;4852.17513022787;4854.611631069523;4855.708657480544;4864.246041863499;4802.927956080644;4804.639652026112;4811.975940120295;4812.687175333592;4826.517348265163;4809.374781278429;4812.181929072066;4823.1800593899125;4823.276508523714;4834.806607735686;4238.237117318881;4245.8513952011845;4246.384274280243;4253.659707223445;4265.0616864289805;5781.219535362757;5929.318128415244;5944.4352786485215;5981.700914954278;5987.820365389045;5591.776328946838;5616.32604087508;5630.15547667849;5640.576956728261;5649.915251271234;6588.407043366072;6597.1093902323055;6633.071370008202;6634.270230274666;6655.966720166417;4661.557152070548;4677.64917631179;4680.134175177569;4687.367205427257;4687.906241875144;6846.281140480228;6904.585724856524;6930.549514281555;6946.583205007665;6947.305269473012;4565.5206203348835;4740.360051393018;4748.097861406391;4753.04939012199;4753.572178503951;4691.850496628348;4719.693219940762;4725.5510726480925;4725.8582242532775;4726.95273047272;5552.944470555323;5562.972185139049;5564.805231816867;5565.554755619541;5568.52667523257;6671.766488172891;6705.899411508832;6712;6712.765053223211;6713.6643167842385;1704.8977061376356;1734.9479515614553;1734.9826501735074;1742.0244662988766;1742.1724680776529;1125.2741981421937;1139.6865861888048;1150.0971737186435;1155.0874808900874;1169.9415029248503;6474.255460622088;6486.189226346707;6494.480441564663;6496.870062598721;6508.869822603616;6834.58992460444;6914.204866440424;6926.376626103674;6931.341522555349;6937.791866244021;6336.8415789604705;6480.449161821204;6494.415502604788;6519.152510173647;6562.704678289489;3738.85044598213;3767.566729826105;3768.9246215075545;3771.057235691077;3775.981120094437;7288.161861385903;7300.4159667226495;7314.926850731531;7333.48665593414;7348.338649521569;7147.642617869085;7186.173590037212;7209.279072092853;7236.276372362827;7258.419326453871;7060.7881763547175;7268.236835132235;7307.123145222501;7329.633518324169;7352.558846469122;6964.09466769337;6999.335063168991;7000.054992575937;7000.159980802337;7013.438924886099;6872.656367181721;6886.414654754402;6888.242293347627;6890;6921.688524016532;7219.963900180675;7273.527220730635;7289.416846652149;7313.890291645736;7316.231795661379;4601.930971035504;4740.19416699155;4759.3574867393845;4759.833405830779;4827.468978412302;6894.758683446055;6928.861422771415;6944.479164062816;6951.617661028692;6958.826029349104;6764.898526522008;6808.897866531907;6810.944303632945;6811.761588344384;6813;6726.226483954408;6748.93251067483;6757.695903684247;6787.287334829772;6798.014287928321;6353.205849268841;6543.770968016097;6558.1802274715665;6571.3100124488155;6608.372204640552;6751.594904305757;6761.628110453776;6804.795856124324;6822.522423430511;6826;6656.334366563305;6664.5334826561675;6675.332466753286;6683.264840867403;6691.966540167268 03:44:11 INFO - PROCESS | 24461 | |5;yui.html;791.8257983243684;801.1027649033081;810.3193317613205;833.1876420490023;839.5088873009289;13456.66358341042;13465.596032119027;13492.190468571867;13595.592132236025;13907.513237036694;12950.611481655566;12989.675258118552;12996.090273680822;13048.021398395134;13063.934680326585;770.5453782268461;911.7811725185941;918.8851393575803;925.047201382577;940.2290122099881;919.7240827751681;920.3971398733806;922.8846394200725;923.8244733500647;945.9195968342699;950.0072424316571;950.1543626172712;951.8810148731409;953.1040821627682;985.8324084905547;938.671464987249;939;942.7831598732262;943.4905151218334;986.6842610364686;737.1890919988024;737.2958824322812;738.2027410396812;740.5815714121558;741.1698897235077;13784.172949623055;13812.240326782023;13818;13853.099548529313;13875.306234688225;12238.632841014694;12262.26426414418;12275;12506.937465312616;12535.185212961129;10531.84202236967;10549.41978191199;10590.25868189227;10611.84082238767;10682.946585267102;3664.212194378195;3763.9811800941093;3797.0886987123167;3850.8652197173246;3908.7263891527605;52340.476595233944;52518.47481525174;52662.736686316326;52666;52795.73602132003;9388.202002829836;9648.469334186546;9710.368826026286;9748.658796942073;9788.119069283655;17205;17363.30546778115;17410.39063632792;17416.738748918775;17849.464516064538;7667.118281397599;7831.686732530635;7859.52842829432;8114.553699546582;8172.264496195371;4374.628156606724;4411.382406463098;4429.357743127229;4491.595756381876;4519.457665080211;3244.6755324467363;3287.983560082232;3292.3086151907887;3300.05948304732;3300.405926933127;618.7710547097603;624.2384291164772;625.9280182778948;629.4335098411466;643.797203880776;580.9564282678816;642.9549931504844;685.7051467868764;700.5901547594714;713.165596252386;7705.267999540035;7921.920780792118;8013;8285.875711864326;8338.207870252316;568.5451638689033;702.2696395748364;703.3107554596525;710.7903168565182;746.8282295072055;3732.738708290394;3747.4940882980995;3857.18999010211;3880.1269714314053;3919.470871432377;54342;54761;54961.450385495635;55142;61507.69246153741;51244.74377628088;51817.48182518127;52202;53361.7331913338;53363.733181333846;47457.525424746;47738.76130619325;48079.75960120247;48088;48770.5122948766;7645.967794347692;7693.384529237535;7702.691892324245;7725.188855170351;7781;35243.82378088093;35640;36789.26421471609;37182.628173717916;37252.813735931144;46566;46642.533574663816;46859.53140468552;46942.53057469382;47807.5219247803;11105.38920359388;11169.72075698114;11419.02938250258;11461;11517.308961462339;11835.822462662894;12177.208481448677;12201.755964880831;12251.816222756488;12430.81353779676;11261.662150135182;11276.32342059479;11278.094029097369;11462.083033357478;11469.885301146882;11199.808890569906;11290.774184516427;11320.377379243891;11392.202545822045;11450.37022963745;10811.729706757395;10821.404822734825;11080.667579972614;11083;11177.329360238411;9588.808223835624;10206.387616743019;10278.640247591298;10288.434136122285;10373.429461379697;9388.95305523468;9618.086281803218;9685.9031409685;9754.26842986793;9756.07317304855 03:44:11 INFO - PROCESS | 24461 | __end_tp_report 03:44:11 INFO - PROCESS | 24461 | __start_cc_report 03:44:11 INFO - PROCESS | 24461 | _x_x_mozilla_cycle_collect,322 03:44:11 INFO - PROCESS | 24461 | __end_cc_report 03:44:11 INFO - PROCESS | 24461 | __startTimestamp1461321851080__endTimestamp 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | ------- Summary: start ------- 03:44:11 INFO - PROCESS | 24461 | Number of tests: 6 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#0] dojo.html Cycles:165 Average:5441.81 Median:5664.29 stddev:594.89 (10.5%) stddev-sans-first:571.81 03:44:11 INFO - PROCESS | 24461 | Values: 3270.3 3336.4 3368.9 3380.2 3405.5 5372.2 5377.4 5410.3 5422.6 5456.3 5417.8 5432.9 5433.6 5441.0 5451.9 4977.3 5002.3 5042.1 5073.0 5094.7 4870.5 4912.0 5006.2 5026.6 5081.7 4989.6 4989.9 4993.9 5045.3 5067.0 5012.1 5048.5 5063.1 5077.6 5087.9 4890.7 4944.5 4965.9 4980.5 4988.1 5237.8 5240.5 5243.7 5264.1 5289.8 5852.7 5865.1 5882.8 5887.1 5909.2 5717.6 5742.4 5789.9 5812.5 5865.0 5476.2 5505.5 5517.4 5522.7 5528.3 5721.7 5930.6 5982.6 5996.6 6002.0 5596.8 5684.8 5716.7 5725.0 5773.6 5833.8 5839.5 5853.6 5876.8 5897.6 5664.3 5813.9 5830.2 5850.9 5856.7 5840.1 5864.1 5864.3 5865.1 5916.0 4435.6 4456.3 4463.5 4463.7 4512.9 3968.7 3976.6 4015.2 4042.5 4083.4 5320.6 5635.0 5691.6 5696.1 5747.1 5883.8 5898.3 5905.2 5908.4 5918.1 5399.5 5577.2 5615.6 5623.4 5635.4 4977.7 5037.3 5048.5 5062.5 5097.2 6119.6 6122.3 6132.8 6134.0 6135.1 5623.5 5796.2 5832.6 5836.9 5889.1 6084.5 6095.7 6100.9 6106.0 6107.8 5783.4 5787.0 5790.0 5793.2 5795.6 5754.5 5802.9 5881.1 5904.4 5929.6 5697.9 5749.1 5750.3 5753.0 5771.2 5555.6 5756.9 5771.1 5771.7 5774.9 5563.2 5600.4 5608.2 5623.8 5663.0 5721.7 5726.1 5773.9 5779.3 5800.9 5445.7 5596.1 5667.3 5671.7 5713.5 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#1] ext.html Cycles:180 Average:54481.39 Median:22092.53 stddev:104086.16 (471.1%) stddev-sans-first:104299.44 03:44:11 INFO - PROCESS | 24461 | Values: 570.2 591.0 602.1 638.3 648.1 39828.6 40174.8 40177.8 40497.6 40540.0 43867.6 43890.6 44017.6 44113.8 44341.0 8848.7 9080.0 9091.3 9112.2 9138.0 8971.0 9092.9 9155.7 9359.3 9366.0 9228.8 9295.1 9354.5 9359.0 9380.5 9220.8 9233.2 9240.2 9266.3 9340.8 9116.4 9233.7 9235.1 9259.4 9273.1 43281.0 43725.0 43999.0 44131.0 44180.0 3237.4 3697.9 3828.1 4010.3 4323.4 29662.4 29666.6 29726.3 29914.0 30349.2 3966.5 4029.4 4056.9 4073.1 4124.8 253529.0 255160.0 255307.0 256202.0 256476.0 59958.7 60247.7 60814.0 60824.7 60924.0 72860.0 73609.0 74496.0 74509.6 75019.6 17621.7 17694.5 17733.9 17770.0 17822.8 13135.6 13140.3 13156.5 13220.1 13300.7 22018.6 22399.6 22417.2 22551.9 23250.0 8040.0 8424.7 8556.2 8571.7 8691.8 988.6 1025.8 1076.7 1083.6 1126.7 29556.0 29942.4 30118.0 30223.0 30249.2 1063.4 1087.2 1136.9 1187.3 1255.7 14511.3 14647.9 14705.3 14917.1 15057.2 341159.0 519509.0 524860.0 527430.0 738809.0 60880.0 61391.4 62064.4 62086.4 62352.7 1493.1 1508.6 1509.1 1512.7 1529.6 29922.0 30547.2 30755.5 30774.4 31062.2 49702.5 49780.0 50280.0 50287.7 50419.5 309115.0 310386.0 311333.0 311601.0 312214.0 34668.5 35049.3 47491.0 48112.5 48485.8 42830.8 43088.4 43664.0 43878.3 44126.8 36533.0 37406.3 37585.7 37625.4 39533.8 38696.4 39401.2 39484.2 40180.0 40272.2 38774.2 39074.2 39522.0 39583.2 39622.4 34109.7 34622.8 34658.5 34818.7 35225.3 26260.3 27143.0 27198.9 27201.3 27300.3 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#2] jquery.html Cycles:180 Average:26869.07 Median:14102.79 stddev:67059.64 (475.5%) stddev-sans-first:67218.26 03:44:11 INFO - PROCESS | 24461 | Values: 373.4 377.3 388.7 391.6 392.1 18744.0 19638.2 19730.4 20272.1 20388.3 17476.8 17857.6 18123.7 18236.2 18269.3 5588.4 5783.8 5825.3 5838.7 5864.7 6835.0 7153.4 7173.3 7180.4 7185.1 6297.1 6561.6 7115.8 7126.7 7131.0 6598.5 6629.4 6634.6 6646.7 6677.2 6656.6 6666.8 6670.1 6681.3 6718.0 22244.3 23600.3 24505.8 24866.5 25661.1 2369.9 2412.6 2540.1 2544.5 2577.2 14600.1 14801.2 14991.2 15059.8 15129.8 1875.2 1916.2 1954.1 1985.8 2043.4 72801.0 75308.6 76729.0 77751.0 79050.2 15438.6 16231.2 16283.3 16543.0 16557.0 27309.7 27450.6 28156.4 28173.7 28217.2 9859.2 10153.5 10259.8 10318.7 10395.3 8675.9 8778.8 8851.4 8859.5 8899.3 4733.8 7924.0 8186.0 8236.4 8298.6 1988.4 2043.2 2050.7 2063.9 2069.7 939.9 981.4 1034.4 1089.6 1101.7 17547.7 17630.4 17937.9 18491.7 18509.4 969.5 977.6 1007.0 1008.3 1041.8 9965.6 10309.9 10345.4 10399.3 10590.5 399984.0 405438.0 407633.0 409182.0 413966.0 76106.0 82499.6 82571.6 82783.0 84548.6 1065.4 1068.0 1071.3 1089.5 1091.1 15892.5 15987.9 16202.4 16206.8 16437.5 35688.5 36134.6 36653.5 36699.1 37975.4 49268.3 51121.0 51568.2 51640.7 51756.0 8440.3 8638.1 8764.5 9010.2 9074.7 11394.6 12985.0 13558.2 13635.9 13657.3 11216.2 11875.0 12201.8 12403.3 12696.7 11403.3 11610.9 11752.4 12462.3 12522.4 12064.2 12182.3 12321.3 12536.2 12823.2 9028.1 9082.3 9107.8 9256.6 9283.7 9736.8 12453.8 12579.6 12582.8 12657.3 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#3] mootools.html Cycles:180 Average:5936.14 Median:5206.71 stddev:3127.84 (60.1%) stddev-sans-first:3118.99 03:44:11 INFO - PROCESS | 24461 | Values: 1518.4 1519.8 1754.4 1934.2 1945.3 7176.6 8193.9 8239.8 8367.5 8447.3 8287.9 8323.6 8335.6 8341.2 8351.9 2394.2 2457.8 2458.6 2462.4 2463.7 2424.3 2450.8 2482.4 2484.6 2486.9 2480.9 2485.7 2509.9 2511.1 2512.9 2463.2 2469.4 2484.1 2488.3 2491.0 2439.7 2449.7 2474.0 2478.6 2506.0 8526.9 8592.4 8616.7 8643.2 8697.8 5102.6 5177.4 5204.1 5206.1 5207.3 3155.9 3176.9 3188.1 3210.6 3244.4 965.5 974.4 983.4 1004.3 1008.4 12027.5 12089.6 12098.6 12109.7 12114.8 4585.5 4631.5 4637.0 4640.7 4752.8 10341.3 10355.6 10365.1 10398.6 10429.6 5245.1 5264.0 5266.0 5270.2 5285.1 4603.5 4699.1 4730.5 4756.2 4768.0 3695.5 3796.5 3808.8 3810.9 3812.4 1163.8 1169.6 1170.6 1172.3 1179.4 1208.4 1238.3 1250.8 1494.4 1498.5 7948.2 8156.0 8207.7 8220.1 8223.1 1209.6 1247.1 1252.9 1262.2 1265.7 6251.1 6331.1 6372.9 6395.5 6411.3 10120.5 10316.9 10423.4 10481.9 10523.2 10335.3 10487.6 10517.9 10552.6 10628.3 7997.4 8099.7 8111.8 8185.9 8190.6 7795.8 7896.9 7911.4 7935.8 8040.6 9262.3 9334.2 9414.5 9434.9 9519.8 9056.5 9079.9 9130.6 9526.0 9785.8 6569.8 7121.7 7294.5 7520.3 7685.2 7974.2 7974.8 7986.5 8010.8 8015.1 6900.9 7182.0 7205.9 7259.5 7415.0 7039.1 7150.7 7153.7 7165.9 7339.8 7377.3 7388.7 7419.7 7450.8 7471.6 6429.7 6516.7 6525.1 6528.2 6533.9 6787.1 6908.5 6970.1 7001.1 7008.3 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#4] prototype.html Cycles:180 Average:5629.66 Median:6371.57 stddev:1703.59 (26.7%) stddev-sans-first:1662.01 03:44:11 INFO - PROCESS | 24461 | Values: 370.7 372.1 374.5 377.7 382.2 6223.1 6328.7 6342.2 6365.6 6377.5 6204.1 6205.7 6222.6 6227.5 6247.2 4715.2 4837.7 4865.4 4868.6 4872.6 4827.9 4852.2 4854.6 4855.7 4864.2 4802.9 4804.6 4812.0 4812.7 4826.5 4809.4 4812.2 4823.2 4823.3 4834.8 4238.2 4245.9 4246.4 4253.7 4265.1 5781.2 5929.3 5944.4 5981.7 5987.8 5591.8 5616.3 5630.2 5640.6 5649.9 6588.4 6597.1 6633.1 6634.3 6656.0 4661.6 4677.6 4680.1 4687.4 4687.9 6846.3 6904.6 6930.5 6946.6 6947.3 4565.5 4740.4 4748.1 4753.0 4753.6 4691.9 4719.7 4725.6 4725.9 4727.0 5552.9 5563.0 5564.8 5565.6 5568.5 6671.8 6705.9 6712.0 6712.8 6713.7 1704.9 1734.9 1735.0 1742.0 1742.2 1125.3 1139.7 1150.1 1155.1 1169.9 6474.3 6486.2 6494.5 6496.9 6508.9 6834.6 6914.2 6926.4 6931.3 6937.8 6336.8 6480.4 6494.4 6519.2 6562.7 3738.9 3767.6 3768.9 3771.1 3776.0 7288.2 7300.4 7314.9 7333.5 7348.3 7147.6 7186.2 7209.3 7236.3 7258.4 7060.8 7268.2 7307.1 7329.6 7352.6 6964.1 6999.3 7000.1 7000.2 7013.4 6872.7 6886.4 6888.2 6890.0 6921.7 7220.0 7273.5 7289.4 7313.9 7316.2 4601.9 4740.2 4759.4 4759.8 4827.5 6894.8 6928.9 6944.5 6951.6 6958.8 6764.9 6808.9 6810.9 6811.8 6813.0 6726.2 6748.9 6757.7 6787.3 6798.0 6353.2 6543.8 6558.2 6571.3 6608.4 6751.6 6761.6 6804.8 6822.5 6826.0 6656.3 6664.5 6675.3 6683.3 6692.0 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - PROCESS | 24461 | [#5] yui.html Cycles:180 Average:14064.41 Median:47943.64 stddev:16462.65 (34.3%) stddev-sans-first:16478.66 03:44:11 INFO - PROCESS | 24461 | Values: 791.8 801.1 810.3 833.2 839.5 13456.7 13465.6 13492.2 13595.6 13907.5 12950.6 12989.7 12996.1 13048.0 13063.9 770.5 911.8 918.9 925.0 940.2 919.7 920.4 922.9 923.8 945.9 950.0 950.2 951.9 953.1 985.8 938.7 939.0 942.8 943.5 986.7 737.2 737.3 738.2 740.6 741.2 13784.2 13812.2 13818.0 13853.1 13875.3 12238.6 12262.3 12275.0 12506.9 12535.2 10531.8 10549.4 10590.3 10611.8 10682.9 3664.2 3764.0 3797.1 3850.9 3908.7 52340.5 52518.5 52662.7 52666.0 52795.7 9388.2 9648.5 9710.4 9748.7 9788.1 17205.0 17363.3 17410.4 17416.7 17849.5 7667.1 7831.7 7859.5 8114.6 8172.3 4374.6 4411.4 4429.4 4491.6 4519.5 3244.7 3288.0 3292.3 3300.1 3300.4 618.8 624.2 625.9 629.4 643.8 581.0 643.0 685.7 700.6 713.2 7705.3 7921.9 8013.0 8285.9 8338.2 568.5 702.3 703.3 710.8 746.8 3732.7 3747.5 3857.2 3880.1 3919.5 54342.0 54761.0 54961.5 55142.0 61507.7 51244.7 51817.5 52202.0 53361.7 53363.7 47457.5 47738.8 48079.8 48088.0 48770.5 7646.0 7693.4 7702.7 7725.2 7781.0 35243.8 35640.0 36789.3 37182.6 37252.8 46566.0 46642.5 46859.5 46942.5 47807.5 11105.4 11169.7 11419.0 11461.0 11517.3 11835.8 12177.2 12201.8 12251.8 12430.8 11261.7 11276.3 11278.1 11462.1 11469.9 11199.8 11290.8 11320.4 11392.2 11450.4 10811.7 10821.4 11080.7 11083.0 11177.3 9588.8 10206.4 10278.6 10288.4 10373.4 9389.0 9618.1 9685.9 9754.3 9756.1 03:44:11 INFO - PROCESS | 24461 | -------- Summary: end -------- 03:44:11 INFO - PROCESS | 24461 | 03:44:11 INFO - TEST-INFO | 24461: exit 0 03:44:11 INFO - TEST-OK | dromaeo_css | took 1109612ms 03:44:11 INFO - TEST-START | kraken 03:44:11 INFO - operating with platform_type : linux_ 03:44:11 INFO - Initialising browser for kraken test... 03:44:11 INFO - TEST-INFO | started process 24703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCgwAq0/profile http://localhost:42809/getInfo.html) 03:44:15 INFO - PROCESS | 24703 | 03:44:15 INFO - PROCESS | 24703 | (process:24780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:44:16 INFO - PROCESS | 24703 | __metrics Screen width/height:1600/1200 03:44:16 INFO - PROCESS | 24703 | colorDepth:24 03:44:16 INFO - PROCESS | 24703 | Browser inner width/height: 1024/697 03:44:16 INFO - PROCESS | 24703 | __metrics 03:44:17 ERROR - PROCESS | 24703 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:44:18 INFO - TEST-INFO | 24703: exit 0 03:44:18 INFO - Browser initialized. 03:44:18 INFO - Running cycle 1/1 for kraken test... 03:44:18 INFO - TEST-INFO | started process 24831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCgwAq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:20 INFO - PROCESS | 24831 | 03:44:20 INFO - PROCESS | 24831 | (process:24897): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:44:30 INFO - PROCESS | 24831 | RSS: Main: 151449600 03:44:30 INFO - PROCESS | 24831 | 03:44:32 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42809/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:33 INFO - PROCESS | 24831 | RSS: Main: 155475968 03:44:33 INFO - PROCESS | 24831 | 03:44:35 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42809/tests/kraken/driver.html?testName=audio-dft) 03:44:36 INFO - PROCESS | 24831 | RSS: Main: 155852800 03:44:36 INFO - PROCESS | 24831 | 03:44:39 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42809/tests/kraken/driver.html?testName=audio-fft) 03:44:39 INFO - PROCESS | 24831 | RSS: Main: 156704768 03:44:39 INFO - PROCESS | 24831 | 03:44:41 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42809/tests/kraken/driver.html?testName=audio-oscillator) 03:44:42 INFO - PROCESS | 24831 | RSS: Main: 156098560 03:44:42 INFO - PROCESS | 24831 | 03:44:44 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:45 INFO - PROCESS | 24831 | RSS: Main: 156246016 03:44:45 INFO - PROCESS | 24831 | 03:44:48 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42809/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:49 INFO - PROCESS | 24831 | RSS: Main: 156942336 03:44:49 INFO - PROCESS | 24831 | 03:44:52 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42809/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:53 INFO - PROCESS | 24831 | RSS: Main: 156815360 03:44:53 INFO - PROCESS | 24831 | 03:44:55 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42809/tests/kraken/driver.html?testName=json-parse-financial) 03:44:56 INFO - PROCESS | 24831 | RSS: Main: 156819456 03:44:56 INFO - PROCESS | 24831 | 03:44:58 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:58 INFO - PROCESS | 24831 | RSS: Main: 156286976 03:44:58 INFO - PROCESS | 24831 | 03:45:00 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:01 INFO - PROCESS | 24831 | RSS: Main: 156069888 03:45:01 INFO - PROCESS | 24831 | 03:45:03 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:03 INFO - PROCESS | 24831 | RSS: Main: 156557312 03:45:03 INFO - PROCESS | 24831 | 03:45:06 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:06 INFO - PROCESS | 24831 | RSS: Main: 156479488 03:45:06 INFO - PROCESS | 24831 | 03:45:09 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:09 INFO - PROCESS | 24831 | RSS: Main: 156766208 03:45:09 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | Cycle 1(1): loaded http://localhost:42809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42809/tests/kraken/driver.html?testName=ai-astar) 03:45:11 INFO - PROCESS | 24831 | RSS: Main: 158720000 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | __start_tp_report 03:45:11 INFO - PROCESS | 24831 | _x_x_mozilla_page_load 03:45:11 INFO - PROCESS | 24831 | _x_x_mozilla_page_load_details 03:45:11 INFO - PROCESS | 24831 | |i|pagename|runs| 03:45:11 INFO - PROCESS | 24831 | |0;ai-astar;111;106;114;110;113;123;111;110;113;110 03:45:11 INFO - PROCESS | 24831 | |1;audio-beat-detection;159;127;151;172;132;158;154;126;169;129 03:45:11 INFO - PROCESS | 24831 | |2;audio-dft;161;164;162;163;161;163;165;162;165;162 03:45:11 INFO - PROCESS | 24831 | |3;audio-fft;75;76;76;168;77;79;76;75;163;77 03:45:11 INFO - PROCESS | 24831 | |4;audio-oscillator;93;94;135;93;93;93;150;94;93;140 03:45:11 INFO - PROCESS | 24831 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;118;117 03:45:11 INFO - PROCESS | 24831 | |6;imaging-darkroom;147;147;146;147;147;148;146;146;148;147 03:45:11 INFO - PROCESS | 24831 | |7;imaging-desaturate;96;96;96;96;97;96;96;97;96;96 03:45:11 INFO - PROCESS | 24831 | |8;json-parse-financial;54;55;59;55;57;59;62;62;54;54 03:45:11 INFO - PROCESS | 24831 | |9;json-stringify-tinderbox;66;66;65;65;65;67;64;66;67;66 03:45:11 INFO - PROCESS | 24831 | |10;stanford-crypto-aes;78;78;82;79;81;85;78;79;79;79 03:45:11 INFO - PROCESS | 24831 | |11;stanford-crypto-ccm;119;122;115;114;114;128;119;124;112;117 03:45:11 INFO - PROCESS | 24831 | |12;stanford-crypto-pbkdf2;141;140;152;144;142;142;140;140;140;141 03:45:11 INFO - PROCESS | 24831 | |13;stanford-crypto-sha256-iterative;69;66;65;68;66;67;69;67;67;71 03:45:11 INFO - PROCESS | 24831 | __end_tp_report 03:45:11 INFO - PROCESS | 24831 | __start_cc_report 03:45:11 INFO - PROCESS | 24831 | _x_x_mozilla_cycle_collect,812 03:45:11 INFO - PROCESS | 24831 | __end_cc_report 03:45:11 INFO - PROCESS | 24831 | __startTimestamp1461321911704__endTimestamp 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | ------- Summary: start ------- 03:45:11 INFO - PROCESS | 24831 | Number of tests: 14 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:4.43 (4.0%) stddev-sans-first:4.68 03:45:11 INFO - PROCESS | 24831 | Values: 111.0 106.0 114.0 110.0 113.0 123.0 111.0 110.0 113.0 110.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.00 stddev:17.71 (11.4%) stddev-sans-first:18.31 03:45:11 INFO - PROCESS | 24831 | Values: 159.0 127.0 151.0 172.0 132.0 158.0 154.0 126.0 169.0 129.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.48 (0.9%) stddev-sans-first:1.41 03:45:11 INFO - PROCESS | 24831 | Values: 161.0 164.0 162.0 163.0 161.0 163.0 165.0 162.0 165.0 162.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:37.61 (49.5%) stddev-sans-first:39.25 03:45:11 INFO - PROCESS | 24831 | Values: 75.0 76.0 76.0 168.0 77.0 79.0 76.0 75.0 163.0 77.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.65 (25.4%) stddev-sans-first:24.47 03:45:11 INFO - PROCESS | 24831 | Values: 93.0 94.0 135.0 93.0 93.0 93.0 150.0 94.0 93.0 140.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:45:11 INFO - PROCESS | 24831 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:45:11 INFO - PROCESS | 24831 | Values: 147.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 148.0 147.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:45:11 INFO - PROCESS | 24831 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:3.21 (5.5%) stddev-sans-first:3.21 03:45:11 INFO - PROCESS | 24831 | Values: 54.0 55.0 59.0 55.0 57.0 59.0 62.0 62.0 54.0 54.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 03:45:11 INFO - PROCESS | 24831 | Values: 66.0 66.0 65.0 65.0 65.0 67.0 64.0 66.0 67.0 66.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.25 (2.8%) stddev-sans-first:2.29 03:45:11 INFO - PROCESS | 24831 | Values: 78.0 78.0 82.0 79.0 81.0 85.0 78.0 79.0 79.0 79.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:119.00 stddev:5.06 (4.3%) stddev-sans-first:5.36 03:45:11 INFO - PROCESS | 24831 | Values: 119.0 122.0 115.0 114.0 114.0 128.0 119.0 124.0 112.0 117.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:141.50 stddev:3.68 (2.6%) stddev-sans-first:3.87 03:45:11 INFO - PROCESS | 24831 | Values: 141.0 140.0 152.0 144.0 142.0 142.0 140.0 140.0 140.0 141.0 03:45:11 INFO - PROCESS | 24831 | 03:45:11 INFO - PROCESS | 24831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.78 (2.6%) stddev-sans-first:1.80 03:45:11 INFO - PROCESS | 24831 | Values: 69.0 66.0 65.0 68.0 66.0 67.0 69.0 67.0 67.0 71.0 03:45:11 INFO - PROCESS | 24831 | -------- Summary: end -------- 03:45:11 INFO - PROCESS | 24831 | 03:45:12 INFO - TEST-INFO | 24831: exit 0 03:45:12 INFO - TEST-OK | kraken | took 60883ms 03:45:12 INFO - SUITE-END | took 1170s 03:45:12 INFO - Completed test suite (00:19:30) 03:45:12 INFO - javascript benchmark 03:45:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3270.329582435601, 3336.4494858348376, 3368.89893303201, 3380.2056516718553, 3405.489176623506, 5372.167314066316, 5377.381601115872, 5410.323709536308, 5422.593305502089, 5456.263404440399, 5417.756200970956, 5432.864178395532, 5433.646812957155, 5441.020616289066, 5451.863703407407, 4977.328060711812, 5002.349694539723, 5042.142835717918, 5073.0107629012355, 5094.668846524983, 4870.537298956593, 4912.0, 5006.173981293082, 5026.597872170236, 5081.695098294114, 4989.550940415362, 4989.925151122736, 4993.900121997558, 5045.344105266328, 5067.01193267313, 5012.122878496267, 5048.469910659402, 5063.139266324733, 5077.619178561604, 5087.872803179913, 4890.682105663156, 4944.456109827916, 4965.924511982327, 4980.526849949249, 4988.102141614508, 5237.764300606444, 5240.502152295526, 5243.711595862226, 5264.052470555299, 5289.814856480043, 5852.67810270435, 5865.120231965197, 5882.764689412418, 5887.087501437284, 5909.172715819789, 5717.628354156966, 5742.425757424266, 5789.855253618651, 5812.534997200214, 5864.970675146639, 5476.17857321401, 5505.532029777473, 5517.36550296717, 5522.66863988162, 5528.308961379827, 5721.713914304268, 5930.644161350333, 5982.581219314693, 5996.640201587918, 6002.0, 5596.804111856066, 5684.772609095672, 5716.685582292931, 5725.0, 5773.595848290579, 5833.79581714638, 5839.474447299764, 5853.648781073064, 5876.7649294028615, 5897.616654917417, 5664.291963504562, 5813.88372232553, 5830.183774271605, 5850.8537286567325, 5856.677882716492, 5840.065589505743, 5864.06175011996, 5864.266966629171, 5865.090910908816, 5916.0, 4435.622972047412, 4456.309272062836, 4463.486699029653, 4463.709858859163, 4512.909741805145, 3968.7420317679835, 3976.6222208890686, 4015.217032678658, 4042.4542686736913, 4083.4487344208746, 5320.574354051744, 5635.0, 5691.601587888808, 5696.117101849137, 5747.08046712524, 5883.823485295448, 5898.262717160355, 5905.232319798399, 5908.4091590841435, 5918.112283157561, 5399.541039011728, 5577.191307260425, 5615.550755939515, 5623.437656234344, 5635.436456354331, 4977.726225057657, 5037.345145131109, 5048.469910659402, 5062.4684408137355, 5097.158968770185, 6119.571629985859, 6122.26532816056, 6132.816015519542, 6134.0, 6135.07973803933, 5623.493885550321, 5796.188533605215, 5832.620879642979, 5836.912446313394, 5889.116632505158, 6084.543659225487, 6095.664738439428, 6100.938990610037, 6106.0, 6107.816765497042, 5783.363829978614, 5786.971065144648, 5789.9710501447225, 5793.246877905845, 5795.623284486495, 5754.539636829128, 5802.912956305574, 5881.05903055509, 5904.409559044061, 5929.6145750526075, 5697.914531282117, 5749.137629355463, 5750.281214848144, 5752.9712351437975, 5771.249737534094, 5555.638883472561, 5756.884862302814, 5771.105478650816, 5771.7402716877, 5774.8845023098465, 5563.193336966198, 5600.355959064596, 5608.186812912023, 5623.775048998158, 5663.0, 5721.713914304185, 5726.055200891807, 5773.91339129905, 5779.306483222041, 5800.912986305125, 5445.673259604437, 5596.104623260258, 5667.291588551431, 5671.688057156731, 5713.514351280188], "unit": "score", "name": "dojo.html", "value": 5404.182313970273}, {"lowerIsBetter": false, "replicates": [570.2216474512292, 590.9982579527702, 602.1178972804842, 638.2819328255713, 648.0506058624117, 39828.601713982855, 40174.799126004364, 40177.7991110044, 40497.59502404975, 40540.0, 43867.56132438675, 43890.56109438905, 44017.559824401746, 44113.7794311028, 44341.0, 8848.690295839662, 9080.0, 9091.318151138657, 9112.179903808656, 9137.954310228473, 8971.0, 9092.909070909305, 9155.67955121571, 9359.298052646045, 9365.969743328229, 9228.769280767967, 9295.07049295072, 9354.485503297316, 9359.0, 9380.484073375961, 9220.769480762967, 9233.169014788702, 9240.214581760525, 9266.305027122926, 9340.813183736322, 9116.361854670176, 9233.722988310294, 9235.076492350778, 9259.398139121004, 9273.119053689888, 43281.0, 43725.0, 43999.0, 44131.0, 44180.0, 3237.3525294941105, 3697.9369404437666, 3828.0812604974603, 4010.2581022510635, 4323.4163387942535, 29662.40675186506, 29666.555001674777, 29726.256843578867, 29914.0, 30349.24126896823, 3966.543157141842, 4029.435878976946, 4056.898577535556, 4073.1446396256524, 4124.793760311973, 253529.0, 255160.0, 255307.0, 256202.0, 256476.0, 59958.70020649869, 60247.69876150591, 60814.0, 60824.69587652033, 60924.0, 72860.0, 73609.0, 74496.0, 74509.6274518624, 75019.62490187514, 17621.7356739649, 17694.469165925042, 17733.911330443265, 17770.022648754442, 17822.821771782375, 13135.605931822061, 13140.34298285082, 13156.473741050442, 13220.140690855063, 13300.733985320432, 22018.559628807336, 22399.55200895973, 22417.215397461336, 22551.887240563694, 23250.0, 8039.959800200962, 8424.663013479514, 8556.229939305493, 8571.657133714582, 8691.782705432288, 988.6391467114452, 1025.825609646362, 1076.7361996310954, 1083.5774048121239, 1126.6732647532288, 29556.0, 29942.40115197684, 30118.0, 30223.0, 30249.243768905955, 1063.3832377221192, 1087.217203613397, 1136.8578927634046, 1187.2698290551248, 1255.6735248835369, 14511.274436278354, 14647.92676036613, 14705.338259778335, 14917.104973701396, 15057.17185554805, 341159.0, 519509.0, 524860.0, 527430.0, 738809.0, 60880.0, 61391.38608613857, 62064.379356206766, 62086.37913620896, 62352.688236559436, 1493.081754720839, 1508.5700575335977, 1509.0945432740268, 1512.6898985707903, 1529.5870115068647, 29922.0, 30547.236319091313, 30755.53866692046, 30774.384512310076, 31062.22344441407, 49702.502974969786, 49780.0, 50280.0, 50287.74856125842, 50419.49580504148, 309115.0, 310386.0, 311333.0, 311601.0, 312214.0, 34668.47997279993, 35049.299014020085, 47491.0, 48112.518874810805, 48485.75757121192, 42830.78584607057, 43088.35367469553, 43664.0, 43878.34182487201, 44126.779366102965, 36533.0, 37406.2518749618, 37585.684501042335, 37625.43561846629, 39533.80233098816, 38696.41955370728, 39401.211975760896, 39484.210315794095, 40180.0, 40272.19455610813, 38774.2245155101, 39074.2185156301, 39522.0, 39583.20833583255, 39622.40566391564, 34109.65890341065, 34622.82688586541, 34658.48012279868, 34818.65181348154, 35225.29549408946, 26260.343491412867, 27143.0, 27198.864005679847, 27201.31996700098, 27300.31749206286], "unit": "score", "name": "ext.html", "value": 20191.790476470618}, {"lowerIsBetter": false, "replicates": [373.4472979989615, 377.27374803503267, 388.6560394051267, 391.5829641431875, 392.0668808236397, 18744.0, 19638.214471421124, 19730.408087757372, 20272.087756050958, 20388.286409975655, 17476.82523174768, 17857.642847143048, 18123.72814407785, 18236.17937192826, 18269.269229230817, 5588.441155884409, 5783.797567085153, 5825.330087040003, 5838.737256823453, 5864.736086876101, 6835.043093966849, 7153.391961683237, 7173.282671732837, 7180.389666878322, 7185.101862267216, 6297.149884765567, 6561.606303621774, 7115.8221044473785, 7126.714931402737, 7131.0, 6598.5051121165625, 6629.370209830058, 6634.601923884534, 6646.6676666166495, 6677.1987361516685, 6656.567323123982, 6666.799996000128, 6670.132882725263, 6681.331866813329, 6717.966410167918, 22244.332670019925, 23600.29199124029, 24505.754942450527, 24866.5026699465, 25661.10186143476, 2369.9289021329387, 2412.6381042843536, 2540.1109611635966, 2544.4783819316995, 2577.1624222127884, 14600.12399256048, 14801.233019749325, 14991.175485348302, 15059.849401506064, 15129.848701512954, 1875.1561797191182, 1916.1856211110362, 1954.0620502159043, 1985.8411327093797, 2043.4482689673853, 72801.0, 75308.62345688291, 76729.0, 77750.99999999943, 79050.20949790544, 15438.614034649223, 16231.188440577924, 16283.267252973645, 16543.0, 16557.0, 27309.726902731116, 27450.5882411764, 28156.43687126246, 28173.71826281711, 28217.153485395473, 9859.211263098934, 10153.4923253837, 10259.846102308471, 10318.742031449274, 10395.272330936914, 8675.913240867636, 8778.780530486662, 8851.380403371702, 8859.468431894107, 8899.33255005877, 4733.763311834395, 7924.0, 8185.959070204611, 8236.382271329554, 8298.585070746438, 1988.3637236084314, 2043.1520918818821, 2050.7334046574147, 2063.8968051597662, 2069.6585063464663, 939.8684184214216, 981.3719219699398, 1034.4052170002278, 1089.629525961177, 1101.680512651322, 17547.73678394825, 17630.41326280641, 17937.910310448366, 18491.722624160648, 18509.35217267389, 969.5055521683851, 977.5845265762023, 1006.9848952265722, 1008.253892119826, 1041.8489319048847, 9965.55155018026, 10309.896901030894, 10345.37927724339, 10399.32404393712, 10590.523426445674, 399984.0, 405438.0, 407633.0, 409182.0, 413966.0, 76106.0, 82499.5875020621, 82571.5871420639, 82783.0, 84548.57725711333, 1065.3607835298758, 1067.9839802402814, 1071.276888100529, 1089.5260561655705, 1091.0834898685143, 15892.52322430329, 15987.920060399623, 16202.351905923631, 16206.756898646765, 16437.506874793777, 35688.464673030445, 36134.63865361418, 36653.45019824758, 36699.08252293607, 37975.43036854504, 49268.2609760861, 51121.0, 51568.22647660213, 51640.74179629078, 51756.0, 8440.324774018187, 8638.13618638131, 8764.474131552128, 9010.234130099016, 9074.682386116454, 11394.601188958346, 12985.0, 13558.186508809504, 13635.86364136346, 13657.317134143452, 11216.158788090763, 11875.0, 12201.755964880474, 12403.317817519763, 12696.6825829355, 11403.258788178742, 11610.94194529022, 11752.412379381169, 12462.252264864137, 12522.436490358137, 12064.155509114278, 12182.269063856196, 12321.260724356567, 12536.185147965352, 12823.230606163661, 9028.142326478974, 9082.273418126402, 9107.772305692411, 9256.629734810533, 9283.72148835536, 9736.75658108553, 12453.750924981268, 12579.622611321674, 12582.811257831323, 12657.303848288433], "unit": "score", "name": "jquery.html", "value": 9887.020685483823}, {"lowerIsBetter": false, "replicates": [1518.3850540531084, 1519.772034194871, 1754.3947338168337, 1934.1973081171316, 1945.2608008956595, 7176.56940583564, 8193.91806081939, 8239.752807415773, 8367.539785311814, 8447.324214062875, 8287.91712082879, 8323.58382080895, 8335.624896879639, 8341.207585279404, 8351.91648083519, 2394.162043284845, 2457.8402403843693, 2458.6434966929783, 2462.384403899025, 2463.6674049003423, 2424.2969538833804, 2450.779429851313, 2482.4042229864795, 2484.5776218042975, 2486.8507889526686, 2480.913168039119, 2485.6768620079456, 2509.887055082526, 2511.1462102885016, 2512.937176570582, 2463.2363967170236, 2469.444375015625, 2484.1305543059784, 2488.2659615413404, 2490.9875450622812, 2439.7194322652767, 2449.6815413996064, 2473.9980307975297, 2478.578641630927, 2505.987470062656, 8526.87209691855, 8592.441491303045, 8616.741497755078, 8643.222110010129, 8697.7825554361, 5102.617303702237, 5177.430482646906, 5204.089284375219, 5206.088934436459, 5207.323048003773, 3155.8737650493954, 3176.9205769855707, 3188.091393952712, 3210.646828848825, 3244.3997860395903, 965.4738167698621, 974.4396971741206, 983.395211944656, 1004.3371374892608, 1008.4151192308443, 12027.51889924402, 12089.637310880687, 12098.637040888787, 12109.697257568543, 12114.757704845942, 4585.541445855454, 4631.536846315409, 4636.976815115971, 4640.721556706609, 4752.809887604457, 10341.327813692085, 10355.63755268577, 10365.118964887919, 10398.636047738293, 10429.5828166874, 5245.108331583564, 5263.973680131575, 5266.0, 5270.235815806686, 5285.101532739443, 4603.49361570227, 4699.083678682624, 4730.5032971538185, 4756.16767065769, 4767.976160119247, 3695.5380577427823, 3796.52543432071, 3808.8286027128847, 3810.904727381838, 3812.4090765931323, 1163.7896587548855, 1169.5672601137633, 1170.6195486466931, 1172.2907640877318, 1179.351356753782, 1208.3837243005955, 1238.3374894431436, 1250.781113305168, 1494.3574263066769, 1498.4530646314017, 7948.165442628557, 8155.959220203979, 8207.71273005442, 8220.095789463154, 8223.095459499451, 1209.5524655877382, 1247.089624574066, 1252.8872401483911, 1262.2489618677057, 1265.7088869559868, 6251.062340648939, 6331.05034244867, 6372.936270637234, 6395.488360931115, 6411.294757576663, 10120.493975301206, 10316.948415258026, 10423.42671153094, 10481.895181048245, 10523.21075919309, 10335.328203666737, 10487.580496780043, 10517.9474102629, 10552.630657926935, 10628.25602207838, 7997.360211183091, 8099.676012959533, 8111.756647300708, 8185.918140818635, 8190.5904704764525, 7795.844083118419, 7896.881546776688, 7911.367090632851, 7935.801604959691, 8040.5979701015885, 9262.259019278306, 9334.206592439446, 9414.529273536433, 9434.85847712271, 9519.762005949906, 9056.456612603264, 9079.909200907907, 9130.634774608941, 9525.952370238381, 9785.755356116155, 6569.80290591283, 7121.67952442131, 7294.525855819355, 7520.323170914644, 7685.193054729397, 7974.162712915292, 7974.8006299840645, 7986.480878742863, 8010.799730006796, 8015.078265999485, 6900.930990690029, 7181.964090179516, 7205.855882882418, 7259.455540834353, 7415.0, 7039.120109986252, 7150.7497237596435, 7153.749618763319, 7165.856682866418, 7339.816504587428, 7377.299156580117, 7388.741394051182, 7419.703211871465, 7450.813729656585, 7471.626418679153, 6429.7106630200815, 6516.706748196248, 6525.119108920425, 6528.21661400635, 6533.934660653333, 6787.117674702257, 6908.48186386013, 6970.059042029261, 7001.054857594363, 7008.264132266038], "unit": "score", "name": "mootools.html", "value": 4858.202418538408}, {"lowerIsBetter": false, "replicates": [370.6830659785883, 372.0828158589079, 374.5393166405323, 377.69595475642114, 382.2107348325707, 6223.1287619733275, 6328.683565821713, 6342.207224096988, 6365.649889256089, 6377.489800815935, 6204.069389591564, 6205.658688772116, 6222.626642401459, 6227.53293502988, 6247.219097612799, 4715.198416269225, 4837.7339246341435, 4865.4161500619975, 4868.586170175539, 4872.610191184696, 4827.927581086269, 4852.17513022787, 4854.611631069523, 4855.708657480544, 4864.246041863499, 4802.927956080644, 4804.639652026112, 4811.975940120295, 4812.687175333592, 4826.517348265163, 4809.374781278429, 4812.181929072066, 4823.1800593899125, 4823.276508523714, 4834.806607735686, 4238.237117318881, 4245.8513952011845, 4246.384274280243, 4253.659707223445, 4265.0616864289805, 5781.219535362757, 5929.318128415244, 5944.4352786485215, 5981.700914954278, 5987.820365389045, 5591.776328946838, 5616.32604087508, 5630.15547667849, 5640.576956728261, 5649.915251271234, 6588.407043366072, 6597.1093902323055, 6633.071370008202, 6634.270230274666, 6655.966720166417, 4661.557152070548, 4677.64917631179, 4680.134175177569, 4687.367205427257, 4687.906241875144, 6846.281140480228, 6904.585724856524, 6930.549514281555, 6946.583205007665, 6947.305269473012, 4565.5206203348835, 4740.360051393018, 4748.097861406391, 4753.04939012199, 4753.572178503951, 4691.850496628348, 4719.693219940762, 4725.5510726480925, 4725.8582242532775, 4726.95273047272, 5552.944470555323, 5562.972185139049, 5564.805231816867, 5565.554755619541, 5568.52667523257, 6671.766488172891, 6705.899411508832, 6712.0, 6712.765053223211, 6713.6643167842385, 1704.8977061376356, 1734.9479515614553, 1734.9826501735074, 1742.0244662988766, 1742.1724680776529, 1125.2741981421937, 1139.6865861888048, 1150.0971737186435, 1155.0874808900874, 1169.9415029248503, 6474.255460622088, 6486.189226346707, 6494.480441564663, 6496.870062598721, 6508.869822603616, 6834.58992460444, 6914.204866440424, 6926.376626103674, 6931.341522555349, 6937.791866244021, 6336.8415789604705, 6480.449161821204, 6494.415502604788, 6519.152510173647, 6562.704678289489, 3738.85044598213, 3767.566729826105, 3768.9246215075545, 3771.057235691077, 3775.981120094437, 7288.161861385903, 7300.4159667226495, 7314.926850731531, 7333.48665593414, 7348.338649521569, 7147.642617869085, 7186.173590037212, 7209.279072092853, 7236.276372362827, 7258.419326453871, 7060.7881763547175, 7268.236835132235, 7307.123145222501, 7329.633518324169, 7352.558846469122, 6964.09466769337, 6999.335063168991, 7000.054992575937, 7000.159980802337, 7013.438924886099, 6872.656367181721, 6886.414654754402, 6888.242293347627, 6890.0, 6921.688524016532, 7219.963900180675, 7273.527220730635, 7289.416846652149, 7313.890291645736, 7316.231795661379, 4601.930971035504, 4740.19416699155, 4759.3574867393845, 4759.833405830779, 4827.468978412302, 6894.758683446055, 6928.861422771415, 6944.479164062816, 6951.617661028692, 6958.826029349104, 6764.898526522008, 6808.897866531907, 6810.944303632945, 6811.761588344384, 6813.0, 6726.226483954408, 6748.93251067483, 6757.695903684247, 6787.287334829772, 6798.014287928321, 6353.205849268841, 6543.770968016097, 6558.1802274715665, 6571.3100124488155, 6608.372204640552, 6751.594904305757, 6761.628110453776, 6804.795856124324, 6822.522423430511, 6826.0, 6656.334366563305, 6664.5334826561675, 6675.332466753286, 6683.264840867403, 6691.966540167268], "unit": "score", "name": "prototype.html", "value": 5084.097489823831}, {"lowerIsBetter": false, "replicates": [791.8257983243684, 801.1027649033081, 810.3193317613205, 833.1876420490023, 839.5088873009289, 13456.66358341042, 13465.596032119027, 13492.190468571867, 13595.592132236025, 13907.513237036694, 12950.611481655566, 12989.675258118552, 12996.090273680822, 13048.021398395134, 13063.934680326585, 770.5453782268461, 911.7811725185941, 918.8851393575803, 925.047201382577, 940.2290122099881, 919.7240827751681, 920.3971398733806, 922.8846394200725, 923.8244733500647, 945.9195968342699, 950.0072424316571, 950.1543626172712, 951.8810148731409, 953.1040821627682, 985.8324084905547, 938.671464987249, 939.0, 942.7831598732262, 943.4905151218334, 986.6842610364686, 737.1890919988024, 737.2958824322812, 738.2027410396812, 740.5815714121558, 741.1698897235077, 13784.172949623055, 13812.240326782023, 13818.0, 13853.099548529313, 13875.306234688225, 12238.632841014694, 12262.26426414418, 12275.0, 12506.937465312616, 12535.185212961129, 10531.84202236967, 10549.41978191199, 10590.25868189227, 10611.84082238767, 10682.946585267102, 3664.212194378195, 3763.9811800941093, 3797.0886987123167, 3850.8652197173246, 3908.7263891527605, 52340.476595233944, 52518.47481525174, 52662.736686316326, 52666.0, 52795.73602132003, 9388.202002829836, 9648.469334186546, 9710.368826026286, 9748.658796942073, 9788.119069283655, 17205.0, 17363.30546778115, 17410.39063632792, 17416.738748918775, 17849.464516064538, 7667.118281397599, 7831.686732530635, 7859.52842829432, 8114.553699546582, 8172.264496195371, 4374.628156606724, 4411.382406463098, 4429.357743127229, 4491.595756381876, 4519.457665080211, 3244.6755324467363, 3287.983560082232, 3292.3086151907887, 3300.05948304732, 3300.405926933127, 618.7710547097603, 624.2384291164772, 625.9280182778948, 629.4335098411466, 643.797203880776, 580.9564282678816, 642.9549931504844, 685.7051467868764, 700.5901547594714, 713.165596252386, 7705.267999540035, 7921.920780792118, 8013.0, 8285.875711864326, 8338.207870252316, 568.5451638689033, 702.2696395748364, 703.3107554596525, 710.7903168565182, 746.8282295072055, 3732.738708290394, 3747.4940882980995, 3857.18999010211, 3880.1269714314053, 3919.470871432377, 54342.0, 54761.0, 54961.450385495635, 55142.0, 61507.69246153741, 51244.74377628088, 51817.48182518127, 52202.0, 53361.7331913338, 53363.733181333846, 47457.525424746, 47738.76130619325, 48079.75960120247, 48088.0, 48770.5122948766, 7645.967794347692, 7693.384529237535, 7702.691892324245, 7725.188855170351, 7781.0, 35243.82378088093, 35640.0, 36789.26421471609, 37182.628173717916, 37252.813735931144, 46566.0, 46642.533574663816, 46859.53140468552, 46942.53057469382, 47807.5219247803, 11105.38920359388, 11169.72075698114, 11419.02938250258, 11461.0, 11517.308961462339, 11835.822462662894, 12177.208481448677, 12201.755964880831, 12251.816222756488, 12430.81353779676, 11261.662150135182, 11276.32342059479, 11278.094029097369, 11462.083033357478, 11469.885301146882, 11199.808890569906, 11290.774184516427, 11320.377379243891, 11392.202545822045, 11450.37022963745, 10811.729706757395, 10821.404822734825, 11080.667579972614, 11083.0, 11177.329360238411, 9588.808223835624, 10206.387616743019, 10278.640247591298, 10288.434136122285, 10373.429461379697, 9388.95305523468, 9618.086281803218, 9685.9031409685, 9754.26842986793, 9756.07317304855], "unit": "score", "name": "yui.html", "value": 6495.480671277334}], "name": "dromaeo_css", "value": 7465.37409820897}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 114.0, 110.0, 113.0, 123.0, 111.0, 110.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 151.0, 172.0, 132.0, 158.0, 154.0, 126.0, 169.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 162.0, 163.0, 161.0, 163.0, 165.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 76.0, 168.0, 77.0, 79.0, 76.0, 75.0, 163.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.2}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 93.0, 93.0, 93.0, 150.0, 94.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 59.0, 55.0, 57.0, 59.0, 62.0, 62.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 67.0, 64.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 82.0, 79.0, 81.0, 85.0, 78.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 115.0, 114.0, 114.0, 128.0, 119.0, 124.0, 112.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 152.0, 144.0, 142.0, 142.0, 140.0, 140.0, 140.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 65.0, 68.0, 66.0, 67.0, 69.0, 67.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1515.8}]} 03:45:12 INFO - Return code: 0 03:45:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:45:12 ERROR - # TBPL SUCCESS # 03:45:12 INFO - Running post-action listener: _resource_record_post_action 03:45:12 INFO - Running post-run listener: _resource_record_post_run 03:45:14 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 282624; Write bytes: 503107584; Read time: 64; Write time: 868384 03:45:14 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 252166144; Read time: 0; Write time: 602676 03:45:14 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 282624; Write bytes: 250855424; Read time: 64; Write time: 265684 03:45:14 INFO - Running post-run listener: _upload_blobber_files 03:45:14 INFO - Blob upload gear active. 03:45:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:14 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 03:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:14 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:15 INFO - (blobuploader) - INFO - Done attempting. 03:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:16 INFO - (blobuploader) - INFO - Done attempting. 03:45:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:16 INFO - Return code: 0 03:45:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7d874e9c21c5d14f05ae9064f93ecc995ca4f4dea06cd2fe95820291b2076df495710d763a1f26e75e7f304fc9a1c08cea06bfc7cec61e4730c2bad5eebc633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b8b3a4a78a7698feb0e2bd5861bbb532c6922dd5908e5baa2992632ced2438007856d0532c6b2e8025d0d3cb36d7ba0288721094c5f21ec99c3c18cda06bd"} 03:45:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:16 INFO - Contents: 03:45:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7d874e9c21c5d14f05ae9064f93ecc995ca4f4dea06cd2fe95820291b2076df495710d763a1f26e75e7f304fc9a1c08cea06bfc7cec61e4730c2bad5eebc633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b8b3a4a78a7698feb0e2bd5861bbb532c6922dd5908e5baa2992632ced2438007856d0532c6b2e8025d0d3cb36d7ba0288721094c5f21ec99c3c18cda06bd"} 03:45:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:16 INFO - Copying logs to upload dir... 03:45:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.797547 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-22 03:45:16.080080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 03:45:16.083515) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7d874e9c21c5d14f05ae9064f93ecc995ca4f4dea06cd2fe95820291b2076df495710d763a1f26e75e7f304fc9a1c08cea06bfc7cec61e4730c2bad5eebc633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b8b3a4a78a7698feb0e2bd5861bbb532c6922dd5908e5baa2992632ced2438007856d0532c6b2e8025d0d3cb36d7ba0288721094c5f21ec99c3c18cda06bd"} build_url:https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011183 build_url: 'https://queue.taskcluster.net/v1/task/IAbF6jyXTGiZdHw9MuVJEw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7d874e9c21c5d14f05ae9064f93ecc995ca4f4dea06cd2fe95820291b2076df495710d763a1f26e75e7f304fc9a1c08cea06bfc7cec61e4730c2bad5eebc633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6b8b3a4a78a7698feb0e2bd5861bbb532c6922dd5908e5baa2992632ced2438007856d0532c6b2e8025d0d3cb36d7ba0288721094c5f21ec99c3c18cda06bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 03:45:16.107751) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:45:16.108046) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1461320688.892858-840023027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004369 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 03:45:16.191834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 03:45:16.192161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 03:45:16.192432) ========= ========= Total master_lag: 0.15 =========