builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1464431873.08 results: success (0) buildid: 20160525183450 builduid: 63f91898e679451db7d589c242ad058b revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.077341) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.078339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.079022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.098345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.098904) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:37:53-- 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% 46.6M=0s 2016-05-28 03:37:53 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.201663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.202428) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014629 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.256104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:53.256908) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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 33693d8bdec17f07fc460ca7cc908ade88f97b86 --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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:37:53,269 truncating revision to first 12 chars 2016-05-28 03:37:53,269 Setting DEBUG logging. 2016-05-28 03:37:53,269 attempt 1/10 2016-05-28 03:37:53,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33693d8bdec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:37:53,750 unpacking tar archive at: mozilla-aurora-33693d8bdec1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:54.059294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:54.060077) ========= script_repo_revision: 33693d8bdec17f07fc460ca7cc908ade88f97b86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:54.060709) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:54.061013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:37:54.075032) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-28 03:37:54.075348) ========= /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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:54 INFO - MultiFileLogger online at 20160528 03:37:54 in /builds/slave/test 03:37:54 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:37:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:54 INFO - {'append_to_log': False, 03:37:54 INFO - 'base_work_dir': '/builds/slave/test', 03:37:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:37:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:54 INFO - 'branch': 'Mozilla-Aurora', 03:37:54 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:54 INFO - 'config_files': ('talos/linux_config.py',), 03:37:54 INFO - 'default_actions': ('clobber', 03:37:54 INFO - 'read-buildbot-config', 03:37:54 INFO - 'download-and-extract', 03:37:54 INFO - 'populate-webroot', 03:37:54 INFO - 'create-virtualenv', 03:37:54 INFO - 'install', 03:37:54 INFO - 'run-tests'), 03:37:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:54 INFO - 'download_minidump_stackwalk': True, 03:37:54 INFO - 'download_symbols': 'ondemand', 03:37:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:54 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:54 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:54 INFO - 'installer_path': 'installer.exe', 03:37:54 INFO - 'log_level': 'info', 03:37:54 INFO - 'log_name': 'talos', 03:37:54 INFO - 'log_to_console': True, 03:37:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:54 INFO - 'opt_config_files': (), 03:37:54 INFO - 'pip_index': False, 03:37:54 INFO - 'sps_profile': False, 03:37:54 INFO - 'sps_profile_interval': 0, 03:37:54 INFO - 'suite': 'dromaeojs-e10s', 03:37:54 INFO - 'system_bits': '32', 03:37:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:54 INFO - 'title': 'talos-linux64-ix-011', 03:37:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:54 INFO - 'use_talos_json': True, 03:37:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:54 INFO - 'work_dir': 'build'} 03:37:54 INFO - ##### 03:37:54 INFO - ##### Running clobber step. 03:37:54 INFO - ##### 03:37:54 INFO - Running pre-action listener: _resource_record_pre_action 03:37:54 INFO - Running main action method: clobber 03:37:54 INFO - rmtree: /builds/slave/test/build 03:37:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:55 INFO - Running post-action listener: _resource_record_post_action 03:37:55 INFO - ##### 03:37:55 INFO - ##### Running read-buildbot-config step. 03:37:55 INFO - ##### 03:37:55 INFO - Running pre-action listener: _resource_record_pre_action 03:37:55 INFO - Running main action method: read_buildbot_config 03:37:55 INFO - Using buildbot properties: 03:37:55 INFO - { 03:37:55 INFO - "project": "", 03:37:55 INFO - "product": "firefox", 03:37:55 INFO - "script_repo_revision": "production", 03:37:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:37:55 INFO - "repository": "", 03:37:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:37:55 INFO - "buildid": "20160525183450", 03:37:55 INFO - "pgo_build": "True", 03:37:55 INFO - "basedir": "/builds/slave/test", 03:37:55 INFO - "buildnumber": 377, 03:37:55 INFO - "slavename": "talos-linux64-ix-011", 03:37:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:37:55 INFO - "platform": "ubuntu64_hw", 03:37:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:37:55 INFO - "branch": "mozilla-aurora", 03:37:55 INFO - "repo_path": "releases/mozilla-aurora", 03:37:55 INFO - "revision": "33693d8bdec17f07fc460ca7cc908ade88f97b86", 03:37:55 INFO - "stage_platform": "linux64-pgo", 03:37:55 INFO - "builduid": "63f91898e679451db7d589c242ad058b", 03:37:55 INFO - "slavebuilddir": "test" 03:37:55 INFO - } 03:37:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:37:55 INFO - Running post-action listener: _resource_record_post_action 03:37:55 INFO - ##### 03:37:55 INFO - ##### Running download-and-extract step. 03:37:55 INFO - ##### 03:37:55 INFO - Running pre-action listener: _resource_record_pre_action 03:37:55 INFO - Running main action method: download_and_extract 03:37:55 INFO - mkdir: /builds/slave/test/build/tests 03:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:55 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:37:55 INFO - Downloaded 1361 bytes. 03:37:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:37:55 INFO - Using the following test package requirements: 03:37:55 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:55 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:55 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:55 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'jsshell-linux-x86_64.zip'], 03:37:55 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:55 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:55 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:55 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:55 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:55 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:55 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:55 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:55 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:56 INFO - Downloaded 24140640 bytes. 03:37:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:37:58 INFO - Return code: 0 03:37:58 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:37: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:37:58 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:59 INFO - Downloaded 24140640 bytes. 03:37:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:38:01 INFO - Return code: 0 03:38:01 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:38:01 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:38:02 INFO - Downloaded 10840145 bytes. 03:38:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:38:02 INFO - Return code: 0 03:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:02 INFO - https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:38:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:38:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:38:06 INFO - Downloaded 62759817 bytes. 03:38:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:38:06 INFO - mkdir: /builds/slave/test/properties 03:38:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:06 INFO - Contents: 03:38:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:38:07 INFO - Running post-action listener: _resource_record_post_action 03:38:07 INFO - Running post-action listener: set_extra_try_arguments 03:38:07 INFO - ##### 03:38:07 INFO - ##### Running populate-webroot step. 03:38:07 INFO - ##### 03:38:07 INFO - Running pre-action listener: _resource_record_pre_action 03:38:07 INFO - Running main action method: populate_webroot 03:38:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:07 INFO - '--tppagecycles', 03:38:07 INFO - '7'], 03:38:07 INFO - 'tests': ['tsvgm']}}, 03:38:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['damp', 'tps']}, 03:38:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'tests': ['damp', 'tps']}, 03:38:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['dromaeo_dom']}, 03:38:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['a11yr', 03:38:07 INFO - 'ts_paint', 03:38:07 INFO - 'tpaint', 03:38:07 INFO - 'sessionrestore', 03:38:07 INFO - 'sessionrestore_no_auto_restore', 03:38:07 INFO - 'tabpaint']}, 03:38:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['tsvgx', 03:38:07 INFO - 'tsvgr_opacity', 03:38:07 INFO - 'tart', 03:38:07 INFO - 'tscrollx', 03:38:07 INFO - 'cart']}, 03:38:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:07 INFO - 'tsvgr_opacity', 03:38:07 INFO - 'tart', 03:38:07 INFO - 'tscrollx', 03:38:07 INFO - 'cart']}, 03:38:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'talos_options': ['--disable-e10s'], 03:38:07 INFO - 'tests': ['tp5o']}, 03:38:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'tests': ['tp5o']}, 03:38:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'talos_options': ['--disable-e10s', 03:38:07 INFO - '--xperf_path', 03:38:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:07 INFO - 'tests': ['tp5n']}, 03:38:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:07 INFO - 'talos_options': ['--xperf_path', 03:38:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:07 INFO - 'tests': ['tp5n']}}, 03:38:07 INFO - 'talos.zip': {'path': '', 03:38:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:07 INFO - Running post-action listener: _resource_record_post_action 03:38:07 INFO - ##### 03:38:07 INFO - ##### Running create-virtualenv step. 03:38:07 INFO - ##### 03:38:07 INFO - Running pre-action listener: _resource_record_pre_action 03:38:07 INFO - Running main action method: create_virtualenv 03:38:07 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:07 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:38:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:07 INFO - Using real prefix '/usr' 03:38:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:09 INFO - Installing pip.................done. 03:38:09 INFO - Return code: 0 03:38:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:09 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:09 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:38:09 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:38:09 INFO - Using env: {'DISPLAY': ':0', 03:38:09 INFO - 'HOME': '/home/cltbld', 03:38:09 INFO - 'LANG': 'en_US.UTF-8', 03:38:09 INFO - 'LANGUAGE': 'en_US:en', 03:38:09 INFO - 'LOGNAME': 'cltbld', 03:38:09 INFO - 'MAIL': '/var/mail/cltbld', 03:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:09 INFO - 'MOZ_NO_REMOTE': '1', 03:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:09 INFO - 'NO_EM_RESTART': '1', 03:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:09 INFO - 'PWD': '/builds/slave/test', 03:38:09 INFO - 'SHELL': '/bin/bash', 03:38:09 INFO - 'SHLVL': '1', 03:38:09 INFO - 'TERM': 'linux', 03:38:09 INFO - 'TMOUT': '86400', 03:38:09 INFO - 'USER': 'cltbld', 03:38:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:09 INFO - '_': '/tools/buildbot/bin/python'} 03:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:10 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:38:10 INFO - Cleaning up... 03:38:10 INFO - Return code: 0 03:38:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:10 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:10 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:38:10 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:38:10 INFO - Using env: {'DISPLAY': ':0', 03:38:10 INFO - 'HOME': '/home/cltbld', 03:38:10 INFO - 'LANG': 'en_US.UTF-8', 03:38:10 INFO - 'LANGUAGE': 'en_US:en', 03:38:10 INFO - 'LOGNAME': 'cltbld', 03:38:10 INFO - 'MAIL': '/var/mail/cltbld', 03:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:10 INFO - 'MOZ_NO_REMOTE': '1', 03:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:10 INFO - 'NO_EM_RESTART': '1', 03:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:10 INFO - 'PWD': '/builds/slave/test', 03:38:10 INFO - 'SHELL': '/bin/bash', 03:38:10 INFO - 'SHLVL': '1', 03:38:10 INFO - 'TERM': 'linux', 03:38:10 INFO - 'TMOUT': '86400', 03:38:10 INFO - 'USER': 'cltbld', 03:38:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:10 INFO - '_': '/tools/buildbot/bin/python'} 03:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:10 INFO - Downloading/unpacking psutil>=0.7.1 03:38:10 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:38:10 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:38:10 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:38:10 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:38:10 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:38:10 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:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:12 INFO - Installing collected packages: psutil 03:38:12 INFO - Running setup.py install for psutil 03:38:12 INFO - building 'psutil._psutil_linux' extension 03:38:12 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:38:12 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:38:12 INFO - building 'psutil._psutil_posix' extension 03:38:12 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:38:12 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:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:12 INFO - Successfully installed psutil 03:38:12 INFO - Cleaning up... 03:38:12 INFO - Return code: 0 03:38:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:38: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:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:12 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:12 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:38:12 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:38:12 INFO - Using env: {'DISPLAY': ':0', 03:38:12 INFO - 'HOME': '/home/cltbld', 03:38:12 INFO - 'LANG': 'en_US.UTF-8', 03:38:12 INFO - 'LANGUAGE': 'en_US:en', 03:38:12 INFO - 'LOGNAME': 'cltbld', 03:38:12 INFO - 'MAIL': '/var/mail/cltbld', 03:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:12 INFO - 'MOZ_NO_REMOTE': '1', 03:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:12 INFO - 'NO_EM_RESTART': '1', 03:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:12 INFO - 'PWD': '/builds/slave/test', 03:38:12 INFO - 'SHELL': '/bin/bash', 03:38:12 INFO - 'SHLVL': '1', 03:38:12 INFO - 'TERM': 'linux', 03:38:12 INFO - 'TMOUT': '86400', 03:38:12 INFO - 'USER': 'cltbld', 03:38:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:12 INFO - '_': '/tools/buildbot/bin/python'} 03:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:38:13 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:38:13 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:38:13 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:38:13 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:38:13 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:38:13 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:38:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:16 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:38:16 INFO - Installing collected packages: mozsystemmonitor 03:38:16 INFO - Running setup.py install for mozsystemmonitor 03:38:17 INFO - Successfully installed mozsystemmonitor 03:38:17 INFO - Cleaning up... 03:38:17 INFO - Return code: 0 03:38:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38:17 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:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:17 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:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:17 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:17 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:38:17 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:38:17 INFO - Using env: {'DISPLAY': ':0', 03:38:17 INFO - 'HOME': '/home/cltbld', 03:38:17 INFO - 'LANG': 'en_US.UTF-8', 03:38:17 INFO - 'LANGUAGE': 'en_US:en', 03:38:17 INFO - 'LOGNAME': 'cltbld', 03:38:17 INFO - 'MAIL': '/var/mail/cltbld', 03:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:17 INFO - 'MOZ_NO_REMOTE': '1', 03:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:17 INFO - 'NO_EM_RESTART': '1', 03:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:17 INFO - 'PWD': '/builds/slave/test', 03:38:17 INFO - 'SHELL': '/bin/bash', 03:38:17 INFO - 'SHLVL': '1', 03:38:17 INFO - 'TERM': 'linux', 03:38:17 INFO - 'TMOUT': '86400', 03:38:17 INFO - 'USER': 'cltbld', 03:38:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:17 INFO - '_': '/tools/buildbot/bin/python'} 03:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:38: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:38: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:38: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:38: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:38: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:38: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:38:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38: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:38: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:38: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:38: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:38: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:38: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:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:20 INFO - Downloading docopt-0.6.1.tar.gz 03:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:20 INFO - Running setup.py install for blobuploader 03:38:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:20 INFO - Running setup.py install for requests 03:38:21 INFO - Running setup.py install for docopt 03:38:21 INFO - Successfully installed blobuploader requests docopt 03:38:21 INFO - Cleaning up... 03:38:21 INFO - Return code: 0 03:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:21 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:21 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:38:21 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:38:21 INFO - Using env: {'DISPLAY': ':0', 03:38:21 INFO - 'HOME': '/home/cltbld', 03:38:21 INFO - 'LANG': 'en_US.UTF-8', 03:38:21 INFO - 'LANGUAGE': 'en_US:en', 03:38:21 INFO - 'LOGNAME': 'cltbld', 03:38:21 INFO - 'MAIL': '/var/mail/cltbld', 03:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:21 INFO - 'MOZ_NO_REMOTE': '1', 03:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:21 INFO - 'NO_EM_RESTART': '1', 03:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:21 INFO - 'PWD': '/builds/slave/test', 03:38:21 INFO - 'SHELL': '/bin/bash', 03:38:21 INFO - 'SHLVL': '1', 03:38:21 INFO - 'TERM': 'linux', 03:38:21 INFO - 'TMOUT': '86400', 03:38:21 INFO - 'USER': 'cltbld', 03:38:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:21 INFO - '_': '/tools/buildbot/bin/python'} 03:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:21 INFO - Running setup.py (path:/tmp/pip-hMg251-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:21 INFO - Running setup.py (path:/tmp/pip-7WeQQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:21 INFO - Running setup.py (path:/tmp/pip-Wvrx2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:21 INFO - Running setup.py (path:/tmp/pip-jrAwHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:21 INFO - Running setup.py (path:/tmp/pip-kVm5PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:21 INFO - Running setup.py (path:/tmp/pip-8rvevp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:21 INFO - Running setup.py (path:/tmp/pip-BS4hzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:21 INFO - Running setup.py (path:/tmp/pip-ncBzqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:21 INFO - Running setup.py (path:/tmp/pip-_QyMa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:22 INFO - Running setup.py (path:/tmp/pip-GcVTav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:22 INFO - Running setup.py (path:/tmp/pip-6bX8Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:22 INFO - Running setup.py (path:/tmp/pip-zKT5pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:22 INFO - Running setup.py (path:/tmp/pip-8E78CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:22 INFO - Running setup.py (path:/tmp/pip-SNA2U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:22 INFO - Running setup.py (path:/tmp/pip-NSww66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:22 INFO - Running setup.py (path:/tmp/pip-QhMvHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:22 INFO - Running setup.py (path:/tmp/pip-WDce7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:22 INFO - Running setup.py install for manifestparser 03:38:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:22 INFO - Running setup.py install for mozcrash 03:38:22 INFO - Running setup.py install for mozdebug 03:38:22 INFO - Running setup.py install for mozdevice 03:38:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:22 INFO - Running setup.py install for mozfile 03:38:23 INFO - Running setup.py install for mozhttpd 03:38:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for mozinfo 03:38:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for mozInstall 03:38:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for mozleak 03:38:23 INFO - Running setup.py install for mozlog 03:38:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for moznetwork 03:38:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for mozprocess 03:38:23 INFO - Running setup.py install for mozprofile 03:38:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:23 INFO - Running setup.py install for mozrunner 03:38:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:24 INFO - Running setup.py install for mozscreenshot 03:38:24 INFO - Running setup.py install for moztest 03:38:24 INFO - Running setup.py install for mozversion 03:38:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:24 INFO - Cleaning up... 03:38:24 INFO - Return code: 0 03:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:24 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:24 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:38:24 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:38:24 INFO - Using env: {'DISPLAY': ':0', 03:38:24 INFO - 'HOME': '/home/cltbld', 03:38:24 INFO - 'LANG': 'en_US.UTF-8', 03:38:24 INFO - 'LANGUAGE': 'en_US:en', 03:38:24 INFO - 'LOGNAME': 'cltbld', 03:38:24 INFO - 'MAIL': '/var/mail/cltbld', 03:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:24 INFO - 'MOZ_NO_REMOTE': '1', 03:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:24 INFO - 'NO_EM_RESTART': '1', 03:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:24 INFO - 'PWD': '/builds/slave/test', 03:38:24 INFO - 'SHELL': '/bin/bash', 03:38:24 INFO - 'SHLVL': '1', 03:38:24 INFO - 'TERM': 'linux', 03:38:24 INFO - 'TMOUT': '86400', 03:38:24 INFO - 'USER': 'cltbld', 03:38:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:24 INFO - '_': '/tools/buildbot/bin/python'} 03:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:24 INFO - Running setup.py (path:/tmp/pip-VYsFvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:24 INFO - Running setup.py (path:/tmp/pip-9fCK2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:24 INFO - Running setup.py (path:/tmp/pip-IEamVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:24 INFO - Running setup.py (path:/tmp/pip-0jBfBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:24 INFO - Running setup.py (path:/tmp/pip-E7Y9_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:24 INFO - Running setup.py (path:/tmp/pip-ftptZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:25 INFO - Running setup.py (path:/tmp/pip-tRtOQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:25 INFO - Running setup.py (path:/tmp/pip-fRlIh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:25 INFO - Running setup.py (path:/tmp/pip-UOIp4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:25 INFO - Running setup.py (path:/tmp/pip-w_H61q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:25 INFO - Running setup.py (path:/tmp/pip-VsB909-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:25 INFO - Running setup.py (path:/tmp/pip-AeVzOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:25 INFO - Running setup.py (path:/tmp/pip-U3yg_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:25 INFO - Running setup.py (path:/tmp/pip-qzcqke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:25 INFO - Running setup.py (path:/tmp/pip-F0dJ8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:25 INFO - Running setup.py (path:/tmp/pip-xBU38T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:25 INFO - Running setup.py (path:/tmp/pip-JeKvCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:25 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:38:25 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:38:25 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:38:25 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:38:25 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:38:25 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:38:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:27 INFO - Downloading blessings-1.6.tar.gz 03:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:27 INFO - Installing collected packages: blessings 03:38:27 INFO - Running setup.py install for blessings 03:38:27 INFO - Successfully installed blessings 03:38:27 INFO - Cleaning up... 03:38:27 INFO - Return code: 0 03:38:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:28 INFO - Reading from file tmpfile_stdout 03:38:28 INFO - Current package versions: 03:38:28 INFO - argparse == 1.2.1 03:38:28 INFO - blessings == 1.6 03:38:28 INFO - blobuploader == 1.2.4 03:38:28 INFO - docopt == 0.6.1 03:38:28 INFO - manifestparser == 1.1 03:38:28 INFO - mozInstall == 1.12 03:38:28 INFO - mozcrash == 0.17 03:38:28 INFO - mozdebug == 0.1 03:38:28 INFO - mozdevice == 0.48 03:38:28 INFO - mozfile == 1.2 03:38:28 INFO - mozhttpd == 0.7 03:38:28 INFO - mozinfo == 0.9 03:38:28 INFO - mozleak == 0.1 03:38:28 INFO - mozlog == 3.1 03:38:28 INFO - moznetwork == 0.27 03:38:28 INFO - mozprocess == 0.22 03:38:28 INFO - mozprofile == 0.28 03:38:28 INFO - mozrunner == 6.11 03:38:28 INFO - mozscreenshot == 0.1 03:38:28 INFO - mozsystemmonitor == 0.0 03:38:28 INFO - moztest == 0.7 03:38:28 INFO - mozversion == 1.4 03:38:28 INFO - psutil == 3.1.1 03:38:28 INFO - requests == 1.2.3 03:38:28 INFO - wsgiref == 0.1.2 03:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:28 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:28 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:38:28 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:38:28 INFO - Using env: {'DISPLAY': ':0', 03:38:28 INFO - 'HOME': '/home/cltbld', 03:38:28 INFO - 'LANG': 'en_US.UTF-8', 03:38:28 INFO - 'LANGUAGE': 'en_US:en', 03:38:28 INFO - 'LOGNAME': 'cltbld', 03:38:28 INFO - 'MAIL': '/var/mail/cltbld', 03:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:28 INFO - 'MOZ_NO_REMOTE': '1', 03:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:28 INFO - 'NO_EM_RESTART': '1', 03:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:28 INFO - 'PWD': '/builds/slave/test', 03:38:28 INFO - 'SHELL': '/bin/bash', 03:38:28 INFO - 'SHLVL': '1', 03:38:28 INFO - 'TERM': 'linux', 03:38:28 INFO - 'TMOUT': '86400', 03:38:28 INFO - 'USER': 'cltbld', 03:38:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:28 INFO - '_': '/tools/buildbot/bin/python'} 03:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 INFO - Cleaning up... 03:38:28 INFO - Return code: 0 03:38:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:28 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:28 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:38:28 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:38:28 INFO - Using env: {'DISPLAY': ':0', 03:38:28 INFO - 'HOME': '/home/cltbld', 03:38:28 INFO - 'LANG': 'en_US.UTF-8', 03:38:28 INFO - 'LANGUAGE': 'en_US:en', 03:38:28 INFO - 'LOGNAME': 'cltbld', 03:38:28 INFO - 'MAIL': '/var/mail/cltbld', 03:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:28 INFO - 'MOZ_NO_REMOTE': '1', 03:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:28 INFO - 'NO_EM_RESTART': '1', 03:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:28 INFO - 'PWD': '/builds/slave/test', 03:38:28 INFO - 'SHELL': '/bin/bash', 03:38:28 INFO - 'SHLVL': '1', 03:38:28 INFO - 'TERM': 'linux', 03:38:28 INFO - 'TMOUT': '86400', 03:38:28 INFO - 'USER': 'cltbld', 03:38:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:28 INFO - '_': '/tools/buildbot/bin/python'} 03:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:28 INFO - Downloading/unpacking jsonschema 03:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:30 INFO - Downloading/unpacking functools32 (from jsonschema) 03:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 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:38:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:30 INFO - warning: no files found matching '*.txt' 03:38:30 INFO - no previously-included directories found matching 'build' 03:38:30 INFO - no previously-included directories found matching 'dist' 03:38:30 INFO - no previously-included directories found matching '.git*' 03:38:30 INFO - Installing collected packages: jsonschema, functools32 03:38:30 INFO - Running setup.py install for functools32 03:38:30 INFO - warning: no files found matching '*.txt' 03:38:30 INFO - no previously-included directories found matching 'build' 03:38:30 INFO - no previously-included directories found matching 'dist' 03:38:30 INFO - no previously-included directories found matching '.git*' 03:38:30 INFO - Successfully installed jsonschema functools32 03:38:30 INFO - Cleaning up... 03:38:30 INFO - Return code: 0 03:38:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 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 0x7f7b31030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, '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': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', '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:38:30 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:38:30 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:38:30 INFO - Using env: {'DISPLAY': ':0', 03:38:30 INFO - 'HOME': '/home/cltbld', 03:38:30 INFO - 'LANG': 'en_US.UTF-8', 03:38:30 INFO - 'LANGUAGE': 'en_US:en', 03:38:30 INFO - 'LOGNAME': 'cltbld', 03:38:30 INFO - 'MAIL': '/var/mail/cltbld', 03:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:30 INFO - 'MOZ_NO_REMOTE': '1', 03:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:30 INFO - 'NO_EM_RESTART': '1', 03:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:30 INFO - 'PWD': '/builds/slave/test', 03:38:30 INFO - 'SHELL': '/bin/bash', 03:38:30 INFO - 'SHLVL': '1', 03:38:30 INFO - 'TERM': 'linux', 03:38:30 INFO - 'TMOUT': '86400', 03:38:30 INFO - 'USER': 'cltbld', 03:38:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:30 INFO - '_': '/tools/buildbot/bin/python'} 03:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:31 INFO - Downloading/unpacking flake8 03:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:31 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:38:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:38:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:38:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:33 INFO - no previously-included directories found matching 'docs/_build' 03:38:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:38:33 INFO - Running setup.py install for pep8 03:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:38:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:38:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:38:33 INFO - no previously-included directories found matching 'docs/_build' 03:38:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:38:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:38:33 INFO - Cleaning up... 03:38:34 INFO - Return code: 0 03:38:34 INFO - Running post-action listener: _resource_record_post_action 03:38:34 INFO - Running post-action listener: _start_resource_monitoring 03:38:34 INFO - Starting resource monitoring. 03:38:34 INFO - ##### 03:38:34 INFO - ##### Running install step. 03:38:34 INFO - ##### 03:38:34 INFO - Running pre-action listener: _resource_record_pre_action 03:38:34 INFO - Running main action method: install 03:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:34 INFO - Reading from file tmpfile_stdout 03:38:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:38:34 INFO - Reading from file tmpfile_stdout 03:38:34 INFO - Output received: 03:38:34 INFO - Usage: mozinstall [options] installer 03:38:34 INFO - Options: 03:38:34 INFO - -h, --help show this help message and exit 03:38:34 INFO - -d DEST, --destination=DEST 03:38:34 INFO - Directory to install application into. [default: 03:38:34 INFO - "/builds/slave/test"] 03:38:34 INFO - --app=APP Application being installed. [default: firefox] 03:38:34 INFO - mkdir: /builds/slave/test/build/application 03:38:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:38:49 INFO - Reading from file tmpfile_stdout 03:38:49 INFO - Output received: 03:38:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:49 INFO - Running post-action listener: _resource_record_post_action 03:38:49 INFO - ##### 03:38:49 INFO - ##### Running run-tests step. 03:38:49 INFO - ##### 03:38:49 INFO - Running pre-action listener: _resource_record_pre_action 03:38:49 INFO - Running main action method: run_tests 03:38:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:49 INFO - Python 2.7.3 03:38:49 INFO - Return code: 0 03:38:49 INFO - grabbing minidump binary from tooltool 03:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:49 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 0x1bbb410>, '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 0x1bbc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:49 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:38:49 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:38:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:50 INFO - Return code: 0 03:38:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:38:50 INFO - Return code: 0 03:38:50 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:38:50 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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:38:50 INFO - Using env: {'DISPLAY': ':0', 03:38:50 INFO - 'HOME': '/home/cltbld', 03:38:50 INFO - 'LANG': 'en_US.UTF-8', 03:38:50 INFO - 'LANGUAGE': 'en_US:en', 03:38:50 INFO - 'LOGNAME': 'cltbld', 03:38:50 INFO - 'MAIL': '/var/mail/cltbld', 03:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:50 INFO - 'MOZ_NO_REMOTE': '1', 03:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:50 INFO - 'NO_EM_RESTART': '1', 03:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:50 INFO - 'PWD': '/builds/slave/test', 03:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:50 INFO - 'SHELL': '/bin/bash', 03:38:50 INFO - 'SHLVL': '1', 03:38:50 INFO - 'TERM': 'linux', 03:38:50 INFO - 'TMOUT': '86400', 03:38:50 INFO - 'USER': 'cltbld', 03:38:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869', 03:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:50 INFO - '_': '/tools/buildbot/bin/python'} 03:38:50 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/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:38:51 INFO - mozversion application_buildid: 20160525183450 03:38:51 INFO - mozversion application_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:51 INFO - mozversion application_name: Firefox 03:38:51 INFO - mozversion application_remotingname: firefox-dev 03:38:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:51 INFO - mozversion application_vendor: Mozilla 03:38:51 INFO - mozversion application_version: 48.0a2 03:38:51 INFO - mozversion platform_buildid: 20160525183450 03:38:51 INFO - mozversion platform_changeset: 33693d8bdec17f07fc460ca7cc908ade88f97b86 03:38:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:51 INFO - mozversion platform_version: 48.0a2 03:38:51 INFO - using testdate: 1464431931 03:38:51 INFO - actual date: 1464431931 03:38:51 INFO - starting webserver on 'localhost:44193' 03:38:51 INFO - SUITE-START | Running 2 tests 03:38:51 INFO - TEST-START | dromaeo_css 03:38:51 INFO - operating with platform_type : linux_ 03:38:51 INFO - Initialising browser for dromaeo_css test... 03:38:51 INFO - TEST-INFO | started process 29816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp28aNl9/profile http://localhost:44193/getInfo.html) 03:38:56 INFO - PROCESS | 29816 | 03:38:56 INFO - PROCESS | 29816 | (process:29898): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:38:57 INFO - PROCESS | 29816 | __metrics Screen width/height:1600/1200 03:38:57 INFO - PROCESS | 29816 | colorDepth:24 03:38:57 INFO - PROCESS | 29816 | Browser inner width/height: 1024/697 03:38:57 INFO - PROCESS | 29816 | __metrics 03:38:58 ERROR - PROCESS | 29816 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:38:59 INFO - TEST-INFO | 29816: exit 0 03:38:59 INFO - Browser initialized. 03:38:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:59 INFO - TEST-INFO | started process 29949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp28aNl9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:01 INFO - PROCESS | 29949 | 03:39:01 INFO - PROCESS | 29949 | (process:30021): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:39:11 INFO - PROCESS | 29949 | RSS: Main: 152096768 03:39:11 INFO - PROCESS | 29949 | 03:40:01 INFO - PROCESS | 29949 | 1464432001030 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:42:08 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44193/tests/dromaeo/cssquery-ext.html) 03:42:09 INFO - PROCESS | 29949 | RSS: Main: 155344896 03:42:09 INFO - PROCESS | 29949 | 03:45:11 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-ext.html (next: http://localhost:44193/tests/dromaeo/cssquery-jquery.html) 03:45:11 INFO - PROCESS | 29949 | RSS: Main: 153821184 03:45:11 INFO - PROCESS | 29949 | 03:48:13 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44193/tests/dromaeo/cssquery-mootools.html) 03:48:14 INFO - PROCESS | 29949 | RSS: Main: 152969216 03:48:14 INFO - PROCESS | 29949 | 03:51:15 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44193/tests/dromaeo/cssquery-prototype.html) 03:51:16 INFO - PROCESS | 29949 | RSS: Main: 152842240 03:51:16 INFO - PROCESS | 29949 | 03:54:18 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44193/tests/dromaeo/cssquery-yui.html) 03:54:19 INFO - PROCESS | 29949 | RSS: Main: 154279936 03:54:19 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | Cycle 1(1): loaded http://localhost:44193/tests/dromaeo/cssquery-yui.html (next: http://localhost:44193/tests/dromaeo/cssquery-dojo.html) 03:57:21 INFO - PROCESS | 29949 | RSS: Main: 155926528 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | __start_tp_report 03:57:21 INFO - PROCESS | 29949 | _x_x_mozilla_page_load 03:57:21 INFO - PROCESS | 29949 | _x_x_mozilla_page_load_details 03:57:21 INFO - PROCESS | 29949 | |i|pagename|runs| 03:57:21 INFO - PROCESS | 29949 | |0;dojo.html;3405.6424075472078;3439.5184674145607;3444.8449819758107;3473.8784142555;3475.669811367919;5691.686957217351;5745.052066409048;5749.166370876221;5761.251037365142;5763.049096899007;5744.052231381817;5746.655200687951;5754.482096611304;5769.394213607574;5776.249087618614;5168.0180765654495;5201.323827902367;5251;5271.841844744664;5274.103402421598;5086.389633243997;5235.895282094356;5359.7320133993335;5363.731813409334;5386.2997810284805;5211.609129315298;5220.034293655667;5281.075811732951;5299.258103865462;5330.600204984622;5265.815191581902;5268.47315268472;5287.180487024537;5301.920471192935;5305.389880163753;5095.745212739385;5149.974250128763;5175.508326708957;5256.342957130359;5258.526732594085;5471.781128754845;5535.474129957647;5559.499645031926;5570.86072848178;5614.073677843151;6148.538859585549;6157.938420615781;6183.752649893999;6198.442140207403;6199.380061993809;6104.2980057293535;6142.416470435302;6193.256809182927;6203.906941395882;6218.067289906505;5761.913571296476;5795.710214489259;5806.535477161817;5815.941840581582;5823.592348535604;6269.529785266123;6308.3060863305;6313;6319.557630965788;6326.2724786649205;5870.559708021916;6037.215162028908;6055.666938318347;6071.605345652519;6110.083487476914;6161.630302181794;6170.50635949123;6188.535859810532;6203.937960620336;6207.255129384413;6031.09533569968;6139.10982907476;6158.261008678897;6167.321594624587;6169.876602468015;5969.880602387928;6102.786402475892;6137.60105593135;6138.664296166039;6155.446009859134;4583.816647334069;4590.632749380042;4593.6095431888;4600.700954437951;4609.1703493371515;4130.194612050681;4137.50349958001;4143.19207754491;4150.107726838744;4161.4382058421725;5829.795957141565;5855.736491857877;5885.646861188342;5917.171595976567;5940.940590594125;6155.692215389213;6225.439710426083;6238.282597501255;6249.281332646713;6256.468200203034;5662.66024038559;5884.911726324109;5901.468867801833;5903.439173278532;5925.200097986803;5204.479552044765;5220.608454365862;5259.21111833228;5282.550983166474;5322.787088516416;6343.841403964845;6349.492040636738;6383.425491705769;6388.073729309224;6394.520410969196;6176.7838125665385;6219.844503887258;6221.595596286227;6223.782167624111;6229.813105606839;6130.356312587114;6191.288001879661;6195.318514963441;6286.622802631857;6288.591241569284;6079.05774604937;6100.969495152496;6123.632582044914;6131.264248290234;6151.323354431099;6198.442140207403;6225.439710425902;6228.781992630236;6237.750489980532;6240.53196010292;5907.940920590739;5949.8215053548465;5979.162917191684;6014;6024.679530360336;5980.43185897339;6021.277446706424;6022.939770602413;6025.21672182631;6028.2766068072115;5778.479936805707;5874.618149820248;5917.615355001911;5937.3468918418075;5946.554008449297;6046.848828779316;6055.969720151371;6058.848528786815;6063.333033366238;6114.327423983269;5851.502622277154;5896.764129434775;5897.321807992136;5906.70466476683;5918.704064796657 03:57:21 INFO - PROCESS | 29949 | |1;ext.html;653.340126472263;660.2769966886258;666.9533132680712;675.2201207605215;752.7177308509309;38567.61432385675;40047.79976100115;40059.399109013386;40319.596804031986;40414.39378409326;41215.38176927349;41422;41581;41875.371869421986;41888;8582.313414926823;8685.739427817176;8769.605367758435;8800.515971621558;8811.735647930573;8618.525981071038;8717.869231961526;8892.199702026815;8923.241524470428;8953.23897468716;8845.248153906894;8952.820943581124;8972.955135224314;8973.371863969525;8975.95512022439;8896.555172241362;8898.73303800887;8906.643734250621;8927.598258078402;8955.2835773138;8822.779430514289;8873.645054197825;8917.0637083106;8917.777055573662;8923;33099;41835.163296733896;42015;42041.369379459335;42460;3446.5174875517446;3751.6248375162268;3774.3960966245268;3858.9421158682644;3892.260470510594;27971.720282797116;28242.43515129686;28642.14073577796;28688.13935581936;28806.567901481285;4311.482622085338;4369.737815731066;4405.691601587891;4409.360642706822;4470.150671372428;200422;202916;203279;204027;204624.99999999852;35488.822555887054;39009.80495097506;39472.605273946894;39650.40524392136;39709.80870573888;37756.811215943744;37777.81111094427;37792.43311350332;37835;37966.81016594899;16464.094474804002;16527.50417487453;16586.502404927873;16610.58473538171;16650;13592.320383980761;13649.317534123453;13677.974151938644;13741.03812733099;13906;9072.04743501936;9127.406718563272;9161.541922903829;9192.586333615003;9210.769730756785;3508.3509550733197;3551.7158627309755;3565.8751943681846;3618.4029635109914;3651.2514934438377;1131.6322195286564;1137.7610701752724;1164.0803765025535;1257.1577043380958;1263.3367482071985;32737.67262327394;33512.16219594481;33686.49470257948;33783.493247601305;34368;1193.3019183777587;1209.2865209526421;1223.5289413575838;1277.770001399757;1374.2785037855206;15664.373425063097;15922.65374255288;16078.598035048983;16278.918605407134;16791;535035;601501;611289;638268;648477;57532.424675753544;59144.40855591475;59182.40817591855;59274;59419.702901485216;1519.7264492391255;1523.4972459088474;1541.6839547892655;1548.0479505104279;1561.039960424331;30696.693033069383;31112.68887311098;31630.841845790623;32034.67965320317;32234.516482253253;54507.454925450234;54710.17934730903;55216.171757424476;55236.72381638227;55360.16959745688;470946;471865;479071;483688;492908;30960.69039309668;31945.201369965936;31978.68021319757;32087.518687220178;32156.83921580377;51866.40667966511;51874.481255188475;52669.47330526646;52860;53699.73150134224;43259.78370108255;43529;43559.56440435682;43758.781206093765;44349.33475997927;42548;42574;42916;43098.569014309454;43525.3471197926;44040.7797961021;44413.33379999238;46077.76961115173;46636;46822;35047;36400.453993190655;36529.45205821968;36712.449313259785;37616.81191594025;29164.7083529162;29817.70182298236;30153.547696784128;30197;30274.394512109193 03:57:21 INFO - PROCESS | 29949 | |2;jquery.html;424.1516966067864;427.2373812744252;428.4729782367686;437.74829473052995;443.5032763305099;18441.170147343368;19172.904135479337;19181.232750689975;19702.40892773219;20417.59164816703;18606.255749770025;19180.328688495905;19354;19467.123979420925;19474;5226.189940559219;5375.569954403658;5380.515753582177;5413.215083812865;5433.809816656418;5332.066888294552;5359.785608575652;5402.162664786944;5534.806281780138;5782.942170578303;5741.511971482429;5742.684152371638;5754.280714910637;5790.739416726257;5794.246747922764;5923.703814809264;6352.205974253218;6383.616982981036;6385.010323399881;6405.935940640604;5620.4660557247;5692.57305702074;5713.628614140109;5720.3135623725;5722.599418040739;20862;21503.2473863414;22654.773452265596;22738;22920;2347.600907845653;2417.915372961938;2472.5920223163157;2566.974330256711;2592.157548796649;10594;10689.251752377337;11186.944065279622;13947.232902190375;14787.852121478754;1970.9901450492655;1973.6151450467164;2104.8210902073342;2161.53526991696;2277.749447560767;73686.63156684236;78604.21395786027;79702;80801.19198808054;83042;10830.620928267474;11263.831042534368;11266.887331126583;11283.548658053585;11348.943255283835;15762.921185394;15807.841921580866;15904.363825447084;15912.124833134289;16006.119663418624;7266.564006159648;8295.129011453831;8343.249107580226;8532.57337133141;8558.828823423497;8347.499150051017;8448.281896038783;8462.36532260083;8544.18830211129;8592.8711069334;4589.655775816827;4633.907321853611;4692.131955588227;4703.45910220329;4743.359646447685;1966.2331690640663;2025.888576128327;2039.7858224886172;2045.5908818236114;2087.5511764970606;467.1614452058563;992.2359782967075;1046.7487802927242;1049.2602715085845;1087.2009073331096;11436.885631143748;11928.642140735792;11944;11963.820542691867;12071.155019148575;492.68714366377606;513.7585334892594;521.9060569097599;528.3026405145248;528.5797790756358;5116.181410974226;6600.141981542369;6624;6644.4020038196795;6692.59844409337;557990;584317;586557;591586;608510;89840;100779;103000.48499757603;103129;104936.47531762446;1097.6268068856627;1129.689335432746;1180.504188240941;1181.1908842442954;1186.4008675618757;16435.67128657444;16720.331186752395;16898.74651880198;16990.830091698925;17049.232784524975;37791;40331;40723;41434.37848432336;42817.57182428136;57886.7105664469;57968.420315796306;58061.96783112571;58080.70959645175;58407.4159258402;8344.332453403835;8704.91295087041;8884.200421961796;8935.28517718568;8971.013188549125;11552.768944621228;13313.600591982256;13495.662608434868;13574.660633483847;13652.453901843815;11964.820527691918;12048.397580120783;12156.696082598006;12259.080568957543;12367.381630918599;11631.243969141979;11639.127065470293;11688.298702077902;12169.2698438094;12361.134720569475;6219.813405597839;8508.91491085106;11828.349440780496;11951.76096478083;12448.128630995743;8471.449355791854;8723.302135828992;8836.602352894006;8846.601902914255;8852.026277109642;10686.465676716289;11538;11957.342346171044;12119.515219391125;12194.390280485763 03:57:21 INFO - PROCESS | 29949 | |3;mootools.html;1593.2193225319593;1604.2540218798256;1808.222464340334;1890.3761758619657;1913.6077104193632;8233.135520770307;8299.33605311575;8437.578121093944;8750.737477875675;8756.824863502727;8286.544240066794;8294.62674179662;8381.497110173394;8398.664053437855;8448.788780280496;2326.3253656439656;2341.8360714749974;2351.423901144222;2361.1499860050367;2364.290712786157;2364.9054037838464;2382.404398900275;2390.3546042568496;2394.1141777542334;2397.2808157552663;2362.0197617988515;2367.9408014799596;2376.1683410806168;2397.1250493569896;2422.236995346469;2357.4695693468916;2357.8821058946983;2368.7275963264274;2368.7749663781915;2375.239923224569;2344.742078371378;2344.9296521104393;2376.7623237676266;2378.096323397098;2378.4648454097864;8428.157184281585;8471.06818249992;8512.319014478826;8537.487750734976;8544.530050847201;5216.634835561512;5252.606054545886;5284.10170271051;5291.973540132313;5322.1484562470205;3399.7450191235507;3408.352413041539;3427.9485807712904;3442.0362298556443;3448.499967504698;1124.6738445850776;1154.457405019648;1170.280277629252;1187.352892673495;1198.5086114693022;11200.943995279971;11216;11262.380569068699;11265.549378024869;11294.491747871283;4270.42349282849;4305.4187684662165;4353.020570371705;4356.6732495063;4380.255356589388;9275.16523512887;9324.627014919328;9331.393459425251;9332.44005359667;9359.298052645943;5016.347874776256;5017.147084995559;5044.848654540369;5049.065922804293;5071.492850714899;4058.2086493134148;4711.95288047122;4726.905461890743;4737.692050016807;4773.498782627844;4061.7156799024374;4109.684900831765;4111;4114.547399786021;4211.368294755811;1282.3011458755002;1297.5653156192782;1312.5996571045923;1330.9334533273297;1336.2917653643585;982.886967998675;1043.9247574997764;1104.2325583719237;1109.8668159820872;1113.3264375053138;5848.2397288353095;5916.0362557086855;5979.790707325223;6152.753889844356;6159.84600384985;438.66880505218995;443.46562392317827;447.1414883423834;449.566168647257;459.64607252415453;4134.431453244182;4181.121964387452;4219.9578004220175;4237.131388065439;4294.012377153273;9828.508574571386;10182.083612474913;10203.336783109222;10221.437820919771;10346.275760696679;10176.440295783803;10182.389056656477;10212.846807297896;10214.846777298346;10226.948865255627;7674.53952762836;7883.2905038546805;8004.959975200087;8014.479058861155;8074.878876816852;5897.262842144732;5953.642781433128;5958.76164953397;6016.187814645142;6065.5754097212775;8679.956600216958;8842.204201621886;8923.73228803137;9030.36787424874;9083.36416450842;8919.55402229873;9100.362974591715;9162.26701863836;9193.080691930754;9208.861867071866;6831.6242606657115;7147.678354473957;7301.160366557914;7329.120505539369;7438.330550250504;7860.135385107748;7868.8819667706175;7906.288434040964;7938.56337901421;7950.602469876368;6945.513814032969;6986.9650651746415;7027.648617568999;7067.646617668993;7277.3086556777025;7032.156141263081;7054.01243825875;7086.326798954091;7090.964545177241;7180.138383393817;6720.32796720324;6820.045193672989;7021.964890175516;7023.122109736283;7027.15674119109;5168.095583272988;5207.895842083061;5227.215917612389;5378.919316210338;5409.675419474844;5202.479752024768;5209.661372010807;5261.57907367402;5281.1286137788375;5379.488948549882 03:57:21 INFO - PROCESS | 29949 | |4;prototype.html;343.53794146872445;354.831455058847;359.3298498300669;362.4056547262488;364.3350884635541;6551.11559939408;6675.799726008221;6766.12040434744;6810.046593476911;6817.727290908364;6693.665316734156;6695.096162018126;6714.865702685944;6720.428763555092;6748.392644661992;5074.213496907985;5080.212567052113;5082.212257100137;5087.618428617869;5089.7455127243675;5076.213186956028;5082.872928176806;5086.6693664911845;5097.847064588068;5101.897962040757;5013.3232013678235;5017.172166592508;5020.272060551218;5042.344495215617;5044;4786.856394308176;4928.605711543068;5010.048090862742;5031.0441016206805;5040.924386134193;4266.0827921996915;4280.957190428087;4286.335617979218;4301.0537681709975;4306.203352379788;6348.77779277723;6379.744810207586;6385.7764978226005;6393.552451328409;6407.551471397004;5768.913466298009;5794.82615521535;5819.621724587888;5821.068629019379;5821.621594596338;7003.3346832050875;7019.754308599226;7021.1574611047;7021.543599666005;7027.43780497559;4635;4774.069056533943;4780.163471392527;4792.568668819823;4797.2564252540915;7233.7468188613675;7332.743353982638;7364.300391462856;7389.4457915656;7389.741359052461;4906.165951788204;4913.336699545515;4916.06594746997;4930.161872481687;4932.679375840559;4971.279164521125;4982.103221420107;4984.37695288089;4991.301217829507;4995.825146119941;5801.9419805802245;5803.042497987869;5805.622634528742;5816.040353341651;5821.738021788945;6868.313168683092;7110.25342339047;7118.964405178044;7126.144862616416;7136.250693677193;1728.7666165067556;1736.791585009807;1743.46824218612;1747.2137538107647;1747.4932269641915;1042.3797840285017;1127.7067962329854;1132.5413207650915;1141.2410746853416;1145.5475087340453;6750.628715420699;6846.863062738717;6871.347222013901;6924.4114250288285;6942.236354001056;7329.5968721719755;7381.594012329373;7418.295261950106;7418.369438597671;7425.85148297031;6889.0355350251;6892.931070689329;6896.413804826546;6898.172219333612;6918.654067296615;3936.291467535871;3963.583823698528;3973.8211780469946;4003.8798836034966;4010.63904248619;7604.657790399446;7611.619419029026;7634;7727.38180945523;7729.497582657222;7523.210062943313;7528.435367347471;7532.7740167795055;7555.16893141754;7559.1684914659345;7601.277878601524;7602.771916842504;7607.505512141804;7607.972923655236;7612.657430415645;7199.928000720135;7337.70649174027;7353.742619008309;7360.852782944418;7394.7781566553085;7239.058922340062;7268.055152830098;7271.854562908818;7272.854542909006;7286;7521.285477879593;7568.318851303409;7569.962150189213;7585.962070189614;7606.973058637234;5059.671121377099;5093.592512599057;5095.898082038412;5114.9232761507865;5116.334876466036;7154.213036566078;7287.890681639886;7293.452991025801;7295.562266264041;7301.817454563678;7052.788416347517;7059.188193357624;7065.717371305091;7096;7103.183133939457;7005.089338386181;7016.6842492089;7034.120734908137;7039.049728286615;7044.084269044992;6911.067005954333;6922.446204303745;6927.7228910845015;6932.757353492603;6942.826429339105;6930.653467326714;6970;7032.6132062735;7089.184743754534;7105.573665580082;6797.6941037654415;6932.48006399512;7029.683664235224;7048.189458212371;7072.929270707433 03:57:21 INFO - PROCESS | 29949 | |5;yui.html;747.6635514018693;767.3209209849282;785.2069409896003;842.6713581703135;843.1273631791096;14325.570232893017;14488.63778405539;14539.636509087251;14543.200123993176;14595.97828152031;13892.722145557083;13921.373538190806;13924.094933829294;13941.442342306322;13955.092918960261;736.871047566675;872.655301156043;896.4397251717677;902.7111324376202;903.891533016039;893.1871996483202;897.3583887520422;898.1602201941173;898.7213963671251;899.2266650680409;943.5470973932482;945.716285114463;948.35511851941;948.8624149498353;949.5964215208509;920.8572671235969;928.6192661008988;934.0192797562567;935.1209862729013;941.7316064921499;680.3468670076733;681.580827790905;682.147315855181;686.739039165119;694.3611877073055;14850;14943.850561494355;14948.775768363483;14970.62573435662;14972.251387430693;13899.79150312746;14515.637109072251;14516;14956.925215373854;15404.691906161926;11868.643940681794;12009.579664711693;12093.697657558632;12139.696507587292;12176.878231217663;4036.2936486114813;4044.838206471767;4100.384942258685;4109.794510274474;4156.168766246763;57917.131243031385;58482.707586461795;58940;58982.41017589855;59047.70476147635;10187.235957303084;10456.477176141163;10570.471476426148;10795.46022698862;11043.72390690223;18846.52883677919;18903.810961890205;18910.149043293084;18914.716279255823;18934.337298194496;7497.587632680146;7609.162992070867;7884.684612615546;7885.684572617031;7958.602069896482;4725.810967561328;4878.926816097762;4936.901261974812;5010.3737032870895;5019.096562618691;3389.74576906733;3457.6715212054814;3474.513568100468;3480.651934806499;3486.930261394758;643.5270076493773;661.2593894837717;664.7905909638448;669.7823207457595;677.9118714567074;766.0807031562148;774.9302562769378;775.1473379282744;796.7649543384715;798.3134504326275;9873.80252394948;10310.845337319946;10463;10656.307340022873;10667.413292269;838.1618381618382;839.2446797881955;848.1391387741447;857.9313654907593;873.4366333714719;4795.640326975421;4812.807487700453;4892.437369702458;4910.435299940481;4917.631177661689;57471;70334.2966570338;70450;70755.6462217696;71016.289837102;58862.11706824401;58888.41111588915;59371.999999999134;59407.40592594105;59739.701301493216;55338.16992745112;55719.164212536845;55760.16359754607;55894.441055589734;56526.71736641291;10190.592376304865;10214.438205898747;10385.169186464913;10465.895341046493;10507.31702439339;39060;39710.60289397069;39900.60099399085;40337.193256134124;40573.39139912845;47667.76166119147;48197.75901120472;52379.73810130925;53033;54399.72800135974;12521.812172817597;12558.937205313914;12706.745865082832;12765.170263932814;12892.935535322264;13320;13398.397072131582;13629.79555306691;13740.381682824496;14277.500287489887;13667.248301343521;13756.105853119516;13824.861751382357;13849.307534623027;14494.275286235435;12891.16207446513;13097.672558186121;13483.662908427368;13752.587422377344;13910.791338130139;12224.633261002184;13445;13778.931105344811;14185.858141418454;14196.858031419553;10508.737281568023;10644.680659580225;10675.679729608124;10739.516721747696;10860.076893464144;10574.682759517227;10640.414777187329;10975.780484390109;10980.780384392427;11029.172812038969 03:57:21 INFO - PROCESS | 29949 | __end_tp_report 03:57:21 INFO - PROCESS | 29949 | __start_cc_report 03:57:21 INFO - PROCESS | 29949 | _x_x_mozilla_cycle_collect,324 03:57:21 INFO - PROCESS | 29949 | __end_cc_report 03:57:21 INFO - PROCESS | 29949 | __startTimestamp1464433041786__endTimestamp 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | ------- Summary: start ------- 03:57:21 INFO - PROCESS | 29949 | Number of tests: 6 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#0] dojo.html Cycles:165 Average:5715.86 Median:5918.70 stddev:645.88 (10.9%) stddev-sans-first:621.91 03:57:21 INFO - PROCESS | 29949 | Values: 3405.6 3439.5 3444.8 3473.9 3475.7 5691.7 5745.1 5749.2 5761.3 5763.0 5744.1 5746.7 5754.5 5769.4 5776.2 5168.0 5201.3 5251.0 5271.8 5274.1 5086.4 5235.9 5359.7 5363.7 5386.3 5211.6 5220.0 5281.1 5299.3 5330.6 5265.8 5268.5 5287.2 5301.9 5305.4 5095.7 5150.0 5175.5 5256.3 5258.5 5471.8 5535.5 5559.5 5570.9 5614.1 6148.5 6157.9 6183.8 6198.4 6199.4 6104.3 6142.4 6193.3 6203.9 6218.1 5761.9 5795.7 5806.5 5815.9 5823.6 6269.5 6308.3 6313.0 6319.6 6326.3 5870.6 6037.2 6055.7 6071.6 6110.1 6161.6 6170.5 6188.5 6203.9 6207.3 6031.1 6139.1 6158.3 6167.3 6169.9 5969.9 6102.8 6137.6 6138.7 6155.4 4583.8 4590.6 4593.6 4600.7 4609.2 4130.2 4137.5 4143.2 4150.1 4161.4 5829.8 5855.7 5885.6 5917.2 5940.9 6155.7 6225.4 6238.3 6249.3 6256.5 5662.7 5884.9 5901.5 5903.4 5925.2 5204.5 5220.6 5259.2 5282.6 5322.8 6343.8 6349.5 6383.4 6388.1 6394.5 6176.8 6219.8 6221.6 6223.8 6229.8 6130.4 6191.3 6195.3 6286.6 6288.6 6079.1 6101.0 6123.6 6131.3 6151.3 6198.4 6225.4 6228.8 6237.8 6240.5 5907.9 5949.8 5979.2 6014.0 6024.7 5980.4 6021.3 6022.9 6025.2 6028.3 5778.5 5874.6 5917.6 5937.3 5946.6 6046.8 6056.0 6058.8 6063.3 6114.3 5851.5 5896.8 5897.3 5906.7 5918.7 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#1] ext.html Cycles:180 Average:58187.84 Median:40814.89 stddev:123931.82 (303.6%) stddev-sans-first:124204.19 03:57:21 INFO - PROCESS | 29949 | Values: 653.3 660.3 667.0 675.2 752.7 38567.6 40047.8 40059.4 40319.6 40414.4 41215.4 41422.0 41581.0 41875.4 41888.0 8582.3 8685.7 8769.6 8800.5 8811.7 8618.5 8717.9 8892.2 8923.2 8953.2 8845.2 8952.8 8973.0 8973.4 8976.0 8896.6 8898.7 8906.6 8927.6 8955.3 8822.8 8873.6 8917.1 8917.8 8923.0 33099.0 41835.2 42015.0 42041.4 42460.0 3446.5 3751.6 3774.4 3858.9 3892.3 27971.7 28242.4 28642.1 28688.1 28806.6 4311.5 4369.7 4405.7 4409.4 4470.2 200422.0 202916.0 203279.0 204027.0 204625.0 35488.8 39009.8 39472.6 39650.4 39709.8 37756.8 37777.8 37792.4 37835.0 37966.8 16464.1 16527.5 16586.5 16610.6 16650.0 13592.3 13649.3 13678.0 13741.0 13906.0 9072.0 9127.4 9161.5 9192.6 9210.8 3508.4 3551.7 3565.9 3618.4 3651.3 1131.6 1137.8 1164.1 1257.2 1263.3 32737.7 33512.2 33686.5 33783.5 34368.0 1193.3 1209.3 1223.5 1277.8 1374.3 15664.4 15922.7 16078.6 16278.9 16791.0 535035.0 601501.0 611289.0 638268.0 648477.0 57532.4 59144.4 59182.4 59274.0 59419.7 1519.7 1523.5 1541.7 1548.0 1561.0 30696.7 31112.7 31630.8 32034.7 32234.5 54507.5 54710.2 55216.2 55236.7 55360.2 470946.0 471865.0 479071.0 483688.0 492908.0 30960.7 31945.2 31978.7 32087.5 32156.8 51866.4 51874.5 52669.5 52860.0 53699.7 43259.8 43529.0 43559.6 43758.8 44349.3 42548.0 42574.0 42916.0 43098.6 43525.3 44040.8 44413.3 46077.8 46636.0 46822.0 35047.0 36400.5 36529.5 36712.4 37616.8 29164.7 29817.7 30153.5 30197.0 30274.4 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#2] jquery.html Cycles:180 Average:31534.55 Median:39061.00 stddev:96366.15 (246.7%) stddev-sans-first:96608.17 03:57:21 INFO - PROCESS | 29949 | Values: 424.2 427.2 428.5 437.7 443.5 18441.2 19172.9 19181.2 19702.4 20417.6 18606.3 19180.3 19354.0 19467.1 19474.0 5226.2 5375.6 5380.5 5413.2 5433.8 5332.1 5359.8 5402.2 5534.8 5782.9 5741.5 5742.7 5754.3 5790.7 5794.2 5923.7 6352.2 6383.6 6385.0 6405.9 5620.5 5692.6 5713.6 5720.3 5722.6 20862.0 21503.2 22654.8 22738.0 22920.0 2347.6 2417.9 2472.6 2567.0 2592.2 10594.0 10689.3 11186.9 13947.2 14787.9 1971.0 1973.6 2104.8 2161.5 2277.7 73686.6 78604.2 79702.0 80801.2 83042.0 10830.6 11263.8 11266.9 11283.5 11348.9 15762.9 15807.8 15904.4 15912.1 16006.1 7266.6 8295.1 8343.2 8532.6 8558.8 8347.5 8448.3 8462.4 8544.2 8592.9 4589.7 4633.9 4692.1 4703.5 4743.4 1966.2 2025.9 2039.8 2045.6 2087.6 467.2 992.2 1046.7 1049.3 1087.2 11436.9 11928.6 11944.0 11963.8 12071.2 492.7 513.8 521.9 528.3 528.6 5116.2 6600.1 6624.0 6644.4 6692.6 557990.0 584317.0 586557.0 591586.0 608510.0 89840.0 100779.0 103000.5 103129.0 104936.5 1097.6 1129.7 1180.5 1181.2 1186.4 16435.7 16720.3 16898.7 16990.8 17049.2 37791.0 40331.0 40723.0 41434.4 42817.6 57886.7 57968.4 58062.0 58080.7 58407.4 8344.3 8704.9 8884.2 8935.3 8971.0 11552.8 13313.6 13495.7 13574.7 13652.5 11964.8 12048.4 12156.7 12259.1 12367.4 11631.2 11639.1 11688.3 12169.3 12361.1 6219.8 8508.9 11828.3 11951.8 12448.1 8471.4 8723.3 8836.6 8846.6 8852.0 10686.5 11538.0 11957.3 12119.5 12194.4 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#3] mootools.html Cycles:180 Average:5544.07 Median:5046.96 stddev:2987.52 (59.2%) stddev-sans-first:2981.15 03:57:21 INFO - PROCESS | 29949 | Values: 1593.2 1604.3 1808.2 1890.4 1913.6 8233.1 8299.3 8437.6 8750.7 8756.8 8286.5 8294.6 8381.5 8398.7 8448.8 2326.3 2341.8 2351.4 2361.1 2364.3 2364.9 2382.4 2390.4 2394.1 2397.3 2362.0 2367.9 2376.2 2397.1 2422.2 2357.5 2357.9 2368.7 2368.8 2375.2 2344.7 2344.9 2376.8 2378.1 2378.5 8428.2 8471.1 8512.3 8537.5 8544.5 5216.6 5252.6 5284.1 5292.0 5322.1 3399.7 3408.4 3427.9 3442.0 3448.5 1124.7 1154.5 1170.3 1187.4 1198.5 11200.9 11216.0 11262.4 11265.5 11294.5 4270.4 4305.4 4353.0 4356.7 4380.3 9275.2 9324.6 9331.4 9332.4 9359.3 5016.3 5017.1 5044.8 5049.1 5071.5 4058.2 4712.0 4726.9 4737.7 4773.5 4061.7 4109.7 4111.0 4114.5 4211.4 1282.3 1297.6 1312.6 1330.9 1336.3 982.9 1043.9 1104.2 1109.9 1113.3 5848.2 5916.0 5979.8 6152.8 6159.8 438.7 443.5 447.1 449.6 459.6 4134.4 4181.1 4220.0 4237.1 4294.0 9828.5 10182.1 10203.3 10221.4 10346.3 10176.4 10182.4 10212.8 10214.8 10226.9 7674.5 7883.3 8005.0 8014.5 8074.9 5897.3 5953.6 5958.8 6016.2 6065.6 8680.0 8842.2 8923.7 9030.4 9083.4 8919.6 9100.4 9162.3 9193.1 9208.9 6831.6 7147.7 7301.2 7329.1 7438.3 7860.1 7868.9 7906.3 7938.6 7950.6 6945.5 6987.0 7027.6 7067.6 7277.3 7032.2 7054.0 7086.3 7091.0 7180.1 6720.3 6820.0 7022.0 7023.1 7027.2 5168.1 5207.9 5227.2 5378.9 5409.7 5202.5 5209.7 5261.6 5281.1 5379.5 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#4] prototype.html Cycles:180 Average:5908.36 Median:6813.89 stddev:1814.43 (26.6%) stddev-sans-first:1770.79 03:57:21 INFO - PROCESS | 29949 | Values: 343.5 354.8 359.3 362.4 364.3 6551.1 6675.8 6766.1 6810.0 6817.7 6693.7 6695.1 6714.9 6720.4 6748.4 5074.2 5080.2 5082.2 5087.6 5089.7 5076.2 5082.9 5086.7 5097.8 5101.9 5013.3 5017.2 5020.3 5042.3 5044.0 4786.9 4928.6 5010.0 5031.0 5040.9 4266.1 4281.0 4286.3 4301.1 4306.2 6348.8 6379.7 6385.8 6393.6 6407.6 5768.9 5794.8 5819.6 5821.1 5821.6 7003.3 7019.8 7021.2 7021.5 7027.4 4635.0 4774.1 4780.2 4792.6 4797.3 7233.7 7332.7 7364.3 7389.4 7389.7 4906.2 4913.3 4916.1 4930.2 4932.7 4971.3 4982.1 4984.4 4991.3 4995.8 5801.9 5803.0 5805.6 5816.0 5821.7 6868.3 7110.3 7119.0 7126.1 7136.3 1728.8 1736.8 1743.5 1747.2 1747.5 1042.4 1127.7 1132.5 1141.2 1145.5 6750.6 6846.9 6871.3 6924.4 6942.2 7329.6 7381.6 7418.3 7418.4 7425.9 6889.0 6892.9 6896.4 6898.2 6918.7 3936.3 3963.6 3973.8 4003.9 4010.6 7604.7 7611.6 7634.0 7727.4 7729.5 7523.2 7528.4 7532.8 7555.2 7559.2 7601.3 7602.8 7607.5 7608.0 7612.7 7199.9 7337.7 7353.7 7360.9 7394.8 7239.1 7268.1 7271.9 7272.9 7286.0 7521.3 7568.3 7570.0 7586.0 7607.0 5059.7 5093.6 5095.9 5114.9 5116.3 7154.2 7287.9 7293.5 7295.6 7301.8 7052.8 7059.2 7065.7 7096.0 7103.2 7005.1 7016.7 7034.1 7039.0 7044.1 6911.1 6922.4 6927.7 6932.8 6942.8 6930.7 6970.0 7032.6 7089.2 7105.6 6797.7 6932.5 7029.7 7048.2 7072.9 03:57:21 INFO - PROCESS | 29949 | 03:57:21 INFO - PROCESS | 29949 | [#5] yui.html Cycles:180 Average:15957.91 Median:22336.89 stddev:18855.99 (84.4%) stddev-sans-first:18874.29 03:57:21 INFO - PROCESS | 29949 | Values: 747.7 767.3 785.2 842.7 843.1 14325.6 14488.6 14539.6 14543.2 14596.0 13892.7 13921.4 13924.1 13941.4 13955.1 736.9 872.7 896.4 902.7 903.9 893.2 897.4 898.2 898.7 899.2 943.5 945.7 948.4 948.9 949.6 920.9 928.6 934.0 935.1 941.7 680.3 681.6 682.1 686.7 694.4 14850.0 14943.9 14948.8 14970.6 14972.3 13899.8 14515.6 14516.0 14956.9 15404.7 11868.6 12009.6 12093.7 12139.7 12176.9 4036.3 4044.8 4100.4 4109.8 4156.2 57917.1 58482.7 58940.0 58982.4 59047.7 10187.2 10456.5 10570.5 10795.5 11043.7 18846.5 18903.8 18910.1 18914.7 18934.3 7497.6 7609.2 7884.7 7885.7 7958.6 4725.8 4878.9 4936.9 5010.4 5019.1 3389.7 3457.7 3474.5 3480.7 3486.9 643.5 661.3 664.8 669.8 677.9 766.1 774.9 775.1 796.8 798.3 9873.8 10310.8 10463.0 10656.3 10667.4 838.2 839.2 848.1 857.9 873.4 4795.6 4812.8 4892.4 4910.4 4917.6 57471.0 70334.3 70450.0 70755.6 71016.3 58862.1 58888.4 59372.0 59407.4 59739.7 55338.2 55719.2 55760.2 55894.4 56526.7 10190.6 10214.4 10385.2 10465.9 10507.3 39060.0 39710.6 39900.6 40337.2 40573.4 47667.8 48197.8 52379.7 53033.0 54399.7 12521.8 12558.9 12706.7 12765.2 12892.9 13320.0 13398.4 13629.8 13740.4 14277.5 13667.2 13756.1 13824.9 13849.3 14494.3 12891.2 13097.7 13483.7 13752.6 13910.8 12224.6 13445.0 13778.9 14185.9 14196.9 10508.7 10644.7 10675.7 10739.5 10860.1 10574.7 10640.4 10975.8 10980.8 11029.2 03:57:21 INFO - PROCESS | 29949 | -------- Summary: end -------- 03:57:21 INFO - PROCESS | 29949 | 03:57:22 INFO - TEST-INFO | 29949: exit 0 03:57:22 INFO - TEST-OK | dromaeo_css | took 1111444ms 03:57:22 INFO - TEST-START | kraken 03:57:22 INFO - operating with platform_type : linux_ 03:57:22 INFO - Initialising browser for kraken test... 03:57:22 INFO - TEST-INFO | started process 30190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NUifv/profile http://localhost:44193/getInfo.html) 03:57:27 INFO - PROCESS | 30190 | 03:57:27 INFO - PROCESS | 30190 | (process:30267): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:28 INFO - PROCESS | 30190 | __metrics Screen width/height:1600/1200 03:57:28 INFO - PROCESS | 30190 | colorDepth:24 03:57:28 INFO - PROCESS | 30190 | Browser inner width/height: 1024/697 03:57:28 INFO - PROCESS | 30190 | __metrics 03:57:29 ERROR - PROCESS | 30190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:57:30 INFO - TEST-INFO | 30190: exit 0 03:57:30 INFO - Browser initialized. 03:57:30 INFO - Running cycle 1/1 for kraken test... 03:57:30 INFO - TEST-INFO | started process 30318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NUifv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:32 INFO - PROCESS | 30318 | 03:57:32 INFO - PROCESS | 30318 | (process:30385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:57:42 INFO - PROCESS | 30318 | RSS: Main: 151814144 03:57:42 INFO - PROCESS | 30318 | 03:57:44 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44193/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:45 INFO - PROCESS | 30318 | RSS: Main: 157036544 03:57:45 INFO - PROCESS | 30318 | 03:57:48 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44193/tests/kraken/driver.html?testName=audio-dft) 03:57:48 INFO - PROCESS | 30318 | RSS: Main: 157487104 03:57:48 INFO - PROCESS | 30318 | 03:57:51 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44193/tests/kraken/driver.html?testName=audio-fft) 03:57:52 INFO - PROCESS | 30318 | RSS: Main: 157290496 03:57:52 INFO - PROCESS | 30318 | 03:57:54 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44193/tests/kraken/driver.html?testName=audio-oscillator) 03:57:54 INFO - PROCESS | 30318 | RSS: Main: 156934144 03:57:54 INFO - PROCESS | 30318 | 03:57:57 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:57 INFO - PROCESS | 30318 | RSS: Main: 156778496 03:57:57 INFO - PROCESS | 30318 | 03:58:00 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44193/tests/kraken/driver.html?testName=imaging-darkroom) 03:58:01 INFO - PROCESS | 30318 | RSS: Main: 156688384 03:58:01 INFO - PROCESS | 30318 | 03:58:04 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44193/tests/kraken/driver.html?testName=imaging-desaturate) 03:58:05 INFO - PROCESS | 30318 | RSS: Main: 157380608 03:58:05 INFO - PROCESS | 30318 | 03:58:07 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44193/tests/kraken/driver.html?testName=json-parse-financial) 03:58:08 INFO - PROCESS | 30318 | RSS: Main: 157020160 03:58:08 INFO - PROCESS | 30318 | 03:58:10 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:58:10 INFO - PROCESS | 30318 | RSS: Main: 157265920 03:58:10 INFO - PROCESS | 30318 | 03:58:12 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:58:13 INFO - PROCESS | 30318 | RSS: Main: 157237248 03:58:13 INFO - PROCESS | 30318 | 03:58:15 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:58:15 INFO - PROCESS | 30318 | RSS: Main: 157483008 03:58:15 INFO - PROCESS | 30318 | 03:58:18 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:58:18 INFO - PROCESS | 30318 | RSS: Main: 158232576 03:58:18 INFO - PROCESS | 30318 | 03:58:21 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:58:22 INFO - PROCESS | 30318 | RSS: Main: 157794304 03:58:22 INFO - PROCESS | 30318 | 03:58:23 INFO - PROCESS | 30318 | Cycle 1(1): loaded http://localhost:44193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44193/tests/kraken/driver.html?testName=ai-astar) 03:58:23 INFO - PROCESS | 30318 | RSS: Main: 159297536 03:58:23 INFO - PROCESS | 30318 | 03:58:23 INFO - PROCESS | 30318 | __start_tp_report 03:58:23 INFO - PROCESS | 30318 | _x_x_mozilla_page_load 03:58:23 INFO - PROCESS | 30318 | _x_x_mozilla_page_load_details 03:58:23 INFO - PROCESS | 30318 | |i|pagename|runs| 03:58:23 INFO - PROCESS | 30318 | |0;ai-astar;111;111;104;112;112;115;101;110;113;109 03:58:23 INFO - PROCESS | 30318 | |1;audio-beat-detection;160;127;154;172;128;160;153;126;187;127 03:58:23 INFO - PROCESS | 30318 | |2;audio-dft;163;162;162;160;161;161;163;162;162;162 03:58:23 INFO - PROCESS | 30318 | |3;audio-fft;74;72;75;164;74;78;72;73;166;76 03:58:23 INFO - PROCESS | 30318 | |4;audio-oscillator;92;93;148;92;91;91;147;92;93;143 03:58:23 INFO - PROCESS | 30318 | |5;imaging-gaussian-blur;117;116;118;118;117;118;117;118;117;117 03:58:23 INFO - PROCESS | 30318 | |6;imaging-darkroom;147;149;147;146;146;146;146;146;147;146 03:58:23 INFO - PROCESS | 30318 | |7;imaging-desaturate;96;95;95;96;95;97;95;95;95;95 03:58:24 INFO - PROCESS | 30318 | |8;json-parse-financial;55;55;56;55;55;63;56;76;61;55 03:58:24 INFO - PROCESS | 30318 | |9;json-stringify-tinderbox;58;59;57;58;57;58;58;58;57;58 03:58:24 INFO - PROCESS | 30318 | |10;stanford-crypto-aes;73;74;74;75;74;75;73;75;75;83 03:58:24 INFO - PROCESS | 30318 | |11;stanford-crypto-ccm;116;114;116;118;117;115;112;113;130;133 03:58:24 INFO - PROCESS | 30318 | |12;stanford-crypto-pbkdf2;159;165;163;169;161;158;160;163;158;156 03:58:24 INFO - PROCESS | 30318 | |13;stanford-crypto-sha256-iterative;70;66;72;67;66;70;69;66;64;68 03:58:24 INFO - PROCESS | 30318 | __end_tp_report 03:58:24 INFO - PROCESS | 30318 | __start_cc_report 03:58:24 INFO - PROCESS | 30318 | _x_x_mozilla_cycle_collect,819 03:58:24 INFO - PROCESS | 30318 | __end_cc_report 03:58:24 INFO - PROCESS | 30318 | __startTimestamp1464433103995__endTimestamp 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | ------- Summary: start ------- 03:58:24 INFO - PROCESS | 30318 | Number of tests: 14 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:4.24 (3.8%) stddev-sans-first:4.47 03:58:24 INFO - PROCESS | 30318 | Values: 111.0 111.0 104.0 112.0 112.0 115.0 101.0 110.0 113.0 109.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:157.00 stddev:21.58 (13.7%) stddev-sans-first:22.55 03:58:24 INFO - PROCESS | 30318 | Values: 160.0 127.0 154.0 172.0 128.0 160.0 153.0 126.0 187.0 127.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:58:24 INFO - PROCESS | 30318 | Values: 163.0 162.0 162.0 160.0 161.0 161.0 163.0 162.0 162.0 162.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#3] audio-fft Cycles:10 Average:92.40 Median:74.00 stddev:38.31 (51.8%) stddev-sans-first:40.05 03:58:24 INFO - PROCESS | 30318 | Values: 74.0 72.0 75.0 164.0 74.0 78.0 72.0 73.0 166.0 76.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:26.12 (28.4%) stddev-sans-first:27.04 03:58:24 INFO - PROCESS | 30318 | Values: 92.0 93.0 148.0 92.0 91.0 91.0 147.0 92.0 93.0 143.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:58:24 INFO - PROCESS | 30318 | Values: 117.0 116.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:58:24 INFO - PROCESS | 30318 | Values: 147.0 149.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:58:24 INFO - PROCESS | 30318 | Values: 96.0 95.0 95.0 96.0 95.0 97.0 95.0 95.0 95.0 95.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:56.00 stddev:6.72 (12.0%) stddev-sans-first:6.99 03:58:24 INFO - PROCESS | 30318 | Values: 55.0 55.0 56.0 55.0 55.0 63.0 56.0 76.0 61.0 55.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:58:24 INFO - PROCESS | 30318 | Values: 58.0 59.0 57.0 58.0 57.0 58.0 58.0 58.0 57.0 58.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:2.88 (3.8%) stddev-sans-first:2.96 03:58:24 INFO - PROCESS | 30318 | Values: 73.0 74.0 74.0 75.0 74.0 75.0 73.0 75.0 75.0 83.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:116.50 stddev:7.17 (6.2%) stddev-sans-first:7.55 03:58:24 INFO - PROCESS | 30318 | Values: 116.0 114.0 116.0 118.0 117.0 115.0 112.0 113.0 130.0 133.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.00 stddev:3.88 (2.4%) stddev-sans-first:4.03 03:58:24 INFO - PROCESS | 30318 | Values: 159.0 165.0 163.0 169.0 161.0 158.0 160.0 163.0 158.0 156.0 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - PROCESS | 30318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:2.44 (3.6%) stddev-sans-first:2.46 03:58:24 INFO - PROCESS | 30318 | Values: 70.0 66.0 72.0 67.0 66.0 70.0 69.0 66.0 64.0 68.0 03:58:24 INFO - PROCESS | 30318 | -------- Summary: end -------- 03:58:24 INFO - PROCESS | 30318 | 03:58:24 INFO - TEST-INFO | 30318: exit 0 03:58:24 INFO - TEST-OK | kraken | took 62360ms 03:58:24 INFO - SUITE-END | took 1173s 03:58:25 INFO - Completed test suite (00:19:34) 03:58:25 INFO - javascript benchmark 03:58:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.6424075472078, 3439.5184674145607, 3444.8449819758107, 3473.8784142555, 3475.669811367919, 5691.686957217351, 5745.052066409048, 5749.166370876221, 5761.251037365142, 5763.049096899007, 5744.052231381817, 5746.655200687951, 5754.482096611304, 5769.394213607574, 5776.249087618614, 5168.0180765654495, 5201.323827902367, 5251.0, 5271.841844744664, 5274.103402421598, 5086.389633243997, 5235.895282094356, 5359.7320133993335, 5363.731813409334, 5386.2997810284805, 5211.609129315298, 5220.034293655667, 5281.075811732951, 5299.258103865462, 5330.600204984622, 5265.815191581902, 5268.47315268472, 5287.180487024537, 5301.920471192935, 5305.389880163753, 5095.745212739385, 5149.974250128763, 5175.508326708957, 5256.342957130359, 5258.526732594085, 5471.781128754845, 5535.474129957647, 5559.499645031926, 5570.86072848178, 5614.073677843151, 6148.538859585549, 6157.938420615781, 6183.752649893999, 6198.442140207403, 6199.380061993809, 6104.2980057293535, 6142.416470435302, 6193.256809182927, 6203.906941395882, 6218.067289906505, 5761.913571296476, 5795.710214489259, 5806.535477161817, 5815.941840581582, 5823.592348535604, 6269.529785266123, 6308.3060863305, 6313.0, 6319.557630965788, 6326.2724786649205, 5870.559708021916, 6037.215162028908, 6055.666938318347, 6071.605345652519, 6110.083487476914, 6161.630302181794, 6170.50635949123, 6188.535859810532, 6203.937960620336, 6207.255129384413, 6031.09533569968, 6139.10982907476, 6158.261008678897, 6167.321594624587, 6169.876602468015, 5969.880602387928, 6102.786402475892, 6137.60105593135, 6138.664296166039, 6155.446009859134, 4583.816647334069, 4590.632749380042, 4593.6095431888, 4600.700954437951, 4609.1703493371515, 4130.194612050681, 4137.50349958001, 4143.19207754491, 4150.107726838744, 4161.4382058421725, 5829.795957141565, 5855.736491857877, 5885.646861188342, 5917.171595976567, 5940.940590594125, 6155.692215389213, 6225.439710426083, 6238.282597501255, 6249.281332646713, 6256.468200203034, 5662.66024038559, 5884.911726324109, 5901.468867801833, 5903.439173278532, 5925.200097986803, 5204.479552044765, 5220.608454365862, 5259.21111833228, 5282.550983166474, 5322.787088516416, 6343.841403964845, 6349.492040636738, 6383.425491705769, 6388.073729309224, 6394.520410969196, 6176.7838125665385, 6219.844503887258, 6221.595596286227, 6223.782167624111, 6229.813105606839, 6130.356312587114, 6191.288001879661, 6195.318514963441, 6286.622802631857, 6288.591241569284, 6079.05774604937, 6100.969495152496, 6123.632582044914, 6131.264248290234, 6151.323354431099, 6198.442140207403, 6225.439710425902, 6228.781992630236, 6237.750489980532, 6240.53196010292, 5907.940920590739, 5949.8215053548465, 5979.162917191684, 6014.0, 6024.679530360336, 5980.43185897339, 6021.277446706424, 6022.939770602413, 6025.21672182631, 6028.2766068072115, 5778.479936805707, 5874.618149820248, 5917.615355001911, 5937.3468918418075, 5946.554008449297, 6046.848828779316, 6055.969720151371, 6058.848528786815, 6063.333033366238, 6114.327423983269, 5851.502622277154, 5896.764129434775, 5897.321807992136, 5906.70466476683, 5918.704064796657], "value": 5672.996171881396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.340126472263, 660.2769966886258, 666.9533132680712, 675.2201207605215, 752.7177308509309, 38567.61432385675, 40047.79976100115, 40059.399109013386, 40319.596804031986, 40414.39378409326, 41215.38176927349, 41422.0, 41581.0, 41875.371869421986, 41888.0, 8582.313414926823, 8685.739427817176, 8769.605367758435, 8800.515971621558, 8811.735647930573, 8618.525981071038, 8717.869231961526, 8892.199702026815, 8923.241524470428, 8953.23897468716, 8845.248153906894, 8952.820943581124, 8972.955135224314, 8973.371863969525, 8975.95512022439, 8896.555172241362, 8898.73303800887, 8906.643734250621, 8927.598258078402, 8955.2835773138, 8822.779430514289, 8873.645054197825, 8917.0637083106, 8917.777055573662, 8923.0, 33099.0, 41835.163296733896, 42015.0, 42041.369379459335, 42460.0, 3446.5174875517446, 3751.6248375162268, 3774.3960966245268, 3858.9421158682644, 3892.260470510594, 27971.720282797116, 28242.43515129686, 28642.14073577796, 28688.13935581936, 28806.567901481285, 4311.482622085338, 4369.737815731066, 4405.691601587891, 4409.360642706822, 4470.150671372428, 200422.0, 202916.0, 203279.0, 204027.0, 204624.99999999852, 35488.822555887054, 39009.80495097506, 39472.605273946894, 39650.40524392136, 39709.80870573888, 37756.811215943744, 37777.81111094427, 37792.43311350332, 37835.0, 37966.81016594899, 16464.094474804002, 16527.50417487453, 16586.502404927873, 16610.58473538171, 16650.0, 13592.320383980761, 13649.317534123453, 13677.974151938644, 13741.03812733099, 13906.0, 9072.04743501936, 9127.406718563272, 9161.541922903829, 9192.586333615003, 9210.769730756785, 3508.3509550733197, 3551.7158627309755, 3565.8751943681846, 3618.4029635109914, 3651.2514934438377, 1131.6322195286564, 1137.7610701752724, 1164.0803765025535, 1257.1577043380958, 1263.3367482071985, 32737.67262327394, 33512.16219594481, 33686.49470257948, 33783.493247601305, 34368.0, 1193.3019183777587, 1209.2865209526421, 1223.5289413575838, 1277.770001399757, 1374.2785037855206, 15664.373425063097, 15922.65374255288, 16078.598035048983, 16278.918605407134, 16791.0, 535035.0, 601501.0, 611289.0, 638268.0, 648477.0, 57532.424675753544, 59144.40855591475, 59182.40817591855, 59274.0, 59419.702901485216, 1519.7264492391255, 1523.4972459088474, 1541.6839547892655, 1548.0479505104279, 1561.039960424331, 30696.693033069383, 31112.68887311098, 31630.841845790623, 32034.67965320317, 32234.516482253253, 54507.454925450234, 54710.17934730903, 55216.171757424476, 55236.72381638227, 55360.16959745688, 470946.0, 471865.0, 479071.0, 483688.0, 492908.0, 30960.69039309668, 31945.201369965936, 31978.68021319757, 32087.518687220178, 32156.83921580377, 51866.40667966511, 51874.481255188475, 52669.47330526646, 52860.0, 53699.73150134224, 43259.78370108255, 43529.0, 43559.56440435682, 43758.781206093765, 44349.33475997927, 42548.0, 42574.0, 42916.0, 43098.569014309454, 43525.3471197926, 44040.7797961021, 44413.33379999238, 46077.76961115173, 46636.0, 46822.0, 35047.0, 36400.453993190655, 36529.45205821968, 36712.449313259785, 37616.81191594025, 29164.7083529162, 29817.70182298236, 30153.547696784128, 30197.0, 30274.394512109193], "value": 19172.48985684107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.1516966067864, 427.2373812744252, 428.4729782367686, 437.74829473052995, 443.5032763305099, 18441.170147343368, 19172.904135479337, 19181.232750689975, 19702.40892773219, 20417.59164816703, 18606.255749770025, 19180.328688495905, 19354.0, 19467.123979420925, 19474.0, 5226.189940559219, 5375.569954403658, 5380.515753582177, 5413.215083812865, 5433.809816656418, 5332.066888294552, 5359.785608575652, 5402.162664786944, 5534.806281780138, 5782.942170578303, 5741.511971482429, 5742.684152371638, 5754.280714910637, 5790.739416726257, 5794.246747922764, 5923.703814809264, 6352.205974253218, 6383.616982981036, 6385.010323399881, 6405.935940640604, 5620.4660557247, 5692.57305702074, 5713.628614140109, 5720.3135623725, 5722.599418040739, 20862.0, 21503.2473863414, 22654.773452265596, 22738.0, 22920.0, 2347.600907845653, 2417.915372961938, 2472.5920223163157, 2566.974330256711, 2592.157548796649, 10594.0, 10689.251752377337, 11186.944065279622, 13947.232902190375, 14787.852121478754, 1970.9901450492655, 1973.6151450467164, 2104.8210902073342, 2161.53526991696, 2277.749447560767, 73686.63156684236, 78604.21395786027, 79702.0, 80801.19198808054, 83042.0, 10830.620928267474, 11263.831042534368, 11266.887331126583, 11283.548658053585, 11348.943255283835, 15762.921185394, 15807.841921580866, 15904.363825447084, 15912.124833134289, 16006.119663418624, 7266.564006159648, 8295.129011453831, 8343.249107580226, 8532.57337133141, 8558.828823423497, 8347.499150051017, 8448.281896038783, 8462.36532260083, 8544.18830211129, 8592.8711069334, 4589.655775816827, 4633.907321853611, 4692.131955588227, 4703.45910220329, 4743.359646447685, 1966.2331690640663, 2025.888576128327, 2039.7858224886172, 2045.5908818236114, 2087.5511764970606, 467.1614452058563, 992.2359782967075, 1046.7487802927242, 1049.2602715085845, 1087.2009073331096, 11436.885631143748, 11928.642140735792, 11944.0, 11963.820542691867, 12071.155019148575, 492.68714366377606, 513.7585334892594, 521.9060569097599, 528.3026405145248, 528.5797790756358, 5116.181410974226, 6600.141981542369, 6624.0, 6644.4020038196795, 6692.59844409337, 557990.0, 584317.0, 586557.0, 591586.0, 608510.0, 89840.0, 100779.0, 103000.48499757603, 103129.0, 104936.47531762446, 1097.6268068856627, 1129.689335432746, 1180.504188240941, 1181.1908842442954, 1186.4008675618757, 16435.67128657444, 16720.331186752395, 16898.74651880198, 16990.830091698925, 17049.232784524975, 37791.0, 40331.0, 40723.0, 41434.37848432336, 42817.57182428136, 57886.7105664469, 57968.420315796306, 58061.96783112571, 58080.70959645175, 58407.4159258402, 8344.332453403835, 8704.91295087041, 8884.200421961796, 8935.28517718568, 8971.013188549125, 11552.768944621228, 13313.600591982256, 13495.662608434868, 13574.660633483847, 13652.453901843815, 11964.820527691918, 12048.397580120783, 12156.696082598006, 12259.080568957543, 12367.381630918599, 11631.243969141979, 11639.127065470293, 11688.298702077902, 12169.2698438094, 12361.134720569475, 6219.813405597839, 8508.91491085106, 11828.349440780496, 11951.76096478083, 12448.128630995743, 8471.449355791854, 8723.302135828992, 8836.602352894006, 8846.601902914255, 8852.026277109642, 10686.465676716289, 11538.0, 11957.342346171044, 12119.515219391125, 12194.390280485763], "value": 8991.27585397989, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.2193225319593, 1604.2540218798256, 1808.222464340334, 1890.3761758619657, 1913.6077104193632, 8233.135520770307, 8299.33605311575, 8437.578121093944, 8750.737477875675, 8756.824863502727, 8286.544240066794, 8294.62674179662, 8381.497110173394, 8398.664053437855, 8448.788780280496, 2326.3253656439656, 2341.8360714749974, 2351.423901144222, 2361.1499860050367, 2364.290712786157, 2364.9054037838464, 2382.404398900275, 2390.3546042568496, 2394.1141777542334, 2397.2808157552663, 2362.0197617988515, 2367.9408014799596, 2376.1683410806168, 2397.1250493569896, 2422.236995346469, 2357.4695693468916, 2357.8821058946983, 2368.7275963264274, 2368.7749663781915, 2375.239923224569, 2344.742078371378, 2344.9296521104393, 2376.7623237676266, 2378.096323397098, 2378.4648454097864, 8428.157184281585, 8471.06818249992, 8512.319014478826, 8537.487750734976, 8544.530050847201, 5216.634835561512, 5252.606054545886, 5284.10170271051, 5291.973540132313, 5322.1484562470205, 3399.7450191235507, 3408.352413041539, 3427.9485807712904, 3442.0362298556443, 3448.499967504698, 1124.6738445850776, 1154.457405019648, 1170.280277629252, 1187.352892673495, 1198.5086114693022, 11200.943995279971, 11216.0, 11262.380569068699, 11265.549378024869, 11294.491747871283, 4270.42349282849, 4305.4187684662165, 4353.020570371705, 4356.6732495063, 4380.255356589388, 9275.16523512887, 9324.627014919328, 9331.393459425251, 9332.44005359667, 9359.298052645943, 5016.347874776256, 5017.147084995559, 5044.848654540369, 5049.065922804293, 5071.492850714899, 4058.2086493134148, 4711.95288047122, 4726.905461890743, 4737.692050016807, 4773.498782627844, 4061.7156799024374, 4109.684900831765, 4111.0, 4114.547399786021, 4211.368294755811, 1282.3011458755002, 1297.5653156192782, 1312.5996571045923, 1330.9334533273297, 1336.2917653643585, 982.886967998675, 1043.9247574997764, 1104.2325583719237, 1109.8668159820872, 1113.3264375053138, 5848.2397288353095, 5916.0362557086855, 5979.790707325223, 6152.753889844356, 6159.84600384985, 438.66880505218995, 443.46562392317827, 447.1414883423834, 449.566168647257, 459.64607252415453, 4134.431453244182, 4181.121964387452, 4219.9578004220175, 4237.131388065439, 4294.012377153273, 9828.508574571386, 10182.083612474913, 10203.336783109222, 10221.437820919771, 10346.275760696679, 10176.440295783803, 10182.389056656477, 10212.846807297896, 10214.846777298346, 10226.948865255627, 7674.53952762836, 7883.2905038546805, 8004.959975200087, 8014.479058861155, 8074.878876816852, 5897.262842144732, 5953.642781433128, 5958.76164953397, 6016.187814645142, 6065.5754097212775, 8679.956600216958, 8842.204201621886, 8923.73228803137, 9030.36787424874, 9083.36416450842, 8919.55402229873, 9100.362974591715, 9162.26701863836, 9193.080691930754, 9208.861867071866, 6831.6242606657115, 7147.678354473957, 7301.160366557914, 7329.120505539369, 7438.330550250504, 7860.135385107748, 7868.8819667706175, 7906.288434040964, 7938.56337901421, 7950.602469876368, 6945.513814032969, 6986.9650651746415, 7027.648617568999, 7067.646617668993, 7277.3086556777025, 7032.156141263081, 7054.01243825875, 7086.326798954091, 7090.964545177241, 7180.138383393817, 6720.32796720324, 6820.045193672989, 7021.964890175516, 7023.122109736283, 7027.15674119109, 5168.095583272988, 5207.895842083061, 5227.215917612389, 5378.919316210338, 5409.675419474844, 5202.479752024768, 5209.661372010807, 5261.57907367402, 5281.1286137788375, 5379.488948549882], "value": 4468.782358750011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.53794146872445, 354.831455058847, 359.3298498300669, 362.4056547262488, 364.3350884635541, 6551.11559939408, 6675.799726008221, 6766.12040434744, 6810.046593476911, 6817.727290908364, 6693.665316734156, 6695.096162018126, 6714.865702685944, 6720.428763555092, 6748.392644661992, 5074.213496907985, 5080.212567052113, 5082.212257100137, 5087.618428617869, 5089.7455127243675, 5076.213186956028, 5082.872928176806, 5086.6693664911845, 5097.847064588068, 5101.897962040757, 5013.3232013678235, 5017.172166592508, 5020.272060551218, 5042.344495215617, 5044.0, 4786.856394308176, 4928.605711543068, 5010.048090862742, 5031.0441016206805, 5040.924386134193, 4266.0827921996915, 4280.957190428087, 4286.335617979218, 4301.0537681709975, 4306.203352379788, 6348.77779277723, 6379.744810207586, 6385.7764978226005, 6393.552451328409, 6407.551471397004, 5768.913466298009, 5794.82615521535, 5819.621724587888, 5821.068629019379, 5821.621594596338, 7003.3346832050875, 7019.754308599226, 7021.1574611047, 7021.543599666005, 7027.43780497559, 4635.0, 4774.069056533943, 4780.163471392527, 4792.568668819823, 4797.2564252540915, 7233.7468188613675, 7332.743353982638, 7364.300391462856, 7389.4457915656, 7389.741359052461, 4906.165951788204, 4913.336699545515, 4916.06594746997, 4930.161872481687, 4932.679375840559, 4971.279164521125, 4982.103221420107, 4984.37695288089, 4991.301217829507, 4995.825146119941, 5801.9419805802245, 5803.042497987869, 5805.622634528742, 5816.040353341651, 5821.738021788945, 6868.313168683092, 7110.25342339047, 7118.964405178044, 7126.144862616416, 7136.250693677193, 1728.7666165067556, 1736.791585009807, 1743.46824218612, 1747.2137538107647, 1747.4932269641915, 1042.3797840285017, 1127.7067962329854, 1132.5413207650915, 1141.2410746853416, 1145.5475087340453, 6750.628715420699, 6846.863062738717, 6871.347222013901, 6924.4114250288285, 6942.236354001056, 7329.5968721719755, 7381.594012329373, 7418.295261950106, 7418.369438597671, 7425.85148297031, 6889.0355350251, 6892.931070689329, 6896.413804826546, 6898.172219333612, 6918.654067296615, 3936.291467535871, 3963.583823698528, 3973.8211780469946, 4003.8798836034966, 4010.63904248619, 7604.657790399446, 7611.619419029026, 7634.0, 7727.38180945523, 7729.497582657222, 7523.210062943313, 7528.435367347471, 7532.7740167795055, 7555.16893141754, 7559.1684914659345, 7601.277878601524, 7602.771916842504, 7607.505512141804, 7607.972923655236, 7612.657430415645, 7199.928000720135, 7337.70649174027, 7353.742619008309, 7360.852782944418, 7394.7781566553085, 7239.058922340062, 7268.055152830098, 7271.854562908818, 7272.854542909006, 7286.0, 7521.285477879593, 7568.318851303409, 7569.962150189213, 7585.962070189614, 7606.973058637234, 5059.671121377099, 5093.592512599057, 5095.898082038412, 5114.9232761507865, 5116.334876466036, 7154.213036566078, 7287.890681639886, 7293.452991025801, 7295.562266264041, 7301.817454563678, 7052.788416347517, 7059.188193357624, 7065.717371305091, 7096.0, 7103.183133939457, 7005.089338386181, 7016.6842492089, 7034.120734908137, 7039.049728286615, 7044.084269044992, 6911.067005954333, 6922.446204303745, 6927.7228910845015, 6932.757353492603, 6942.826429339105, 6930.653467326714, 6970.0, 7032.6132062735, 7089.184743754534, 7105.573665580082, 6797.6941037654415, 6932.48006399512, 7029.683664235224, 7048.189458212371, 7072.929270707433], "value": 5305.224661530921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.6635514018693, 767.3209209849282, 785.2069409896003, 842.6713581703135, 843.1273631791096, 14325.570232893017, 14488.63778405539, 14539.636509087251, 14543.200123993176, 14595.97828152031, 13892.722145557083, 13921.373538190806, 13924.094933829294, 13941.442342306322, 13955.092918960261, 736.871047566675, 872.655301156043, 896.4397251717677, 902.7111324376202, 903.891533016039, 893.1871996483202, 897.3583887520422, 898.1602201941173, 898.7213963671251, 899.2266650680409, 943.5470973932482, 945.716285114463, 948.35511851941, 948.8624149498353, 949.5964215208509, 920.8572671235969, 928.6192661008988, 934.0192797562567, 935.1209862729013, 941.7316064921499, 680.3468670076733, 681.580827790905, 682.147315855181, 686.739039165119, 694.3611877073055, 14850.0, 14943.850561494355, 14948.775768363483, 14970.62573435662, 14972.251387430693, 13899.79150312746, 14515.637109072251, 14516.0, 14956.925215373854, 15404.691906161926, 11868.643940681794, 12009.579664711693, 12093.697657558632, 12139.696507587292, 12176.878231217663, 4036.2936486114813, 4044.838206471767, 4100.384942258685, 4109.794510274474, 4156.168766246763, 57917.131243031385, 58482.707586461795, 58940.0, 58982.41017589855, 59047.70476147635, 10187.235957303084, 10456.477176141163, 10570.471476426148, 10795.46022698862, 11043.72390690223, 18846.52883677919, 18903.810961890205, 18910.149043293084, 18914.716279255823, 18934.337298194496, 7497.587632680146, 7609.162992070867, 7884.684612615546, 7885.684572617031, 7958.602069896482, 4725.810967561328, 4878.926816097762, 4936.901261974812, 5010.3737032870895, 5019.096562618691, 3389.74576906733, 3457.6715212054814, 3474.513568100468, 3480.651934806499, 3486.930261394758, 643.5270076493773, 661.2593894837717, 664.7905909638448, 669.7823207457595, 677.9118714567074, 766.0807031562148, 774.9302562769378, 775.1473379282744, 796.7649543384715, 798.3134504326275, 9873.80252394948, 10310.845337319946, 10463.0, 10656.307340022873, 10667.413292269, 838.1618381618382, 839.2446797881955, 848.1391387741447, 857.9313654907593, 873.4366333714719, 4795.640326975421, 4812.807487700453, 4892.437369702458, 4910.435299940481, 4917.631177661689, 57471.0, 70334.2966570338, 70450.0, 70755.6462217696, 71016.289837102, 58862.11706824401, 58888.41111588915, 59371.999999999134, 59407.40592594105, 59739.701301493216, 55338.16992745112, 55719.164212536845, 55760.16359754607, 55894.441055589734, 56526.71736641291, 10190.592376304865, 10214.438205898747, 10385.169186464913, 10465.895341046493, 10507.31702439339, 39060.0, 39710.60289397069, 39900.60099399085, 40337.193256134124, 40573.39139912845, 47667.76166119147, 48197.75901120472, 52379.73810130925, 53033.0, 54399.72800135974, 12521.812172817597, 12558.937205313914, 12706.745865082832, 12765.170263932814, 12892.935535322264, 13320.0, 13398.397072131582, 13629.79555306691, 13740.381682824496, 14277.500287489887, 13667.248301343521, 13756.105853119516, 13824.861751382357, 13849.307534623027, 14494.275286235435, 12891.16207446513, 13097.672558186121, 13483.662908427368, 13752.587422377344, 13910.791338130139, 12224.633261002184, 13445.0, 13778.931105344811, 14185.858141418454, 14196.858031419553, 10508.737281568023, 10644.680659580225, 10675.679729608124, 10739.516721747696, 10860.076893464144, 10574.682759517227, 10640.414777187329, 10975.780484390109, 10980.780384392427, 11029.172812038969], "value": 7188.455703256935, "unit": "score"}], "name": "dromaeo_css", "value": 7418.443098298478, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 104.0, 112.0, 112.0, 115.0, 101.0, 110.0, 113.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 154.0, 172.0, 128.0, 160.0, 153.0, 126.0, 187.0, 127.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 160.0, 161.0, 161.0, 163.0, 162.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 75.0, 164.0, 74.0, 78.0, 72.0, 73.0, 166.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 148.0, 92.0, 91.0, 91.0, 147.0, 92.0, 93.0, 143.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 63.0, 56.0, 76.0, 61.0, 55.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 75.0, 74.0, 75.0, 73.0, 75.0, 75.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 118.0, 117.0, 115.0, 112.0, 113.0, 130.0, 133.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 165.0, 163.0, 169.0, 161.0, 158.0, 160.0, 163.0, 158.0, 156.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 72.0, 67.0, 66.0, 70.0, 69.0, 66.0, 64.0, 68.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1519.8999999999999, "alertThreshold": 2.0}]} 03:58:25 INFO - Return code: 0 03:58:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:58:25 ERROR - # TBPL SUCCESS # 03:58:25 INFO - Running post-action listener: _resource_record_post_action 03:58:25 INFO - Running post-run listener: _resource_record_post_run 03:58:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 364544; Write bytes: 248266752; Read time: 236; Write time: 380368 03:58:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5263360; Read time: 0; Write time: 448 03:58:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 364544; Write bytes: 243003392; Read time: 236; Write time: 379920 03:58:26 INFO - Running post-run listener: _upload_blobber_files 03:58:26 INFO - Blob upload gear active. 03:58:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:26 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:58:26 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:58:26 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:58:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:58:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:27 INFO - (blobuploader) - INFO - Done attempting. 03:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:28 INFO - (blobuploader) - INFO - Done attempting. 03:58:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:28 INFO - Return code: 0 03:58:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2fd2d30d20b0a46c707dc4ee256d3e436199b21813e838654296fe19dab8c08b448b4f7e49a52a1bac864cc86db80ac40e2831b69ae49a587e79748fed2794", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4db063b7359d522e82e238529ed5cff3e3e110f28a729792b6c2f9b079a3f3a12f594fcf19747729e1e163ce36655082ccd0bb6201cca062162c33f02de8e0b5"} 03:58:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:28 INFO - Contents: 03:58:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2fd2d30d20b0a46c707dc4ee256d3e436199b21813e838654296fe19dab8c08b448b4f7e49a52a1bac864cc86db80ac40e2831b69ae49a587e79748fed2794", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4db063b7359d522e82e238529ed5cff3e3e110f28a729792b6c2f9b079a3f3a12f594fcf19747729e1e163ce36655082ccd0bb6201cca062162c33f02de8e0b5"} 03:58:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:28 INFO - Copying logs to upload dir... 03:58:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.720210 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-28 03:58:28.813905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:28.817138) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 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/de2fd2d30d20b0a46c707dc4ee256d3e436199b21813e838654296fe19dab8c08b448b4f7e49a52a1bac864cc86db80ac40e2831b69ae49a587e79748fed2794", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4db063b7359d522e82e238529ed5cff3e3e110f28a729792b6c2f9b079a3f3a12f594fcf19747729e1e163ce36655082ccd0bb6201cca062162c33f02de8e0b5"} build_url:https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/NyN-1RguTPSoiQWZRupe-Q/artifacts/public/build/firefox-48.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/de2fd2d30d20b0a46c707dc4ee256d3e436199b21813e838654296fe19dab8c08b448b4f7e49a52a1bac864cc86db80ac40e2831b69ae49a587e79748fed2794", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4db063b7359d522e82e238529ed5cff3e3e110f28a729792b6c2f9b079a3f3a12f594fcf19747729e1e163ce36655082ccd0bb6201cca062162c33f02de8e0b5"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:28.881117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:28.881489) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464431872.329540-1919817869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:58:28.939261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:58:28.939574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 03:58:28.939939) ========= ========= Total master_lag: 0.20 =========