builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1461616544.95 results: success (0) buildid: 20160425103006 builduid: 1a87fa8d522747ab8b0da4138352f4b4 revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:44.951600) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:44.952077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:44.952359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:44.968986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:44.969269) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 13:35:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-04-25 13:35:45 (16.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118269 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:45.100630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:45.100955) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016208 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:45.150528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:35:45.150891) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --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 0d6a91c76a9eddf2219caf028dea130f2d683ec2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 13:35:45,354 truncating revision to first 12 chars 2016-04-25 13:35:45,354 Setting DEBUG logging. 2016-04-25 13:35:45,354 attempt 1/10 2016-04-25 13:35:45,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d6a91c76a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 13:35:46,142 unpacking tar archive at: mozilla-aurora-0d6a91c76a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.058480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 13:35:46.223981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:46.224309) ========= script_repo_revision: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:46.224725) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:46.224990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 13:35:46.237226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-25 13:35:46.238754) ========= /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=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:35:46 INFO - MultiFileLogger online at 20160425 13:35:46 in /builds/slave/test 13:35:46 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 13:35:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:35:46 INFO - {'append_to_log': False, 13:35:46 INFO - 'base_work_dir': '/builds/slave/test', 13:35:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:35:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:35:46 INFO - 'branch': 'Mozilla-Aurora', 13:35:46 INFO - 'buildbot_json_path': 'buildprops.json', 13:35:46 INFO - 'config_files': ('talos/linux_config.py',), 13:35:46 INFO - 'default_actions': ('clobber', 13:35:46 INFO - 'read-buildbot-config', 13:35:46 INFO - 'download-and-extract', 13:35:46 INFO - 'populate-webroot', 13:35:46 INFO - 'create-virtualenv', 13:35:46 INFO - 'install', 13:35:46 INFO - 'run-tests'), 13:35:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:35:46 INFO - 'download_minidump_stackwalk': True, 13:35:46 INFO - 'download_symbols': 'ondemand', 13:35:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:35:46 INFO - 'tooltool.py': '/tools/tooltool.py', 13:35:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:35:46 INFO - '/tools/misc-python/virtualenv.py')}, 13:35:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:35:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:35:46 INFO - 'installer_path': 'installer.exe', 13:35:46 INFO - 'log_level': 'info', 13:35:46 INFO - 'log_name': 'talos', 13:35:46 INFO - 'log_to_console': True, 13:35:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:35:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:35:46 INFO - 'opt_config_files': (), 13:35:46 INFO - 'pip_index': False, 13:35:46 INFO - 'sps_profile': False, 13:35:46 INFO - 'sps_profile_interval': 0, 13:35:46 INFO - 'suite': 'dromaeojs-e10s', 13:35:46 INFO - 'system_bits': '32', 13:35:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:35:46 INFO - 'title': 'talos-linux64-ix-001', 13:35:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:35:46 INFO - 'use_talos_json': True, 13:35:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:35:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:35:46 INFO - 'work_dir': 'build'} 13:35:46 INFO - ##### 13:35:46 INFO - ##### Running clobber step. 13:35:46 INFO - ##### 13:35:46 INFO - Running pre-action listener: _resource_record_pre_action 13:35:46 INFO - Running main action method: clobber 13:35:46 INFO - rmtree: /builds/slave/test/build 13:35:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:35:47 INFO - Running post-action listener: _resource_record_post_action 13:35:47 INFO - ##### 13:35:47 INFO - ##### Running read-buildbot-config step. 13:35:47 INFO - ##### 13:35:47 INFO - Running pre-action listener: _resource_record_pre_action 13:35:47 INFO - Running main action method: read_buildbot_config 13:35:47 INFO - Using buildbot properties: 13:35:47 INFO - { 13:35:47 INFO - "project": "", 13:35:47 INFO - "product": "firefox", 13:35:47 INFO - "script_repo_revision": "production", 13:35:47 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:35:47 INFO - "repository": "", 13:35:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:35:47 INFO - "buildid": "20160425103006", 13:35:47 INFO - "pgo_build": "True", 13:35:47 INFO - "basedir": "/builds/slave/test", 13:35:47 INFO - "buildnumber": 321, 13:35:47 INFO - "slavename": "talos-linux64-ix-001", 13:35:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:35:47 INFO - "platform": "ubuntu64_hw", 13:35:47 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:35:47 INFO - "branch": "mozilla-aurora", 13:35:47 INFO - "repo_path": "releases/mozilla-aurora", 13:35:47 INFO - "revision": "0d6a91c76a9eddf2219caf028dea130f2d683ec2", 13:35:47 INFO - "stage_platform": "linux64-pgo", 13:35:47 INFO - "builduid": "1a87fa8d522747ab8b0da4138352f4b4", 13:35:47 INFO - "slavebuilddir": "test" 13:35:47 INFO - } 13:35:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 13:35:47 INFO - Running post-action listener: _resource_record_post_action 13:35:47 INFO - ##### 13:35:47 INFO - ##### Running download-and-extract step. 13:35:47 INFO - ##### 13:35:47 INFO - Running pre-action listener: _resource_record_pre_action 13:35:47 INFO - Running main action method: download_and_extract 13:35:47 INFO - mkdir: /builds/slave/test/build/tests 13:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:47 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:47 INFO - Downloaded 1361 bytes. 13:35:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 13:35:47 INFO - Using the following test package requirements: 13:35:47 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:47 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:35:47 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:35:47 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'jsshell-linux-x86_64.zip'], 13:35:47 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:35:47 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 13:35:47 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:35:47 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:35:47 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:35:47 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 13:35:47 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:35:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:47 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:48 INFO - Downloaded 23819986 bytes. 13:35:48 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'] 13:35:48 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 13:35:50 INFO - Return code: 0 13:35:50 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 13:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:50 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 13:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:51 INFO - Downloaded 23819986 bytes. 13:35:51 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'] 13:35:51 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 13:35:52 INFO - Return code: 0 13:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:52 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 13:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:53 INFO - Downloaded 10840145 bytes. 13:35:53 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'] 13:35:53 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 13:35:54 INFO - Return code: 0 13:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:54 INFO - https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a46NiOjYQzSSlKI18glfOw/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 13:35:55 INFO - Downloaded 62670906 bytes. 13:35:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:55 INFO - mkdir: /builds/slave/test/properties 13:35:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:35:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:35:55 INFO - Contents: 13:35:55 INFO - build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 13:35:56 INFO - Running post-action listener: _resource_record_post_action 13:35:56 INFO - Running post-action listener: set_extra_try_arguments 13:35:56 INFO - ##### 13:35:56 INFO - ##### Running populate-webroot step. 13:35:56 INFO - ##### 13:35:56 INFO - Running pre-action listener: _resource_record_pre_action 13:35:56 INFO - Running main action method: populate_webroot 13:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:35:56 INFO - '--tppagecycles', 13:35:56 INFO - '7'], 13:35:56 INFO - 'tests': ['tsvgm']}}, 13:35:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:35:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:35:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:35:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['damp', 'tps']}, 13:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'tests': ['damp', 'tps']}, 13:35:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['dromaeo_dom']}, 13:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:35:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'other-e10s': {'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['a11yr', 13:35:56 INFO - 'ts_paint', 13:35:56 INFO - 'tpaint', 13:35:56 INFO - 'sessionrestore', 13:35:56 INFO - 'sessionrestore_no_auto_restore', 13:35:56 INFO - 'tabpaint']}, 13:35:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['tsvgx', 13:35:56 INFO - 'tsvgr_opacity', 13:35:56 INFO - 'tart', 13:35:56 INFO - 'tscrollx', 13:35:56 INFO - 'cart']}, 13:35:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:35:56 INFO - 'tsvgr_opacity', 13:35:56 INFO - 'tart', 13:35:56 INFO - 'tscrollx', 13:35:56 INFO - 'cart']}, 13:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'talos_options': ['--disable-e10s'], 13:35:56 INFO - 'tests': ['tp5o']}, 13:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'tests': ['tp5o']}, 13:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'talos_options': ['--disable-e10s', 13:35:56 INFO - '--xperf_path', 13:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:56 INFO - 'tests': ['tp5n']}, 13:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:35:56 INFO - 'talos_options': ['--xperf_path', 13:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:35:56 INFO - 'tests': ['tp5n']}}, 13:35:56 INFO - 'talos.zip': {'path': '', 13:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:35:56 INFO - Running post-action listener: _resource_record_post_action 13:35:56 INFO - ##### 13:35:56 INFO - ##### Running create-virtualenv step. 13:35:56 INFO - ##### 13:35:56 INFO - Running pre-action listener: _resource_record_pre_action 13:35:56 INFO - Running main action method: create_virtualenv 13:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 13:35:56 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 13:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:35:56 INFO - Using real prefix '/usr' 13:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 13:35:59 INFO - Installing pip.................done. 13:35:59 INFO - Return code: 0 13:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:35:59 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 13:35:59 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 13:35:59 INFO - Using env: {'DISPLAY': ':0', 13:35:59 INFO - 'HOME': '/home/cltbld', 13:35:59 INFO - 'LANG': 'en_US.UTF-8', 13:35:59 INFO - 'LANGUAGE': 'en_US:en', 13:35:59 INFO - 'LOGNAME': 'cltbld', 13:35:59 INFO - 'MAIL': '/var/mail/cltbld', 13:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:59 INFO - 'MOZ_NO_REMOTE': '1', 13:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:59 INFO - 'NO_EM_RESTART': '1', 13:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:59 INFO - 'PWD': '/builds/slave/test', 13:35:59 INFO - 'SHELL': '/bin/bash', 13:35:59 INFO - 'SHLVL': '1', 13:35:59 INFO - 'TERM': 'linux', 13:35:59 INFO - 'TMOUT': '86400', 13:35:59 INFO - 'USER': 'cltbld', 13:35:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:59 INFO - '_': '/tools/buildbot/bin/python'} 13:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:59 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 13:35:59 INFO - Cleaning up... 13:35:59 INFO - Return code: 0 13:35:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:35:59 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:35:59 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 13:35:59 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 13:35:59 INFO - Using env: {'DISPLAY': ':0', 13:35:59 INFO - 'HOME': '/home/cltbld', 13:35:59 INFO - 'LANG': 'en_US.UTF-8', 13:35:59 INFO - 'LANGUAGE': 'en_US:en', 13:35:59 INFO - 'LOGNAME': 'cltbld', 13:35:59 INFO - 'MAIL': '/var/mail/cltbld', 13:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:59 INFO - 'MOZ_NO_REMOTE': '1', 13:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:59 INFO - 'NO_EM_RESTART': '1', 13:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:59 INFO - 'PWD': '/builds/slave/test', 13:35:59 INFO - 'SHELL': '/bin/bash', 13:35:59 INFO - 'SHLVL': '1', 13:35:59 INFO - 'TERM': 'linux', 13:35:59 INFO - 'TMOUT': '86400', 13:35:59 INFO - 'USER': 'cltbld', 13:35:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:59 INFO - '_': '/tools/buildbot/bin/python'} 13:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:59 INFO - Downloading/unpacking psutil>=0.7.1 13:35:59 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 13:35:59 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 13:35:59 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 13:35:59 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 13:35:59 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 13:35:59 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 13:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:01 INFO - Installing collected packages: psutil 13:36:01 INFO - Running setup.py install for psutil 13:36:01 INFO - building 'psutil._psutil_linux' extension 13:36:01 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 13:36:01 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 13:36:01 INFO - building 'psutil._psutil_posix' extension 13:36:01 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 13:36:01 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 13:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:01 INFO - Successfully installed psutil 13:36:01 INFO - Cleaning up... 13:36:01 INFO - Return code: 0 13:36:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:01 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:01 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 13:36:01 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 13:36:01 INFO - Using env: {'DISPLAY': ':0', 13:36:01 INFO - 'HOME': '/home/cltbld', 13:36:01 INFO - 'LANG': 'en_US.UTF-8', 13:36:01 INFO - 'LANGUAGE': 'en_US:en', 13:36:01 INFO - 'LOGNAME': 'cltbld', 13:36:01 INFO - 'MAIL': '/var/mail/cltbld', 13:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:01 INFO - 'MOZ_NO_REMOTE': '1', 13:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:01 INFO - 'NO_EM_RESTART': '1', 13:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:01 INFO - 'PWD': '/builds/slave/test', 13:36:01 INFO - 'SHELL': '/bin/bash', 13:36:01 INFO - 'SHLVL': '1', 13:36:01 INFO - 'TERM': 'linux', 13:36:01 INFO - 'TMOUT': '86400', 13:36:01 INFO - 'USER': 'cltbld', 13:36:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:01 INFO - '_': '/tools/buildbot/bin/python'} 13:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:36:04 INFO - Installing collected packages: mozsystemmonitor 13:36:04 INFO - Running setup.py install for mozsystemmonitor 13:36:04 INFO - Successfully installed mozsystemmonitor 13:36:04 INFO - Cleaning up... 13:36:04 INFO - Return code: 0 13:36:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36:04 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')]} 13:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:04 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')]} 13:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:04 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:04 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 13:36:04 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 13:36:04 INFO - Using env: {'DISPLAY': ':0', 13:36:04 INFO - 'HOME': '/home/cltbld', 13:36:04 INFO - 'LANG': 'en_US.UTF-8', 13:36:04 INFO - 'LANGUAGE': 'en_US:en', 13:36:04 INFO - 'LOGNAME': 'cltbld', 13:36:04 INFO - 'MAIL': '/var/mail/cltbld', 13:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:04 INFO - 'MOZ_NO_REMOTE': '1', 13:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:04 INFO - 'NO_EM_RESTART': '1', 13:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:04 INFO - 'PWD': '/builds/slave/test', 13:36:04 INFO - 'SHELL': '/bin/bash', 13:36:04 INFO - 'SHLVL': '1', 13:36:04 INFO - 'TERM': 'linux', 13:36:04 INFO - 'TMOUT': '86400', 13:36:04 INFO - 'USER': 'cltbld', 13:36:04 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:04 INFO - '_': '/tools/buildbot/bin/python'} 13:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:07 INFO - Downloading docopt-0.6.1.tar.gz 13:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:07 INFO - Running setup.py install for blobuploader 13:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:07 INFO - Running setup.py install for requests 13:36:07 INFO - Running setup.py install for docopt 13:36:07 INFO - Successfully installed blobuploader requests docopt 13:36:07 INFO - Cleaning up... 13:36:07 INFO - Return code: 0 13:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:07 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')]} 13:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:07 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')]} 13:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:07 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:07 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 13:36:07 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 13:36:07 INFO - Using env: {'DISPLAY': ':0', 13:36:07 INFO - 'HOME': '/home/cltbld', 13:36:07 INFO - 'LANG': 'en_US.UTF-8', 13:36:07 INFO - 'LANGUAGE': 'en_US:en', 13:36:07 INFO - 'LOGNAME': 'cltbld', 13:36:07 INFO - 'MAIL': '/var/mail/cltbld', 13:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:07 INFO - 'MOZ_NO_REMOTE': '1', 13:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:07 INFO - 'NO_EM_RESTART': '1', 13:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:07 INFO - 'PWD': '/builds/slave/test', 13:36:07 INFO - 'SHELL': '/bin/bash', 13:36:07 INFO - 'SHLVL': '1', 13:36:07 INFO - 'TERM': 'linux', 13:36:07 INFO - 'TMOUT': '86400', 13:36:07 INFO - 'USER': 'cltbld', 13:36:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:07 INFO - '_': '/tools/buildbot/bin/python'} 13:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:08 INFO - Running setup.py (path:/tmp/pip-qlqAyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:08 INFO - Running setup.py (path:/tmp/pip-TpkzMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:08 INFO - Running setup.py (path:/tmp/pip-dusnZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:08 INFO - Running setup.py (path:/tmp/pip-vr1apF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:08 INFO - Running setup.py (path:/tmp/pip-B6dqvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:08 INFO - Running setup.py (path:/tmp/pip-am4f03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:08 INFO - Running setup.py (path:/tmp/pip-YO43sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:08 INFO - Running setup.py (path:/tmp/pip-qCv2VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:08 INFO - Running setup.py (path:/tmp/pip-V06XEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:08 INFO - Running setup.py (path:/tmp/pip-fEOXoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:08 INFO - Running setup.py (path:/tmp/pip-NwJBUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:08 INFO - Running setup.py (path:/tmp/pip-c904Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:08 INFO - Running setup.py (path:/tmp/pip-tWE1xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:08 INFO - Running setup.py (path:/tmp/pip-LcEiVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:09 INFO - Running setup.py (path:/tmp/pip-l0IHMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:09 INFO - Running setup.py (path:/tmp/pip-Z1IwCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:09 INFO - Running setup.py (path:/tmp/pip-nOyFQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:09 INFO - Running setup.py install for manifestparser 13:36:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:09 INFO - Running setup.py install for mozcrash 13:36:09 INFO - Running setup.py install for mozdebug 13:36:09 INFO - Running setup.py install for mozdevice 13:36:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:09 INFO - Running setup.py install for mozfile 13:36:09 INFO - Running setup.py install for mozhttpd 13:36:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:09 INFO - Running setup.py install for mozinfo 13:36:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:09 INFO - Running setup.py install for mozInstall 13:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Running setup.py install for mozleak 13:36:10 INFO - Running setup.py install for mozlog 13:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Running setup.py install for moznetwork 13:36:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Running setup.py install for mozprocess 13:36:10 INFO - Running setup.py install for mozprofile 13:36:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Running setup.py install for mozrunner 13:36:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:10 INFO - Running setup.py install for mozscreenshot 13:36:10 INFO - Running setup.py install for moztest 13:36:10 INFO - Running setup.py install for mozversion 13:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:11 INFO - Cleaning up... 13:36:11 INFO - Return code: 0 13:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:11 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')]} 13:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:11 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')]} 13:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:11 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:11 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 13:36:11 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 13:36:11 INFO - Using env: {'DISPLAY': ':0', 13:36:11 INFO - 'HOME': '/home/cltbld', 13:36:11 INFO - 'LANG': 'en_US.UTF-8', 13:36:11 INFO - 'LANGUAGE': 'en_US:en', 13:36:11 INFO - 'LOGNAME': 'cltbld', 13:36:11 INFO - 'MAIL': '/var/mail/cltbld', 13:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:11 INFO - 'MOZ_NO_REMOTE': '1', 13:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:11 INFO - 'NO_EM_RESTART': '1', 13:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:11 INFO - 'PWD': '/builds/slave/test', 13:36:11 INFO - 'SHELL': '/bin/bash', 13:36:11 INFO - 'SHLVL': '1', 13:36:11 INFO - 'TERM': 'linux', 13:36:11 INFO - 'TMOUT': '86400', 13:36:11 INFO - 'USER': 'cltbld', 13:36:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:11 INFO - '_': '/tools/buildbot/bin/python'} 13:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:11 INFO - Running setup.py (path:/tmp/pip-cgofvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:11 INFO - Running setup.py (path:/tmp/pip-2b_Z4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:11 INFO - Running setup.py (path:/tmp/pip-GYk_wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:11 INFO - Running setup.py (path:/tmp/pip-Qb6ueO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:11 INFO - Running setup.py (path:/tmp/pip-6xrgBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:11 INFO - Running setup.py (path:/tmp/pip-sh7mrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:11 INFO - Running setup.py (path:/tmp/pip-zaAjva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:11 INFO - Running setup.py (path:/tmp/pip-XwiX07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:11 INFO - Running setup.py (path:/tmp/pip-3t41Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:11 INFO - Running setup.py (path:/tmp/pip-yY25V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:11 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)) 13:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:11 INFO - Running setup.py (path:/tmp/pip-aPqzGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:12 INFO - Running setup.py (path:/tmp/pip-ZYA3pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:12 INFO - Running setup.py (path:/tmp/pip-arvcAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:12 INFO - Running setup.py (path:/tmp/pip-1_09ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:12 INFO - Running setup.py (path:/tmp/pip-tCpB32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:12 INFO - Running setup.py (path:/tmp/pip-CJ17iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:12 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)) 13:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:12 INFO - Running setup.py (path:/tmp/pip-ygWXAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 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)) 13:36:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:14 INFO - Downloading blessings-1.6.tar.gz 13:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:14 INFO - Installing collected packages: blessings 13:36:14 INFO - Running setup.py install for blessings 13:36:14 INFO - Successfully installed blessings 13:36:14 INFO - Cleaning up... 13:36:14 INFO - Return code: 0 13:36:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:14 INFO - Reading from file tmpfile_stdout 13:36:14 INFO - Current package versions: 13:36:14 INFO - argparse == 1.2.1 13:36:14 INFO - blessings == 1.6 13:36:14 INFO - blobuploader == 1.2.4 13:36:14 INFO - docopt == 0.6.1 13:36:14 INFO - manifestparser == 1.1 13:36:14 INFO - mozInstall == 1.12 13:36:14 INFO - mozcrash == 0.17 13:36:14 INFO - mozdebug == 0.1 13:36:14 INFO - mozdevice == 0.48 13:36:14 INFO - mozfile == 1.2 13:36:14 INFO - mozhttpd == 0.7 13:36:14 INFO - mozinfo == 0.9 13:36:14 INFO - mozleak == 0.1 13:36:14 INFO - mozlog == 3.1 13:36:14 INFO - moznetwork == 0.27 13:36:14 INFO - mozprocess == 0.22 13:36:14 INFO - mozprofile == 0.28 13:36:14 INFO - mozrunner == 6.11 13:36:14 INFO - mozscreenshot == 0.1 13:36:14 INFO - mozsystemmonitor == 0.0 13:36:14 INFO - moztest == 0.7 13:36:14 INFO - mozversion == 1.4 13:36:14 INFO - psutil == 3.1.1 13:36:14 INFO - requests == 1.2.3 13:36:14 INFO - wsgiref == 0.1.2 13:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:14 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')]} 13:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:14 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')]} 13:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:14 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:14 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 13:36:14 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 13:36:14 INFO - Using env: {'DISPLAY': ':0', 13:36:14 INFO - 'HOME': '/home/cltbld', 13:36:14 INFO - 'LANG': 'en_US.UTF-8', 13:36:14 INFO - 'LANGUAGE': 'en_US:en', 13:36:14 INFO - 'LOGNAME': 'cltbld', 13:36:14 INFO - 'MAIL': '/var/mail/cltbld', 13:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:14 INFO - 'MOZ_NO_REMOTE': '1', 13:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:14 INFO - 'NO_EM_RESTART': '1', 13:36:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:14 INFO - 'PWD': '/builds/slave/test', 13:36:14 INFO - 'SHELL': '/bin/bash', 13:36:14 INFO - 'SHLVL': '1', 13:36:14 INFO - 'TERM': 'linux', 13:36:14 INFO - 'TMOUT': '86400', 13:36:14 INFO - 'USER': 'cltbld', 13:36:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:14 INFO - '_': '/tools/buildbot/bin/python'} 13:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 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)) 13:36:15 INFO - Cleaning up... 13:36:15 INFO - Return code: 0 13:36:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:15 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 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36:15 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 13:36:15 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 13:36:15 INFO - Using env: {'DISPLAY': ':0', 13:36:15 INFO - 'HOME': '/home/cltbld', 13:36:15 INFO - 'LANG': 'en_US.UTF-8', 13:36:15 INFO - 'LANGUAGE': 'en_US:en', 13:36:15 INFO - 'LOGNAME': 'cltbld', 13:36:15 INFO - 'MAIL': '/var/mail/cltbld', 13:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:15 INFO - 'MOZ_NO_REMOTE': '1', 13:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:15 INFO - 'NO_EM_RESTART': '1', 13:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:15 INFO - 'PWD': '/builds/slave/test', 13:36:15 INFO - 'SHELL': '/bin/bash', 13:36:15 INFO - 'SHLVL': '1', 13:36:15 INFO - 'TERM': 'linux', 13:36:15 INFO - 'TMOUT': '86400', 13:36:15 INFO - 'USER': 'cltbld', 13:36:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:15 INFO - '_': '/tools/buildbot/bin/python'} 13:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:15 INFO - Downloading/unpacking jsonschema 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:15 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 13:36:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:36:17 INFO - Downloading/unpacking functools32 (from jsonschema) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:17 INFO - Downloading functools32-3.2.3-2.tar.gz 13:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:36:17 INFO - warning: no files found matching '*.txt' 13:36:17 INFO - no previously-included directories found matching 'build' 13:36:17 INFO - no previously-included directories found matching 'dist' 13:36:17 INFO - no previously-included directories found matching '.git*' 13:36:17 INFO - Installing collected packages: jsonschema, functools32 13:36:17 INFO - Running setup.py install for functools32 13:36:17 INFO - warning: no files found matching '*.txt' 13:36:17 INFO - no previously-included directories found matching 'build' 13:36:17 INFO - no previously-included directories found matching 'dist' 13:36:17 INFO - no previously-included directories found matching '.git*' 13:36:17 INFO - Successfully installed jsonschema functools32 13:36:17 INFO - Cleaning up... 13:36:17 INFO - Return code: 0 13:36:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb677c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', '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 13:36: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', 'flake8'] in /builds/slave/test/build 13:36: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 flake8 13:36:17 INFO - Using env: {'DISPLAY': ':0', 13:36:17 INFO - 'HOME': '/home/cltbld', 13:36:17 INFO - 'LANG': 'en_US.UTF-8', 13:36:17 INFO - 'LANGUAGE': 'en_US:en', 13:36:17 INFO - 'LOGNAME': 'cltbld', 13:36:17 INFO - 'MAIL': '/var/mail/cltbld', 13:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:17 INFO - 'MOZ_NO_REMOTE': '1', 13:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:17 INFO - 'NO_EM_RESTART': '1', 13:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:17 INFO - 'PWD': '/builds/slave/test', 13:36:17 INFO - 'SHELL': '/bin/bash', 13:36:17 INFO - 'SHLVL': '1', 13:36:17 INFO - 'TERM': 'linux', 13:36:17 INFO - 'TMOUT': '86400', 13:36:17 INFO - 'USER': 'cltbld', 13:36:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:17 INFO - '_': '/tools/buildbot/bin/python'} 13:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:17 INFO - Downloading/unpacking flake8 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:36:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:36:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:20 INFO - no previously-included directories found matching 'docs/_build' 13:36:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:36:20 INFO - Running setup.py install for pep8 13:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:20 INFO - no previously-included directories found matching 'docs/_build' 13:36:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:36:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:36:20 INFO - Cleaning up... 13:36:20 INFO - Return code: 0 13:36:20 INFO - Running post-action listener: _resource_record_post_action 13:36:20 INFO - Running post-action listener: _start_resource_monitoring 13:36:20 INFO - Starting resource monitoring. 13:36:20 INFO - ##### 13:36:20 INFO - ##### Running install step. 13:36:20 INFO - ##### 13:36:20 INFO - Running pre-action listener: _resource_record_pre_action 13:36:20 INFO - Running main action method: install 13:36:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:20 INFO - Reading from file tmpfile_stdout 13:36:20 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:20 INFO - Reading from file tmpfile_stdout 13:36:20 INFO - Output received: 13:36:20 INFO - Usage: mozinstall [options] installer 13:36:20 INFO - Options: 13:36:20 INFO - -h, --help show this help message and exit 13:36:20 INFO - -d DEST, --destination=DEST 13:36:20 INFO - Directory to install application into. [default: 13:36:20 INFO - "/builds/slave/test"] 13:36:20 INFO - --app=APP Application being installed. [default: firefox] 13:36:20 INFO - mkdir: /builds/slave/test/build/application 13:36:20 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'] 13:36:20 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 13:36:36 INFO - Reading from file tmpfile_stdout 13:36:36 INFO - Output received: 13:36:36 INFO - /builds/slave/test/build/application/firefox/firefox 13:36:36 INFO - Running post-action listener: _resource_record_post_action 13:36:36 INFO - ##### 13:36:36 INFO - ##### Running run-tests step. 13:36:36 INFO - ##### 13:36:36 INFO - Running pre-action listener: _resource_record_pre_action 13:36:36 INFO - Running main action method: run_tests 13:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:36:36 INFO - Python 2.7.3 13:36:36 INFO - Return code: 0 13:36:36 INFO - grabbing minidump binary from tooltool 13:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:36:36 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 0x1fab410>, '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 0x1fac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:36:36 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 13:36:36 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 13:36:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:36:36 INFO - Return code: 0 13:36:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:36:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:36:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:36:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:36:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:36:37 INFO - Return code: 0 13:36:37 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:36:37 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:36:37 INFO - Using env: {'DISPLAY': ':0', 13:36:37 INFO - 'HOME': '/home/cltbld', 13:36:37 INFO - 'LANG': 'en_US.UTF-8', 13:36:37 INFO - 'LANGUAGE': 'en_US:en', 13:36:37 INFO - 'LOGNAME': 'cltbld', 13:36:37 INFO - 'MAIL': '/var/mail/cltbld', 13:36:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:37 INFO - 'MOZ_NO_REMOTE': '1', 13:36:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:37 INFO - 'NO_EM_RESTART': '1', 13:36:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:37 INFO - 'PWD': '/builds/slave/test', 13:36:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:37 INFO - 'SHELL': '/bin/bash', 13:36:37 INFO - 'SHLVL': '1', 13:36:37 INFO - 'TERM': 'linux', 13:36:37 INFO - 'TMOUT': '86400', 13:36:37 INFO - 'USER': 'cltbld', 13:36:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479', 13:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:37 INFO - '_': '/tools/buildbot/bin/python'} 13:36:37 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/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:36:37 INFO - mozversion application_buildid: 20160425103006 13:36:37 INFO - mozversion application_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:36:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:36:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:36:37 INFO - mozversion application_name: Firefox 13:36:37 INFO - mozversion application_remotingname: firefox-dev 13:36:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:37 INFO - mozversion application_vendor: Mozilla 13:36:37 INFO - mozversion application_version: 48.0a2 13:36:37 INFO - mozversion platform_buildid: 20160425103006 13:36:37 INFO - mozversion platform_changeset: 0d6a91c76a9eddf2219caf028dea130f2d683ec2 13:36:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:36:37 INFO - mozversion platform_version: 48.0a2 13:36:37 INFO - using testdate: 1461616597 13:36:37 INFO - actual date: 1461616597 13:36:37 INFO - starting webserver on 'localhost:52062' 13:36:37 INFO - SUITE-START | Running 2 tests 13:36:37 INFO - TEST-START | dromaeo_css 13:36:37 INFO - operating with platform_type : linux_ 13:36:37 INFO - Initialising browser for dromaeo_css test... 13:36:37 INFO - TEST-INFO | started process 20044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWx_ET/profile http://localhost:52062/getInfo.html) 13:36:41 INFO - PROCESS | 20044 | 13:36:41 INFO - PROCESS | 20044 | (process:20123): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:36:42 INFO - PROCESS | 20044 | __metrics Screen width/height:1600/1200 13:36:42 INFO - PROCESS | 20044 | colorDepth:24 13:36:42 INFO - PROCESS | 20044 | Browser inner width/height: 1024/697 13:36:42 INFO - PROCESS | 20044 | __metrics 13:36:43 ERROR - PROCESS | 20044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:36:44 INFO - TEST-INFO | 20044: exit 0 13:36:44 INFO - Browser initialized. 13:36:44 INFO - Running cycle 1/1 for dromaeo_css test... 13:36:44 INFO - TEST-INFO | started process 20174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWx_ET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:45 INFO - PROCESS | 20174 | 13:36:45 INFO - PROCESS | 20174 | (process:20242): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:36:56 INFO - PROCESS | 20174 | RSS: Main: 152674304 13:36:56 INFO - PROCESS | 20174 | 13:37:45 INFO - PROCESS | 20174 | 1461616665577 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] 13:39:53 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52062/tests/dromaeo/cssquery-ext.html) 13:39:54 INFO - PROCESS | 20174 | RSS: Main: 155377664 13:39:54 INFO - PROCESS | 20174 | 13:42:55 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-ext.html (next: http://localhost:52062/tests/dromaeo/cssquery-jquery.html) 13:42:56 INFO - PROCESS | 20174 | RSS: Main: 155238400 13:42:56 INFO - PROCESS | 20174 | 13:45:58 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52062/tests/dromaeo/cssquery-mootools.html) 13:45:58 INFO - PROCESS | 20174 | RSS: Main: 153911296 13:45:58 INFO - PROCESS | 20174 | 13:49:00 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52062/tests/dromaeo/cssquery-prototype.html) 13:49:01 INFO - PROCESS | 20174 | RSS: Main: 153600000 13:49:01 INFO - PROCESS | 20174 | 13:52:03 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52062/tests/dromaeo/cssquery-yui.html) 13:52:04 INFO - PROCESS | 20174 | RSS: Main: 155234304 13:52:04 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | Cycle 1(1): loaded http://localhost:52062/tests/dromaeo/cssquery-yui.html (next: http://localhost:52062/tests/dromaeo/cssquery-dojo.html) 13:55:06 INFO - PROCESS | 20174 | RSS: Main: 155770880 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | __start_tp_report 13:55:06 INFO - PROCESS | 20174 | _x_x_mozilla_page_load 13:55:06 INFO - PROCESS | 20174 | _x_x_mozilla_page_load_details 13:55:06 INFO - PROCESS | 20174 | |i|pagename|runs| 13:55:06 INFO - PROCESS | 20174 | |0;dojo.html;3377.2063565062213;3421.777584457011;3425.0581090200194;3429.725621950244;3450.8964731058077;5754.856128596787;5761.625494342875;5776.537876969837;5783.5373170146395;5793.82618521444;5734.369219385864;5791;5800.332961709405;5804.303483581976;5804.883902321962;5154.458781827911;5217.060929032773;5236.8690782730355;5285.656432331886;5335.119705248649;5153.330067091273;5276.1030624793875;5370.946290537103;5371.086915224421;5380;5198.09033419152;5242.501962313574;5268.736563171845;5282.841514754564;5352.063388906945;5228.5555727763185;5263.1578947368425;5266.631335806457;5274.024305503475;5284.5772338212855;5020.523050310215;5100.132977393852;5159.871003224912;5203.531682148587;5207.140821764404;5562.749676264578;5562.833115006556;5611.8877622447735;5645.15322701594;5661.943380566224;6053.667048312341;6098.756049758004;6104.298005729309;6115.571909966304;6118.388161183891;6031.849203769897;6038.1848450459065;6163.630182189038;6168.228971378578;6175.197224360849;5729.4843464088435;5762.88474230513;5764.884702305931;5769.538436925036;5811.941880581182;6271.059341098871;6284.622922624657;6297.118403423525;6301.212348456443;6323.1779868617705;5821.2141360916585;5943.762249509971;5979.970100149471;6012.038073908154;6073.423024812724;6062.151298818169;6064.696765161724;6066.575339726177;6080.361562036011;6131.080337949344;5974.163617093611;6011.458968692838;6017.608855424383;6036.6679832609625;6051.969740151271;5887.175795388649;6062.757489700362;6081.817545473643;6121.117656725397;6130.540209484307;4579.7252164870215;4588.403507544064;4591.242444996538;4602.907941841211;4606.493285738566;4097.405876147942;4110.34234522475;4127.2570937231585;4137;4145;5736.856578585485;5806.071028635482;5888.558358123158;5912.733926973297;5916.615419997686;6096.207493025879;6108.511319094462;6111.480524155497;6119.694015299217;6124.755009799647;5718.285214348207;5790.131480277992;5792.362840087587;5813.360530341659;5821;5154.5103215194495;5267.631265811357;5275.366955965232;5284.656497327738;5286.048511268009;6277.340879207617;6423.903641445382;6462.095306657072;6467.547271691031;6470.64411457365;6049.51603871698;6078.118672792332;6082.2701275847185;6090.33006369299;6102.023676211785;6239;6287.339829317856;6294.622322660655;6324.430801227912;6330.3669633036325;6088.726007329592;6093.695315234132;6097.634141951497;6101.115338275837;6128.387161283836;6140.377058150382;6190.845228869134;6200.131981522501;6207.441330280297;6217.875642487215;5839.970800146142;5973.074173503114;6024.865155880918;6031.125486804476;6053.606515576474;6050.2437195350585;6051.848703782441;6052.485538729257;6065.939340606714;6066.15073889647;5898.6350100925865;5899.705014749331;5944.762209511571;5960.5231581474245;5980.34216236205;5854.970725146347;6028.5177185825905;6117.449429551361;6121.696863452088;6150.477209437069;5897.997340452048;5905.4685078343155;5907.350191478848;5932.050871860654;5952.613080149777 13:55:06 INFO - PROCESS | 20174 | |1;ext.html;623.6975067092459;663.847315117523;675.9729610815567;683.9042534045232;684.1174884399126;36656.450153247686;38272.80863595682;38416.80791596045;38490.61509384913;38657;39701;40462.7976860116;40500.79749601248;40760.18479630406;40762.18475630486;8811.471311721301;9036.728898133066;9067.138621830916;9074.410163339395;9105.817883642323;8889.066648001964;8918.063603321654;8950.194482496574;9013.23387512059;9016.504092274923;9022.639094436214;9048.592813323416;9066.954665226665;9076.909230907673;9080.591373388213;8910;8924.152205540464;8949.910500895037;8951;9035.367524273304;8905.465672059698;8932.151445612657;8970.192682658528;8976.41653292534;9020;32905;40102.39846402306;40491.59508404908;40805.59194408077;40835.38746918798;3487.5640544931885;3564.429691249388;3567.8751243706347;3981.5620281768984;4252.808623611945;29752;30285.091447256396;30579.23551911198;30615.234619134477;31125.066248012597;4474.865754027384;4505.36924830524;4577.359169716243;4587.472440669332;4658.394408726877;220799;221410;222480.99999999837;222962;225113;54697.72651136719;55623;55904;55993.7200314004;56185;58598.121028184614;59240;59260.70369648124;59551.70224148938;59613.701931490934;15739.055656660637;16067.919660401623;16136.838631613768;16173.27220275067;16233.837661623233;11444.713882153013;11513.827292590619;11619.186656934102;11628.418579071013;11648.88351116478;19881;20218.797812021985;20280.695789563168;20291.28980485676;20717.58564828695;7588.544687318668;7764.922350776533;7820.653803858933;7844.607769611496;7905.723299684599;1083.0523292119397;1084.9132069434427;1097.6816723150357;1175.6456353409833;1194.2595590733802;31473.685263147534;31865.36269274648;31913.52129718056;32277.677223227467;32470.512942305886;1142.5943789954447;1208.86098098718;1229.5327775445453;1269.3335998600808;1322.0943653597317;16670.499885003228;17287.56781080458;17311.3941012064;17366.3053477862;17426.564335891704;334278;336032;337767;405608;521198;56605.71697141488;57263;57330.426695733346;57676;57846.710766445896;1421.2822524625205;1458.7637848199033;1480.4078368652624;1481.3259966715334;1487.3530014443752;33168;33584.16039599029;33617.83191084029;34086.65913340835;34681.13297167591;53820;54475.18287225774;54527.18209226785;54571.45428545664;54875.07937222178;464764;467164;467238;467800;468583;30456.390872182874;31213.375732485678;31288.37423251477;31327.37345253128;31336;45374.092518150115;45387;45475.77262113668;45675.54324456846;46343.30485042794;42680.57319426766;42738.358924616776;43248.56751432445;43706;44151;41620.791896040326;42749.786251068545;42809.1438171241;43258.134837302445;43486.782566086964;42061;42816;43136.78431607822;43203.567964319955;43391.34912976245;36133.27733445369;36927.63072369242;37217.627823721414;37870.24259514849;37950.62049379581;28011.159665210078;28035.43929121447;28367.716322836506;28527.572086419135;28755.712442875305 13:55:06 INFO - PROCESS | 20174 | |2;jquery.html;373.58345444829024;378.56843198753427;382.76459977114075;382.9942550861737;390.3715018819702;18950;20470.2835400761;20529.38411847643;21269.57460850782;21451.892740536296;15659.295331710073;16407.261673224704;16504.42234521792;16549.25528351224;16591.253393597286;5521.171824226378;5705.139711601753;5713.057345537981;5761.798337058204;5789.884202315951;5551.417101204356;5658.321001479828;5661.122526008476;5669.376368599451;5678.43215678433;5539.169124631318;5604.215409842625;5626;5632;5633.267675202218;5581.134924086773;5609.971950140243;5616.803411880605;5642.379338272786;5645.294338207704;4881.1213981483315;4969.055879382906;4981.178105612606;4984.800607975677;5056.115179843549;23255.88372058129;23364.766352336428;23582.29253122409;23807.285781426584;23831.523369532686;2362.8464149830206;2395;2497.2633073243437;2504.7306045214655;2646.3913299940928;14601.123932563974;14619.342129604192;14632.780508292384;14997.475088371855;15060.623484412868;2012.8087831655969;2100.978990210094;2141.2826703054498;2172.0660116150048;2213.103693004336;82343;83513.58243208745;85634.57182714109;85790.71313930358;86384;9900.405975641484;10306.12397946183;10456.268061235793;10695.251332406657;10708.250422470508;14342.641433964234;14354.569362919128;14468;14546.4908728194;14550.636234094021;7621.961890190513;8030.839383212303;8078.959605201936;8160.428769986044;8193.09875913649;7736.497127686683;7771.222877712296;7901.762947111596;7960.4825686330205;7991;6552.279249282575;6562.179727534059;6592.373724496165;6640.501962352843;6773.322667733188;1793.3812834572052;1812.7371531127912;1824.36147348427;1858;1876.1369769905723;1033.3827559868932;1091.7052395853075;1201.9098567607289;1204.114975493012;1220.664317312746;19534.804651953582;19577.706334404997;19654;19917.502062448555;20297;1068.4444089073793;1089.8583184186004;1113.8050841102774;1115.4088333183427;1176.276589897207;11337.716557085974;11473.71315717097;11587.942060289644;11640.126990475748;11667.941660291644;516014;518042;519178;537023;545451;60537.69731151404;79342;88676.5566172165;89072;91068;1143.1255089856268;1145.5589598004663;1185.6146752305535;1186.3297237061206;1213.7633161533415;16150.596235094217;16728.832711672727;16903.915480422518;16936.153192340582;17733.733993990358;38326.425103624024;38780.80609596934;39080.80459597798;39182.41226381664;39334.60665393309;55947;62817.68591157015;63545;64155;64291;7782.066152061789;8024.9598752008205;8127.227913348459;8187.771834224914;8657.991437479068;8508.27679647237;12133.272003679807;13641;13894.652633684238;13921.373538190603;11888.702782430508;12143.574974875837;12208.755824883276;12324.260544367367;12567.120301578801;5720;10946.288491248044;11707.590234341757;11776.410184624967;12131.150819442555;12067.275963442222;12373.62879113628;12386.690332741753;12444.377781110727;12451.813222801484;7536.698532058656;8022.438429309892;8178.5092894426525;8273.048599411144;8325.750227493185;9817.4600396976;11312.94343528277;11369.602063927723;11674.70813229676;11717.707057323634 13:55:06 INFO - PROCESS | 20174 | |3;mootools.html;1615.1520451762824;1616.862566681832;1808.9005104719236;1883.9905800470995;1910.512819231095;7659.923400765991;7998.9600051999805;8227.999999999993;8425.115362886892;8499;8373.288270497014;8418.410711250215;8423.873641895376;8472.406931514797;8488.660453581864;2341.3912382780472;2376.192094687806;2377.072941552787;2386.7971222446026;2391.5575618510543;2295.598270302699;2317.7450480447137;2357.6463530470483;2369.1944738788807;2376.5128148729555;2330.9650355244685;2355.5171189906114;2375.8812059397046;2384.141708984764;2385.212879749687;2291.140822191678;2319.8724070176136;2322.326525307659;2326.8138548916218;2363.7045369328835;2235.452314183019;2236.5303286309895;2236.899339529709;2237.630790919496;2238.8320875934205;8510.87233691489;8573;8624.698135565224;8662.393632445732;8670.219680228747;4794.880127996793;4920.507949205086;4932.358793356877;4934.358533390672;4937.728424936627;3281.5733954585753;3334.733221342287;3406.9659303406897;3473.6873681368547;3502.2820321833965;1077.4538537199066;1083.4366129612558;1136.5510623303749;1141.5034460009922;1151.5278735718398;11642.18504704671;11684.357360345177;11692.766144677058;11692.824607630891;11719.238249513754;4523.231050721385;4547.886302842456;4589.632829373709;4614.907701845944;4632.374629425052;9807.411555306562;9824;9858.802823943624;9869.309148359689;9872.457014864107;4818.638602104786;4888.706677599355;4937.679050861682;4937.679050861682;4948.134076536592;4017.819198136091;4261.2542805009;4313.374560688745;4436.26801577736;4445.110977804452;3900.297946369624;3904.1260195105942;3966.781826999543;4016.0763024504527;4042.110735638155;1225.136278923357;1258.672745086284;1259.3640211693037;1260.4832018872219;1265.5317532512845;979.397670432693;1018.0938964321759;1030.835066389374;1074.4412905289205;1095.4686976816238;5416.91874621881;5587.7485513152005;5646.962421868384;5738.225339579103;5837.737301821428;426.9530351661315;432.0775145065308;435.2426777407289;442.72993473980847;445.6835646690821;3977.54258260298;4003.2193722223888;4012.8996775080273;4072.450219220427;4266.189424009428;10177.898221017844;10334.121599664113;10457.84313235302;10485.213608979357;10592.15262778976;9941.45322007282;10335.17318614509;10413.5834566618;10462.63380781669;10555.947220264003;7823.843523129505;7913.604319783988;7937.960310198412;7987.800304992305;8001.4398992071165;5979.133025711334;6062.696865156637;6173.59871608362;6201.069839524108;6225.782097626561;9426.858597121185;9548.52257387114;9563.713088607354;9622.9037709622;9736.172425343924;9946.701598952042;9970.252231082843;10017.298789084694;10021.198304135505;10071.546780395047;7510.136334321404;7657.885131722917;7733.651985660546;7771.650275737492;7798.844023119619;7971.963644726148;7975.361971042419;8020.719274825587;8036;8045.155258697752;7331.303526165006;7352.4485663576515;7507.361874240751;7545.170031296443;7580.128285247267;7064.293570642894;7191.640417979184;7341.375983041501;7385.630718463948;7413.96293018553;6405.295417503978;6420.711068002044;6424.775132870327;6451.258105317761;6451.516136289891;4985.376827896513;5047.167217409086;5053.898922021465;5118.616103792305;5163.922541161961;5119.948800511947;5230.63385563007;5269.209618557247;5289.100852854947;5393.83818485446 13:55:06 INFO - PROCESS | 20174 | |4;prototype.html;298.8744727214571;301.96829332920043;306.62438512821797;309.2223059006599;315.86102115069383;5574.498295153436;5653.632513886605;5670.744816483258;5818.458108601224;5842.912356314659;5702.344230413503;5719.857003574913;5723.799667011655;5743.913841292384;5770.422957704228;4335.891602709926;4339.41417908583;4365.388845561624;4373.453318335208;4385.51759306476;4129.7315674481215;4345.78271086446;4363.716358436707;4379.321205213197;4399.208142534342;4253.383259427381;4275.657947364203;4293.441852559163;4301.505326887417;4313.525512193656;4280.272353699863;4292.61366477017;4295.699301048928;4309.095090031113;4315.956840431587;3578.1233597768455;3713.498677678506;3721.3115573618966;3723.8696645617274;3734.1784807342615;5520.254765606672;5552.361478429992;5558.277423934903;5558.499735023867;5560.666360018371;4939.580135688435;4955;4956.677815941952;4960;4981.302617633498;5721.227634269362;5949.940500594982;5999.520038396918;6046.395360463963;6047.879042419171;4050.2709512287774;4079.3473044313064;4099.3031184698375;4110.46563946685;4115.670746340315;6223.284322302902;6236.158118653969;6274.1843560336865;6287.842803929892;6295.748170073146;4079.204555111784;4149.8340066397;4153.736213763506;4168.24971505132;4193.720915120856;4152.1072969311745;4165.4584903962295;4186.623203911662;4187.685923555746;4190.769507677046;4896.4124305082905;4912.04215178044;4915.459299477055;4916.70499770015;4921.7785199666105;5915.733791979371;6039.275286965504;6050.485708714808;6057.212562366864;6084.939150608526;1515.7574788033862;1528.48031669233;1533.2180587900252;1535.5009621872937;1539.8306186319496;972.8666103988774;989.4805227255605;992.8659630949874;993.4337427666161;1002.9047240512285;6205.844853878599;6238.126662267196;6258.843528911722;6272.341404152589;6296.811095667137;6564.606123632502;6610.8016759497295;6627.4366678831875;6641.169853768279;6684.465242780566;6079.392060793885;6256.749730010749;6280.7487700491465;6294.464970477561;6301.7164227609865;3536.310419468179;3546.095745584911;3559.483874838134;3573.3032058748813;3575.6245594212755;6703.932960670429;6875.58746475203;6880.208775990725;6914.481413893978;6957.234704182536;6728.064082511785;6751.966240168767;6776.746301934059;6814.318568143146;6815.556988795812;6123.264808466832;6566.868662626721;6599.835004124935;6860.725570977105;6898.310168983062;6220.906686399617;6287.96856015717;6288.968555157195;6296.496280297473;6306.7610998095015;6032.6983650818165;6223.159873417031;6232.283287422005;6244.438000579969;6313.936860631335;6383.425491705769;6476.805695829133;6485.77299794505;6518.869622607616;6524.510661700297;4136.855210067633;4220.430241917425;4232.95767042338;4236.745795252295;4252.829886804493;6218.31598524171;6271.874562508816;6294.464970477377;6324.209473815773;6362.713677884413;5914.881702366015;6093.268807743099;6098.963176260135;6142.723577439116;6153.630782153085;6122.816315510542;6128.785492507741;6151.739578023655;6157.538184636081;6193.792210518905;5658.85852853682;5957.970210148921;6016.398360163948;6027.21646185993;6027.246594175728;6107.633541987318;6153;6163.38366163398;6165.198524191826;6172.512530420298;5939.821805345847;5980.8803823924145;5989.221401217814;6039.862694054586;6055.333913269625 13:55:06 INFO - PROCESS | 20174 | |5;yui.html;845.4907989239207;879.604178119846;910.1990248581252;928.0765638190002;937.4890684576905;12729.490820367175;12742.29917354545;12775.361231938412;13553.390097445614;14633.122012679247;14101.647458813535;14195.432182712704;14243.857561424382;14284.357203925849;14291.71416571668;877.6708734224666;896.0591379052001;923.9769005774842;924.7826760711228;926.7219834049791;913.634546181526;913.9497327646977;919.8482250428672;922.5018490015384;922.7923717163618;964.81668482988;966.8211380894522;966.9854952175723;967.89837067108;968.056145258371;951.8714973478561;953.9761505962337;954.0507195340612;954.2795189631818;955.4171955107379;704.7040243097911;707.024306457091;707.7912015955254;708.7625645408795;709.7835160276114;15507.379704811794;15546.76679849803;15589.532314030597;15592.376304947902;15599.298031588605;12834.614961551168;13490.460381584822;13550.59348219545;13581.320933953262;13590.932045339809;11396.145289103268;11396.772064558745;11432.48553815072;11443.485043173077;11533.308001519936;3921.843126274974;3945.3292940200236;3965.484487016698;3970.463987361698;3983.4821473208585;54620.72689636566;55842.441575583725;56105.71947140279;56375.71812140954;56633.43366566364;11320.886791131983;11347.148963827745;11466.197366184453;11577.363245021605;11722.76554468923;19269.518262043282;19648.70526942097;19664.901675491816;19851;19894.90052549728;8351.874721879176;8365.749027529184;8441.11368306319;8544.2310192083;8548;4968.577670897942;5041.218611115283;5046.4953504649975;5077.263796749525;5081.618878584047;3490.441529355291;3563.6436356364156;3699.500567423417;3863.9806800966376;3887.611238876146;687.3435868745336;698.4238003647012;709.4218212157075;709.9609521476265;716.4089626058523;681.7545683553917;755.7430473638989;769.4214466313113;786.3591173193829;800.9399295052895;9528.95235523818;9856.655017074369;9980.45107519079;10008.949955250177;10058.195344372432;693.6531734132933;719.8056524738291;720.1538192623647;736.373361196107;769.5767327969594;4688.718676879398;4756.239001759702;4786.545278198566;4820.9517904821205;4854.732989685531;74955.25044749591;76048;76393;77383;77566;61579;63210.41973950596;64040.35959640437;64500.67749661222;66098.66950665216;57967.710161449766;58851;58886.41113588895;58912;60200;8689.17452841979;8798.648054078021;8885.4668719877;8977.910220897707;9029.41308814925;36748.81625591855;37059.6294037067;37186.62813371832;37421.251574967806;37938.8103059483;43939.56060439483;46454.30318545292;49202.507974921224;49833;49985.75007124941;11670.183087183816;11728.88271117312;11762.470688818852;11963.222390544935;12022.819657705317;13745.175289482662;13930.651733706738;13933;14000.509982150576;14457.204853733145;12214.511419543118;12319.568815091787;12438.440270188044;12595.370231488572;12811.679708007374;12630.494780208688;12774.872251277367;12879.098463107492;13037.674058148623;13102.148360356547;12911;12992.740145197233;13202.933985330012;13264.668383290495;13871.23708196059;10826.783464330827;11018.84763583115;11214.719632009264;11315.603953861575;11335.773284534429;11045.83431248548;11164.776704466027;11204.887951120385;11236.55053797839;11478.139139564733 13:55:06 INFO - PROCESS | 20174 | __end_tp_report 13:55:06 INFO - PROCESS | 20174 | __start_cc_report 13:55:06 INFO - PROCESS | 20174 | _x_x_mozilla_cycle_collect,332 13:55:06 INFO - PROCESS | 20174 | __end_cc_report 13:55:06 INFO - PROCESS | 20174 | __startTimestamp1461617706368__endTimestamp 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | ------- Summary: start ------- 13:55:06 INFO - PROCESS | 20174 | Number of tests: 6 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#0] dojo.html Cycles:165 Average:5696.36 Median:5912.73 stddev:640.34 (10.8%) stddev-sans-first:615.91 13:55:06 INFO - PROCESS | 20174 | Values: 3377.2 3421.8 3425.1 3429.7 3450.9 5754.9 5761.6 5776.5 5783.5 5793.8 5734.4 5791.0 5800.3 5804.3 5804.9 5154.5 5217.1 5236.9 5285.7 5335.1 5153.3 5276.1 5370.9 5371.1 5380.0 5198.1 5242.5 5268.7 5282.8 5352.1 5228.6 5263.2 5266.6 5274.0 5284.6 5020.5 5100.1 5159.9 5203.5 5207.1 5562.7 5562.8 5611.9 5645.2 5661.9 6053.7 6098.8 6104.3 6115.6 6118.4 6031.8 6038.2 6163.6 6168.2 6175.2 5729.5 5762.9 5764.9 5769.5 5811.9 6271.1 6284.6 6297.1 6301.2 6323.2 5821.2 5943.8 5980.0 6012.0 6073.4 6062.2 6064.7 6066.6 6080.4 6131.1 5974.2 6011.5 6017.6 6036.7 6052.0 5887.2 6062.8 6081.8 6121.1 6130.5 4579.7 4588.4 4591.2 4602.9 4606.5 4097.4 4110.3 4127.3 4137.0 4145.0 5736.9 5806.1 5888.6 5912.7 5916.6 6096.2 6108.5 6111.5 6119.7 6124.8 5718.3 5790.1 5792.4 5813.4 5821.0 5154.5 5267.6 5275.4 5284.7 5286.0 6277.3 6423.9 6462.1 6467.5 6470.6 6049.5 6078.1 6082.3 6090.3 6102.0 6239.0 6287.3 6294.6 6324.4 6330.4 6088.7 6093.7 6097.6 6101.1 6128.4 6140.4 6190.8 6200.1 6207.4 6217.9 5840.0 5973.1 6024.9 6031.1 6053.6 6050.2 6051.8 6052.5 6065.9 6066.2 5898.6 5899.7 5944.8 5960.5 5980.3 5855.0 6028.5 6117.4 6121.7 6150.5 5898.0 5905.5 5907.4 5932.1 5952.6 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#1] ext.html Cycles:180 Average:53313.14 Median:40783.89 stddev:99350.41 (243.6%) stddev-sans-first:99550.35 13:55:06 INFO - PROCESS | 20174 | Values: 623.7 663.8 676.0 683.9 684.1 36656.5 38272.8 38416.8 38490.6 38657.0 39701.0 40462.8 40500.8 40760.2 40762.2 8811.5 9036.7 9067.1 9074.4 9105.8 8889.1 8918.1 8950.2 9013.2 9016.5 9022.6 9048.6 9067.0 9076.9 9080.6 8910.0 8924.2 8949.9 8951.0 9035.4 8905.5 8932.2 8970.2 8976.4 9020.0 32905.0 40102.4 40491.6 40805.6 40835.4 3487.6 3564.4 3567.9 3981.6 4252.8 29752.0 30285.1 30579.2 30615.2 31125.1 4474.9 4505.4 4577.4 4587.5 4658.4 220799.0 221410.0 222481.0 222962.0 225113.0 54697.7 55623.0 55904.0 55993.7 56185.0 58598.1 59240.0 59260.7 59551.7 59613.7 15739.1 16067.9 16136.8 16173.3 16233.8 11444.7 11513.8 11619.2 11628.4 11648.9 19881.0 20218.8 20280.7 20291.3 20717.6 7588.5 7764.9 7820.7 7844.6 7905.7 1083.1 1084.9 1097.7 1175.6 1194.3 31473.7 31865.4 31913.5 32277.7 32470.5 1142.6 1208.9 1229.5 1269.3 1322.1 16670.5 17287.6 17311.4 17366.3 17426.6 334278.0 336032.0 337767.0 405608.0 521198.0 56605.7 57263.0 57330.4 57676.0 57846.7 1421.3 1458.8 1480.4 1481.3 1487.4 33168.0 33584.2 33617.8 34086.7 34681.1 53820.0 54475.2 54527.2 54571.5 54875.1 464764.0 467164.0 467238.0 467800.0 468583.0 30456.4 31213.4 31288.4 31327.4 31336.0 45374.1 45387.0 45475.8 45675.5 46343.3 42680.6 42738.4 43248.6 43706.0 44151.0 41620.8 42749.8 42809.1 43258.1 43486.8 42061.0 42816.0 43136.8 43203.6 43391.3 36133.3 36927.6 37217.6 37870.2 37950.6 28011.2 28035.4 28367.7 28527.6 28755.7 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#2] jquery.html Cycles:180 Average:29949.84 Median:23819.40 stddev:86662.77 (363.8%) stddev-sans-first:86877.42 13:55:06 INFO - PROCESS | 20174 | Values: 373.6 378.6 382.8 383.0 390.4 18950.0 20470.3 20529.4 21269.6 21451.9 15659.3 16407.3 16504.4 16549.3 16591.3 5521.2 5705.1 5713.1 5761.8 5789.9 5551.4 5658.3 5661.1 5669.4 5678.4 5539.2 5604.2 5626.0 5632.0 5633.3 5581.1 5610.0 5616.8 5642.4 5645.3 4881.1 4969.1 4981.2 4984.8 5056.1 23255.9 23364.8 23582.3 23807.3 23831.5 2362.8 2395.0 2497.3 2504.7 2646.4 14601.1 14619.3 14632.8 14997.5 15060.6 2012.8 2101.0 2141.3 2172.1 2213.1 82343.0 83513.6 85634.6 85790.7 86384.0 9900.4 10306.1 10456.3 10695.3 10708.3 14342.6 14354.6 14468.0 14546.5 14550.6 7622.0 8030.8 8079.0 8160.4 8193.1 7736.5 7771.2 7901.8 7960.5 7991.0 6552.3 6562.2 6592.4 6640.5 6773.3 1793.4 1812.7 1824.4 1858.0 1876.1 1033.4 1091.7 1201.9 1204.1 1220.7 19534.8 19577.7 19654.0 19917.5 20297.0 1068.4 1089.9 1113.8 1115.4 1176.3 11337.7 11473.7 11587.9 11640.1 11667.9 516014.0 518042.0 519178.0 537023.0 545451.0 60537.7 79342.0 88676.6 89072.0 91068.0 1143.1 1145.6 1185.6 1186.3 1213.8 16150.6 16728.8 16903.9 16936.2 17733.7 38326.4 38780.8 39080.8 39182.4 39334.6 55947.0 62817.7 63545.0 64155.0 64291.0 7782.1 8025.0 8127.2 8187.8 8658.0 8508.3 12133.3 13641.0 13894.7 13921.4 11888.7 12143.6 12208.8 12324.3 12567.1 5720.0 10946.3 11707.6 11776.4 12131.2 12067.3 12373.6 12386.7 12444.4 12451.8 7536.7 8022.4 8178.5 8273.0 8325.8 9817.5 11312.9 11369.6 11674.7 11717.7 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#3] mootools.html Cycles:180 Average:5593.71 Median:4713.63 stddev:3133.04 (66.5%) stddev-sans-first:3127.57 13:55:06 INFO - PROCESS | 20174 | Values: 1615.2 1616.9 1808.9 1884.0 1910.5 7659.9 7999.0 8228.0 8425.1 8499.0 8373.3 8418.4 8423.9 8472.4 8488.7 2341.4 2376.2 2377.1 2386.8 2391.6 2295.6 2317.7 2357.6 2369.2 2376.5 2331.0 2355.5 2375.9 2384.1 2385.2 2291.1 2319.9 2322.3 2326.8 2363.7 2235.5 2236.5 2236.9 2237.6 2238.8 8510.9 8573.0 8624.7 8662.4 8670.2 4794.9 4920.5 4932.4 4934.4 4937.7 3281.6 3334.7 3407.0 3473.7 3502.3 1077.5 1083.4 1136.6 1141.5 1151.5 11642.2 11684.4 11692.8 11692.8 11719.2 4523.2 4547.9 4589.6 4614.9 4632.4 9807.4 9824.0 9858.8 9869.3 9872.5 4818.6 4888.7 4937.7 4937.7 4948.1 4017.8 4261.3 4313.4 4436.3 4445.1 3900.3 3904.1 3966.8 4016.1 4042.1 1225.1 1258.7 1259.4 1260.5 1265.5 979.4 1018.1 1030.8 1074.4 1095.5 5416.9 5587.7 5647.0 5738.2 5837.7 427.0 432.1 435.2 442.7 445.7 3977.5 4003.2 4012.9 4072.5 4266.2 10177.9 10334.1 10457.8 10485.2 10592.2 9941.5 10335.2 10413.6 10462.6 10555.9 7823.8 7913.6 7938.0 7987.8 8001.4 5979.1 6062.7 6173.6 6201.1 6225.8 9426.9 9548.5 9563.7 9622.9 9736.2 9946.7 9970.3 10017.3 10021.2 10071.5 7510.1 7657.9 7733.7 7771.7 7798.8 7972.0 7975.4 8020.7 8036.0 8045.2 7331.3 7352.4 7507.4 7545.2 7580.1 7064.3 7191.6 7341.4 7385.6 7414.0 6405.3 6420.7 6424.8 6451.3 6451.5 4985.4 5047.2 5053.9 5118.6 5163.9 5119.9 5230.6 5269.2 5289.1 5393.8 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#4] prototype.html Cycles:180 Average:5112.59 Median:5944.88 stddev:1593.86 (26.8%) stddev-sans-first:1556.84 13:55:06 INFO - PROCESS | 20174 | Values: 298.9 302.0 306.6 309.2 315.9 5574.5 5653.6 5670.7 5818.5 5842.9 5702.3 5719.9 5723.8 5743.9 5770.4 4335.9 4339.4 4365.4 4373.5 4385.5 4129.7 4345.8 4363.7 4379.3 4399.2 4253.4 4275.7 4293.4 4301.5 4313.5 4280.3 4292.6 4295.7 4309.1 4316.0 3578.1 3713.5 3721.3 3723.9 3734.2 5520.3 5552.4 5558.3 5558.5 5560.7 4939.6 4955.0 4956.7 4960.0 4981.3 5721.2 5949.9 5999.5 6046.4 6047.9 4050.3 4079.3 4099.3 4110.5 4115.7 6223.3 6236.2 6274.2 6287.8 6295.7 4079.2 4149.8 4153.7 4168.2 4193.7 4152.1 4165.5 4186.6 4187.7 4190.8 4896.4 4912.0 4915.5 4916.7 4921.8 5915.7 6039.3 6050.5 6057.2 6084.9 1515.8 1528.5 1533.2 1535.5 1539.8 972.9 989.5 992.9 993.4 1002.9 6205.8 6238.1 6258.8 6272.3 6296.8 6564.6 6610.8 6627.4 6641.2 6684.5 6079.4 6256.7 6280.7 6294.5 6301.7 3536.3 3546.1 3559.5 3573.3 3575.6 6703.9 6875.6 6880.2 6914.5 6957.2 6728.1 6752.0 6776.7 6814.3 6815.6 6123.3 6566.9 6599.8 6860.7 6898.3 6220.9 6288.0 6289.0 6296.5 6306.8 6032.7 6223.2 6232.3 6244.4 6313.9 6383.4 6476.8 6485.8 6518.9 6524.5 4136.9 4220.4 4233.0 4236.7 4252.8 6218.3 6271.9 6294.5 6324.2 6362.7 5914.9 6093.3 6099.0 6142.7 6153.6 6122.8 6128.8 6151.7 6157.5 6193.8 5658.9 5958.0 6016.4 6027.2 6027.2 6107.6 6153.0 6163.4 6165.2 6172.5 5939.8 5980.9 5989.2 6039.9 6055.3 13:55:06 INFO - PROCESS | 20174 | 13:55:06 INFO - PROCESS | 20174 | [#5] yui.html Cycles:180 Average:16070.34 Median:4771.39 stddev:19629.27 (411.4%) stddev-sans-first:19651.04 13:55:06 INFO - PROCESS | 20174 | Values: 845.5 879.6 910.2 928.1 937.5 12729.5 12742.3 12775.4 13553.4 14633.1 14101.6 14195.4 14243.9 14284.4 14291.7 877.7 896.1 924.0 924.8 926.7 913.6 913.9 919.8 922.5 922.8 964.8 966.8 967.0 967.9 968.1 951.9 954.0 954.1 954.3 955.4 704.7 707.0 707.8 708.8 709.8 15507.4 15546.8 15589.5 15592.4 15599.3 12834.6 13490.5 13550.6 13581.3 13590.9 11396.1 11396.8 11432.5 11443.5 11533.3 3921.8 3945.3 3965.5 3970.5 3983.5 54620.7 55842.4 56105.7 56375.7 56633.4 11320.9 11347.1 11466.2 11577.4 11722.8 19269.5 19648.7 19664.9 19851.0 19894.9 8351.9 8365.7 8441.1 8544.2 8548.0 4968.6 5041.2 5046.5 5077.3 5081.6 3490.4 3563.6 3699.5 3864.0 3887.6 687.3 698.4 709.4 710.0 716.4 681.8 755.7 769.4 786.4 800.9 9529.0 9856.7 9980.5 10008.9 10058.2 693.7 719.8 720.2 736.4 769.6 4688.7 4756.2 4786.5 4821.0 4854.7 74955.3 76048.0 76393.0 77383.0 77566.0 61579.0 63210.4 64040.4 64500.7 66098.7 57967.7 58851.0 58886.4 58912.0 60200.0 8689.2 8798.6 8885.5 8977.9 9029.4 36748.8 37059.6 37186.6 37421.3 37938.8 43939.6 46454.3 49202.5 49833.0 49985.8 11670.2 11728.9 11762.5 11963.2 12022.8 13745.2 13930.7 13933.0 14000.5 14457.2 12214.5 12319.6 12438.4 12595.4 12811.7 12630.5 12774.9 12879.1 13037.7 13102.1 12911.0 12992.7 13202.9 13264.7 13871.2 10826.8 11018.8 11214.7 11315.6 11335.8 11045.8 11164.8 11204.9 11236.6 11478.1 13:55:06 INFO - PROCESS | 20174 | -------- Summary: end -------- 13:55:06 INFO - PROCESS | 20174 | 13:55:07 INFO - TEST-INFO | 20174: exit 0 13:55:07 INFO - TEST-OK | dromaeo_css | took 1109235ms 13:55:07 INFO - TEST-START | kraken 13:55:07 INFO - operating with platform_type : linux_ 13:55:07 INFO - Initialising browser for kraken test... 13:55:07 INFO - TEST-INFO | started process 20419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwzXwU/profile http://localhost:52062/getInfo.html) 13:55:10 INFO - PROCESS | 20419 | 13:55:10 INFO - PROCESS | 20419 | (process:20493): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:55:11 INFO - PROCESS | 20419 | __metrics Screen width/height:1600/1200 13:55:11 INFO - PROCESS | 20419 | colorDepth:24 13:55:11 INFO - PROCESS | 20419 | Browser inner width/height: 1024/697 13:55:11 INFO - PROCESS | 20419 | __metrics 13:55:12 ERROR - PROCESS | 20419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:55:13 INFO - TEST-INFO | 20419: exit 0 13:55:13 INFO - Browser initialized. 13:55:13 INFO - Running cycle 1/1 for kraken test... 13:55:13 INFO - TEST-INFO | started process 20544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwwzXwU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:15 INFO - PROCESS | 20544 | 13:55:15 INFO - PROCESS | 20544 | (process:20610): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:55:25 INFO - PROCESS | 20544 | RSS: Main: 151764992 13:55:25 INFO - PROCESS | 20544 | 13:55:27 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52062/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:28 INFO - PROCESS | 20544 | RSS: Main: 156545024 13:55:28 INFO - PROCESS | 20544 | 13:55:31 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52062/tests/kraken/driver.html?testName=audio-dft) 13:55:31 INFO - PROCESS | 20544 | RSS: Main: 156745728 13:55:31 INFO - PROCESS | 20544 | 13:55:34 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52062/tests/kraken/driver.html?testName=audio-fft) 13:55:35 INFO - PROCESS | 20544 | RSS: Main: 157134848 13:55:35 INFO - PROCESS | 20544 | 13:55:37 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52062/tests/kraken/driver.html?testName=audio-oscillator) 13:55:37 INFO - PROCESS | 20544 | RSS: Main: 157253632 13:55:37 INFO - PROCESS | 20544 | 13:55:40 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:55:40 INFO - PROCESS | 20544 | RSS: Main: 157171712 13:55:40 INFO - PROCESS | 20544 | 13:55:43 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52062/tests/kraken/driver.html?testName=imaging-darkroom) 13:55:44 INFO - PROCESS | 20544 | RSS: Main: 157089792 13:55:44 INFO - PROCESS | 20544 | 13:55:47 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52062/tests/kraken/driver.html?testName=imaging-desaturate) 13:55:48 INFO - PROCESS | 20544 | RSS: Main: 157462528 13:55:48 INFO - PROCESS | 20544 | 13:55:51 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52062/tests/kraken/driver.html?testName=json-parse-financial) 13:55:51 INFO - PROCESS | 20544 | RSS: Main: 157736960 13:55:51 INFO - PROCESS | 20544 | 13:55:53 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:55:54 INFO - PROCESS | 20544 | RSS: Main: 157777920 13:55:54 INFO - PROCESS | 20544 | 13:55:55 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:55:56 INFO - PROCESS | 20544 | RSS: Main: 157970432 13:55:56 INFO - PROCESS | 20544 | 13:55:58 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:55:59 INFO - PROCESS | 20544 | RSS: Main: 158076928 13:55:59 INFO - PROCESS | 20544 | 13:56:01 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:56:02 INFO - PROCESS | 20544 | RSS: Main: 158556160 13:56:02 INFO - PROCESS | 20544 | 13:56:05 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:05 INFO - PROCESS | 20544 | RSS: Main: 159006720 13:56:05 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | Cycle 1(1): loaded http://localhost:52062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52062/tests/kraken/driver.html?testName=ai-astar) 13:56:07 INFO - PROCESS | 20544 | RSS: Main: 159776768 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | __start_tp_report 13:56:07 INFO - PROCESS | 20544 | _x_x_mozilla_page_load 13:56:07 INFO - PROCESS | 20544 | _x_x_mozilla_page_load_details 13:56:07 INFO - PROCESS | 20544 | |i|pagename|runs| 13:56:07 INFO - PROCESS | 20544 | |0;ai-astar;111;105;111;110;111;123;112;111;110;109 13:56:07 INFO - PROCESS | 20544 | |1;audio-beat-detection;152;125;153;174;136;167;157;130;187;131 13:56:07 INFO - PROCESS | 20544 | |2;audio-dft;164;163;161;162;163;163;162;162;165;162 13:56:07 INFO - PROCESS | 20544 | |3;audio-fft;75;75;74;187;75;73;76;76;187;77 13:56:07 INFO - PROCESS | 20544 | |4;audio-oscillator;92;92;149;96;95;93;146;93;92;146 13:56:07 INFO - PROCESS | 20544 | |5;imaging-gaussian-blur;118;117;118;118;118;117;117;117;118;120 13:56:07 INFO - PROCESS | 20544 | |6;imaging-darkroom;147;147;147;146;146;146;147;147;146;146 13:56:07 INFO - PROCESS | 20544 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;94 13:56:07 INFO - PROCESS | 20544 | |8;json-parse-financial;61;68;65;68;65;65;68;79;63;62 13:56:07 INFO - PROCESS | 20544 | |9;json-stringify-tinderbox;57;58;58;58;58;57;58;57;58;58 13:56:07 INFO - PROCESS | 20544 | |10;stanford-crypto-aes;82;73;71;72;73;80;73;74;74;75 13:56:07 INFO - PROCESS | 20544 | |11;stanford-crypto-ccm;119;121;119;130;117;130;119;138;166;122 13:56:07 INFO - PROCESS | 20544 | |12;stanford-crypto-pbkdf2;162;156;160;158;167;161;159;159;164;158 13:56:07 INFO - PROCESS | 20544 | |13;stanford-crypto-sha256-iterative;66;67;67;67;65;68;67;65;66;68 13:56:07 INFO - PROCESS | 20544 | __end_tp_report 13:56:07 INFO - PROCESS | 20544 | __start_cc_report 13:56:07 INFO - PROCESS | 20544 | _x_x_mozilla_cycle_collect,852 13:56:07 INFO - PROCESS | 20544 | __end_cc_report 13:56:07 INFO - PROCESS | 20544 | __startTimestamp1461617767608__endTimestamp 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | ------- Summary: start ------- 13:56:07 INFO - PROCESS | 20544 | Number of tests: 14 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.55 (4.1%) stddev-sans-first:4.82 13:56:07 INFO - PROCESS | 20544 | Values: 111.0 105.0 111.0 110.0 111.0 123.0 112.0 111.0 110.0 109.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:20.72 (13.4%) stddev-sans-first:21.97 13:56:07 INFO - PROCESS | 20544 | Values: 152.0 125.0 153.0 174.0 136.0 167.0 157.0 130.0 187.0 131.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 13:56:07 INFO - PROCESS | 20544 | Values: 164.0 163.0 161.0 162.0 163.0 163.0 162.0 162.0 165.0 162.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#3] audio-fft Cycles:10 Average:97.50 Median:75.00 stddev:47.18 (62.9%) stddev-sans-first:49.34 13:56:07 INFO - PROCESS | 20544 | Values: 75.0 75.0 74.0 187.0 75.0 73.0 76.0 76.0 187.0 77.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.50 stddev:25.99 (28.1%) stddev-sans-first:26.80 13:56:07 INFO - PROCESS | 20544 | Values: 92.0 92.0 149.0 96.0 95.0 93.0 146.0 93.0 92.0 146.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 13:56:07 INFO - PROCESS | 20544 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 120.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:56:07 INFO - PROCESS | 20544 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:56:07 INFO - PROCESS | 20544 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:5.08 (7.6%) stddev-sans-first:5.00 13:56:07 INFO - PROCESS | 20544 | Values: 61.0 68.0 65.0 68.0 65.0 65.0 68.0 79.0 63.0 62.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:56:07 INFO - PROCESS | 20544 | Values: 57.0 58.0 58.0 58.0 58.0 57.0 58.0 57.0 58.0 58.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:3.53 (4.8%) stddev-sans-first:2.57 13:56:07 INFO - PROCESS | 20544 | Values: 82.0 73.0 71.0 72.0 73.0 80.0 73.0 74.0 74.0 75.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:14.91 (11.8%) stddev-sans-first:15.45 13:56:07 INFO - PROCESS | 20544 | Values: 119.0 121.0 119.0 130.0 117.0 130.0 119.0 138.0 166.0 122.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:3.24 (2.0%) stddev-sans-first:3.38 13:56:07 INFO - PROCESS | 20544 | Values: 162.0 156.0 160.0 158.0 167.0 161.0 159.0 159.0 164.0 158.0 13:56:07 INFO - PROCESS | 20544 | 13:56:07 INFO - PROCESS | 20544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 13:56:07 INFO - PROCESS | 20544 | Values: 66.0 67.0 67.0 67.0 65.0 68.0 67.0 65.0 66.0 68.0 13:56:07 INFO - PROCESS | 20544 | -------- Summary: end -------- 13:56:07 INFO - PROCESS | 20544 | 13:56:08 INFO - TEST-INFO | 20544: exit 0 13:56:08 INFO - TEST-OK | kraken | took 61431ms 13:56:08 INFO - SUITE-END | took 1170s 13:56:08 INFO - Completed test suite (00:19:30) 13:56:08 INFO - javascript benchmark 13:56:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3377.2063565062213, 3421.777584457011, 3425.0581090200194, 3429.725621950244, 3450.8964731058077, 5754.856128596787, 5761.625494342875, 5776.537876969837, 5783.5373170146395, 5793.82618521444, 5734.369219385864, 5791.0, 5800.332961709405, 5804.303483581976, 5804.883902321962, 5154.458781827911, 5217.060929032773, 5236.8690782730355, 5285.656432331886, 5335.119705248649, 5153.330067091273, 5276.1030624793875, 5370.946290537103, 5371.086915224421, 5380.0, 5198.09033419152, 5242.501962313574, 5268.736563171845, 5282.841514754564, 5352.063388906945, 5228.5555727763185, 5263.1578947368425, 5266.631335806457, 5274.024305503475, 5284.5772338212855, 5020.523050310215, 5100.132977393852, 5159.871003224912, 5203.531682148587, 5207.140821764404, 5562.749676264578, 5562.833115006556, 5611.8877622447735, 5645.15322701594, 5661.943380566224, 6053.667048312341, 6098.756049758004, 6104.298005729309, 6115.571909966304, 6118.388161183891, 6031.849203769897, 6038.1848450459065, 6163.630182189038, 6168.228971378578, 6175.197224360849, 5729.4843464088435, 5762.88474230513, 5764.884702305931, 5769.538436925036, 5811.941880581182, 6271.059341098871, 6284.622922624657, 6297.118403423525, 6301.212348456443, 6323.1779868617705, 5821.2141360916585, 5943.762249509971, 5979.970100149471, 6012.038073908154, 6073.423024812724, 6062.151298818169, 6064.696765161724, 6066.575339726177, 6080.361562036011, 6131.080337949344, 5974.163617093611, 6011.458968692838, 6017.608855424383, 6036.6679832609625, 6051.969740151271, 5887.175795388649, 6062.757489700362, 6081.817545473643, 6121.117656725397, 6130.540209484307, 4579.7252164870215, 4588.403507544064, 4591.242444996538, 4602.907941841211, 4606.493285738566, 4097.405876147942, 4110.34234522475, 4127.2570937231585, 4137.0, 4145.0, 5736.856578585485, 5806.071028635482, 5888.558358123158, 5912.733926973297, 5916.615419997686, 6096.207493025879, 6108.511319094462, 6111.480524155497, 6119.694015299217, 6124.755009799647, 5718.285214348207, 5790.131480277992, 5792.362840087587, 5813.360530341659, 5821.0, 5154.5103215194495, 5267.631265811357, 5275.366955965232, 5284.656497327738, 5286.048511268009, 6277.340879207617, 6423.903641445382, 6462.095306657072, 6467.547271691031, 6470.64411457365, 6049.51603871698, 6078.118672792332, 6082.2701275847185, 6090.33006369299, 6102.023676211785, 6239.0, 6287.339829317856, 6294.622322660655, 6324.430801227912, 6330.3669633036325, 6088.726007329592, 6093.695315234132, 6097.634141951497, 6101.115338275837, 6128.387161283836, 6140.377058150382, 6190.845228869134, 6200.131981522501, 6207.441330280297, 6217.875642487215, 5839.970800146142, 5973.074173503114, 6024.865155880918, 6031.125486804476, 6053.606515576474, 6050.2437195350585, 6051.848703782441, 6052.485538729257, 6065.939340606714, 6066.15073889647, 5898.6350100925865, 5899.705014749331, 5944.762209511571, 5960.5231581474245, 5980.34216236205, 5854.970725146347, 6028.5177185825905, 6117.449429551361, 6121.696863452088, 6150.477209437069, 5897.997340452048, 5905.4685078343155, 5907.350191478848, 5932.050871860654, 5952.613080149777], "value": 5653.921821456889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.6975067092459, 663.847315117523, 675.9729610815567, 683.9042534045232, 684.1174884399126, 36656.450153247686, 38272.80863595682, 38416.80791596045, 38490.61509384913, 38657.0, 39701.0, 40462.7976860116, 40500.79749601248, 40760.18479630406, 40762.18475630486, 8811.471311721301, 9036.728898133066, 9067.138621830916, 9074.410163339395, 9105.817883642323, 8889.066648001964, 8918.063603321654, 8950.194482496574, 9013.23387512059, 9016.504092274923, 9022.639094436214, 9048.592813323416, 9066.954665226665, 9076.909230907673, 9080.591373388213, 8910.0, 8924.152205540464, 8949.910500895037, 8951.0, 9035.367524273304, 8905.465672059698, 8932.151445612657, 8970.192682658528, 8976.41653292534, 9020.0, 32905.0, 40102.39846402306, 40491.59508404908, 40805.59194408077, 40835.38746918798, 3487.5640544931885, 3564.429691249388, 3567.8751243706347, 3981.5620281768984, 4252.808623611945, 29752.0, 30285.091447256396, 30579.23551911198, 30615.234619134477, 31125.066248012597, 4474.865754027384, 4505.36924830524, 4577.359169716243, 4587.472440669332, 4658.394408726877, 220799.0, 221410.0, 222480.99999999837, 222962.0, 225113.0, 54697.72651136719, 55623.0, 55904.0, 55993.7200314004, 56185.0, 58598.121028184614, 59240.0, 59260.70369648124, 59551.70224148938, 59613.701931490934, 15739.055656660637, 16067.919660401623, 16136.838631613768, 16173.27220275067, 16233.837661623233, 11444.713882153013, 11513.827292590619, 11619.186656934102, 11628.418579071013, 11648.88351116478, 19881.0, 20218.797812021985, 20280.695789563168, 20291.28980485676, 20717.58564828695, 7588.544687318668, 7764.922350776533, 7820.653803858933, 7844.607769611496, 7905.723299684599, 1083.0523292119397, 1084.9132069434427, 1097.6816723150357, 1175.6456353409833, 1194.2595590733802, 31473.685263147534, 31865.36269274648, 31913.52129718056, 32277.677223227467, 32470.512942305886, 1142.5943789954447, 1208.86098098718, 1229.5327775445453, 1269.3335998600808, 1322.0943653597317, 16670.499885003228, 17287.56781080458, 17311.3941012064, 17366.3053477862, 17426.564335891704, 334278.0, 336032.0, 337767.0, 405608.0, 521198.0, 56605.71697141488, 57263.0, 57330.426695733346, 57676.0, 57846.710766445896, 1421.2822524625205, 1458.7637848199033, 1480.4078368652624, 1481.3259966715334, 1487.3530014443752, 33168.0, 33584.16039599029, 33617.83191084029, 34086.65913340835, 34681.13297167591, 53820.0, 54475.18287225774, 54527.18209226785, 54571.45428545664, 54875.07937222178, 464764.0, 467164.0, 467238.0, 467800.0, 468583.0, 30456.390872182874, 31213.375732485678, 31288.37423251477, 31327.37345253128, 31336.0, 45374.092518150115, 45387.0, 45475.77262113668, 45675.54324456846, 46343.30485042794, 42680.57319426766, 42738.358924616776, 43248.56751432445, 43706.0, 44151.0, 41620.791896040326, 42749.786251068545, 42809.1438171241, 43258.134837302445, 43486.782566086964, 42061.0, 42816.0, 43136.78431607822, 43203.567964319955, 43391.34912976245, 36133.27733445369, 36927.63072369242, 37217.627823721414, 37870.24259514849, 37950.62049379581, 28011.159665210078, 28035.43929121447, 28367.716322836506, 28527.572086419135, 28755.712442875305], "value": 19995.780342732993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.58345444829024, 378.56843198753427, 382.76459977114075, 382.9942550861737, 390.3715018819702, 18950.0, 20470.2835400761, 20529.38411847643, 21269.57460850782, 21451.892740536296, 15659.295331710073, 16407.261673224704, 16504.42234521792, 16549.25528351224, 16591.253393597286, 5521.171824226378, 5705.139711601753, 5713.057345537981, 5761.798337058204, 5789.884202315951, 5551.417101204356, 5658.321001479828, 5661.122526008476, 5669.376368599451, 5678.43215678433, 5539.169124631318, 5604.215409842625, 5626.0, 5632.0, 5633.267675202218, 5581.134924086773, 5609.971950140243, 5616.803411880605, 5642.379338272786, 5645.294338207704, 4881.1213981483315, 4969.055879382906, 4981.178105612606, 4984.800607975677, 5056.115179843549, 23255.88372058129, 23364.766352336428, 23582.29253122409, 23807.285781426584, 23831.523369532686, 2362.8464149830206, 2395.0, 2497.2633073243437, 2504.7306045214655, 2646.3913299940928, 14601.123932563974, 14619.342129604192, 14632.780508292384, 14997.475088371855, 15060.623484412868, 2012.8087831655969, 2100.978990210094, 2141.2826703054498, 2172.0660116150048, 2213.103693004336, 82343.0, 83513.58243208745, 85634.57182714109, 85790.71313930358, 86384.0, 9900.405975641484, 10306.12397946183, 10456.268061235793, 10695.251332406657, 10708.250422470508, 14342.641433964234, 14354.569362919128, 14468.0, 14546.4908728194, 14550.636234094021, 7621.961890190513, 8030.839383212303, 8078.959605201936, 8160.428769986044, 8193.09875913649, 7736.497127686683, 7771.222877712296, 7901.762947111596, 7960.4825686330205, 7991.0, 6552.279249282575, 6562.179727534059, 6592.373724496165, 6640.501962352843, 6773.322667733188, 1793.3812834572052, 1812.7371531127912, 1824.36147348427, 1858.0, 1876.1369769905723, 1033.3827559868932, 1091.7052395853075, 1201.9098567607289, 1204.114975493012, 1220.664317312746, 19534.804651953582, 19577.706334404997, 19654.0, 19917.502062448555, 20297.0, 1068.4444089073793, 1089.8583184186004, 1113.8050841102774, 1115.4088333183427, 1176.276589897207, 11337.716557085974, 11473.71315717097, 11587.942060289644, 11640.126990475748, 11667.941660291644, 516014.0, 518042.0, 519178.0, 537023.0, 545451.0, 60537.69731151404, 79342.0, 88676.5566172165, 89072.0, 91068.0, 1143.1255089856268, 1145.5589598004663, 1185.6146752305535, 1186.3297237061206, 1213.7633161533415, 16150.596235094217, 16728.832711672727, 16903.915480422518, 16936.153192340582, 17733.733993990358, 38326.425103624024, 38780.80609596934, 39080.80459597798, 39182.41226381664, 39334.60665393309, 55947.0, 62817.68591157015, 63545.0, 64155.0, 64291.0, 7782.066152061789, 8024.9598752008205, 8127.227913348459, 8187.771834224914, 8657.991437479068, 8508.27679647237, 12133.272003679807, 13641.0, 13894.652633684238, 13921.373538190603, 11888.702782430508, 12143.574974875837, 12208.755824883276, 12324.260544367367, 12567.120301578801, 5720.0, 10946.288491248044, 11707.590234341757, 11776.410184624967, 12131.150819442555, 12067.275963442222, 12373.62879113628, 12386.690332741753, 12444.377781110727, 12451.813222801484, 7536.698532058656, 8022.438429309892, 8178.5092894426525, 8273.048599411144, 8325.750227493185, 9817.4600396976, 11312.94343528277, 11369.602063927723, 11674.70813229676, 11717.707057323634], "value": 9385.072971486057, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1615.1520451762824, 1616.862566681832, 1808.9005104719236, 1883.9905800470995, 1910.512819231095, 7659.923400765991, 7998.9600051999805, 8227.999999999993, 8425.115362886892, 8499.0, 8373.288270497014, 8418.410711250215, 8423.873641895376, 8472.406931514797, 8488.660453581864, 2341.3912382780472, 2376.192094687806, 2377.072941552787, 2386.7971222446026, 2391.5575618510543, 2295.598270302699, 2317.7450480447137, 2357.6463530470483, 2369.1944738788807, 2376.5128148729555, 2330.9650355244685, 2355.5171189906114, 2375.8812059397046, 2384.141708984764, 2385.212879749687, 2291.140822191678, 2319.8724070176136, 2322.326525307659, 2326.8138548916218, 2363.7045369328835, 2235.452314183019, 2236.5303286309895, 2236.899339529709, 2237.630790919496, 2238.8320875934205, 8510.87233691489, 8573.0, 8624.698135565224, 8662.393632445732, 8670.219680228747, 4794.880127996793, 4920.507949205086, 4932.358793356877, 4934.358533390672, 4937.728424936627, 3281.5733954585753, 3334.733221342287, 3406.9659303406897, 3473.6873681368547, 3502.2820321833965, 1077.4538537199066, 1083.4366129612558, 1136.5510623303749, 1141.5034460009922, 1151.5278735718398, 11642.18504704671, 11684.357360345177, 11692.766144677058, 11692.824607630891, 11719.238249513754, 4523.231050721385, 4547.886302842456, 4589.632829373709, 4614.907701845944, 4632.374629425052, 9807.411555306562, 9824.0, 9858.802823943624, 9869.309148359689, 9872.457014864107, 4818.638602104786, 4888.706677599355, 4937.679050861682, 4937.679050861682, 4948.134076536592, 4017.819198136091, 4261.2542805009, 4313.374560688745, 4436.26801577736, 4445.110977804452, 3900.297946369624, 3904.1260195105942, 3966.781826999543, 4016.0763024504527, 4042.110735638155, 1225.136278923357, 1258.672745086284, 1259.3640211693037, 1260.4832018872219, 1265.5317532512845, 979.397670432693, 1018.0938964321759, 1030.835066389374, 1074.4412905289205, 1095.4686976816238, 5416.91874621881, 5587.7485513152005, 5646.962421868384, 5738.225339579103, 5837.737301821428, 426.9530351661315, 432.0775145065308, 435.2426777407289, 442.72993473980847, 445.6835646690821, 3977.54258260298, 4003.2193722223888, 4012.8996775080273, 4072.450219220427, 4266.189424009428, 10177.898221017844, 10334.121599664113, 10457.84313235302, 10485.213608979357, 10592.15262778976, 9941.45322007282, 10335.17318614509, 10413.5834566618, 10462.63380781669, 10555.947220264003, 7823.843523129505, 7913.604319783988, 7937.960310198412, 7987.800304992305, 8001.4398992071165, 5979.133025711334, 6062.696865156637, 6173.59871608362, 6201.069839524108, 6225.782097626561, 9426.858597121185, 9548.52257387114, 9563.713088607354, 9622.9037709622, 9736.172425343924, 9946.701598952042, 9970.252231082843, 10017.298789084694, 10021.198304135505, 10071.546780395047, 7510.136334321404, 7657.885131722917, 7733.651985660546, 7771.650275737492, 7798.844023119619, 7971.963644726148, 7975.361971042419, 8020.719274825587, 8036.0, 8045.155258697752, 7331.303526165006, 7352.4485663576515, 7507.361874240751, 7545.170031296443, 7580.128285247267, 7064.293570642894, 7191.640417979184, 7341.375983041501, 7385.630718463948, 7413.96293018553, 6405.295417503978, 6420.711068002044, 6424.775132870327, 6451.258105317761, 6451.516136289891, 4985.376827896513, 5047.167217409086, 5053.898922021465, 5118.616103792305, 5163.922541161961, 5119.948800511947, 5230.63385563007, 5269.209618557247, 5289.100852854947, 5393.83818485446], "value": 4451.899822092116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8744727214571, 301.96829332920043, 306.62438512821797, 309.2223059006599, 315.86102115069383, 5574.498295153436, 5653.632513886605, 5670.744816483258, 5818.458108601224, 5842.912356314659, 5702.344230413503, 5719.857003574913, 5723.799667011655, 5743.913841292384, 5770.422957704228, 4335.891602709926, 4339.41417908583, 4365.388845561624, 4373.453318335208, 4385.51759306476, 4129.7315674481215, 4345.78271086446, 4363.716358436707, 4379.321205213197, 4399.208142534342, 4253.383259427381, 4275.657947364203, 4293.441852559163, 4301.505326887417, 4313.525512193656, 4280.272353699863, 4292.61366477017, 4295.699301048928, 4309.095090031113, 4315.956840431587, 3578.1233597768455, 3713.498677678506, 3721.3115573618966, 3723.8696645617274, 3734.1784807342615, 5520.254765606672, 5552.361478429992, 5558.277423934903, 5558.499735023867, 5560.666360018371, 4939.580135688435, 4955.0, 4956.677815941952, 4960.0, 4981.302617633498, 5721.227634269362, 5949.940500594982, 5999.520038396918, 6046.395360463963, 6047.879042419171, 4050.2709512287774, 4079.3473044313064, 4099.3031184698375, 4110.46563946685, 4115.670746340315, 6223.284322302902, 6236.158118653969, 6274.1843560336865, 6287.842803929892, 6295.748170073146, 4079.204555111784, 4149.8340066397, 4153.736213763506, 4168.24971505132, 4193.720915120856, 4152.1072969311745, 4165.4584903962295, 4186.623203911662, 4187.685923555746, 4190.769507677046, 4896.4124305082905, 4912.04215178044, 4915.459299477055, 4916.70499770015, 4921.7785199666105, 5915.733791979371, 6039.275286965504, 6050.485708714808, 6057.212562366864, 6084.939150608526, 1515.7574788033862, 1528.48031669233, 1533.2180587900252, 1535.5009621872937, 1539.8306186319496, 972.8666103988774, 989.4805227255605, 992.8659630949874, 993.4337427666161, 1002.9047240512285, 6205.844853878599, 6238.126662267196, 6258.843528911722, 6272.341404152589, 6296.811095667137, 6564.606123632502, 6610.8016759497295, 6627.4366678831875, 6641.169853768279, 6684.465242780566, 6079.392060793885, 6256.749730010749, 6280.7487700491465, 6294.464970477561, 6301.7164227609865, 3536.310419468179, 3546.095745584911, 3559.483874838134, 3573.3032058748813, 3575.6245594212755, 6703.932960670429, 6875.58746475203, 6880.208775990725, 6914.481413893978, 6957.234704182536, 6728.064082511785, 6751.966240168767, 6776.746301934059, 6814.318568143146, 6815.556988795812, 6123.264808466832, 6566.868662626721, 6599.835004124935, 6860.725570977105, 6898.310168983062, 6220.906686399617, 6287.96856015717, 6288.968555157195, 6296.496280297473, 6306.7610998095015, 6032.6983650818165, 6223.159873417031, 6232.283287422005, 6244.438000579969, 6313.936860631335, 6383.425491705769, 6476.805695829133, 6485.77299794505, 6518.869622607616, 6524.510661700297, 4136.855210067633, 4220.430241917425, 4232.95767042338, 4236.745795252295, 4252.829886804493, 6218.31598524171, 6271.874562508816, 6294.464970477377, 6324.209473815773, 6362.713677884413, 5914.881702366015, 6093.268807743099, 6098.963176260135, 6142.723577439116, 6153.630782153085, 6122.816315510542, 6128.785492507741, 6151.739578023655, 6157.538184636081, 6193.792210518905, 5658.85852853682, 5957.970210148921, 6016.398360163948, 6027.21646185993, 6027.246594175728, 6107.633541987318, 6153.0, 6163.38366163398, 6165.198524191826, 6172.512530420298, 5939.821805345847, 5980.8803823924145, 5989.221401217814, 6039.862694054586, 6055.333913269625], "value": 4587.693021676531, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.4907989239207, 879.604178119846, 910.1990248581252, 928.0765638190002, 937.4890684576905, 12729.490820367175, 12742.29917354545, 12775.361231938412, 13553.390097445614, 14633.122012679247, 14101.647458813535, 14195.432182712704, 14243.857561424382, 14284.357203925849, 14291.71416571668, 877.6708734224666, 896.0591379052001, 923.9769005774842, 924.7826760711228, 926.7219834049791, 913.634546181526, 913.9497327646977, 919.8482250428672, 922.5018490015384, 922.7923717163618, 964.81668482988, 966.8211380894522, 966.9854952175723, 967.89837067108, 968.056145258371, 951.8714973478561, 953.9761505962337, 954.0507195340612, 954.2795189631818, 955.4171955107379, 704.7040243097911, 707.024306457091, 707.7912015955254, 708.7625645408795, 709.7835160276114, 15507.379704811794, 15546.76679849803, 15589.532314030597, 15592.376304947902, 15599.298031588605, 12834.614961551168, 13490.460381584822, 13550.59348219545, 13581.320933953262, 13590.932045339809, 11396.145289103268, 11396.772064558745, 11432.48553815072, 11443.485043173077, 11533.308001519936, 3921.843126274974, 3945.3292940200236, 3965.484487016698, 3970.463987361698, 3983.4821473208585, 54620.72689636566, 55842.441575583725, 56105.71947140279, 56375.71812140954, 56633.43366566364, 11320.886791131983, 11347.148963827745, 11466.197366184453, 11577.363245021605, 11722.76554468923, 19269.518262043282, 19648.70526942097, 19664.901675491816, 19851.0, 19894.90052549728, 8351.874721879176, 8365.749027529184, 8441.11368306319, 8544.2310192083, 8548.0, 4968.577670897942, 5041.218611115283, 5046.4953504649975, 5077.263796749525, 5081.618878584047, 3490.441529355291, 3563.6436356364156, 3699.500567423417, 3863.9806800966376, 3887.611238876146, 687.3435868745336, 698.4238003647012, 709.4218212157075, 709.9609521476265, 716.4089626058523, 681.7545683553917, 755.7430473638989, 769.4214466313113, 786.3591173193829, 800.9399295052895, 9528.95235523818, 9856.655017074369, 9980.45107519079, 10008.949955250177, 10058.195344372432, 693.6531734132933, 719.8056524738291, 720.1538192623647, 736.373361196107, 769.5767327969594, 4688.718676879398, 4756.239001759702, 4786.545278198566, 4820.9517904821205, 4854.732989685531, 74955.25044749591, 76048.0, 76393.0, 77383.0, 77566.0, 61579.0, 63210.41973950596, 64040.35959640437, 64500.67749661222, 66098.66950665216, 57967.710161449766, 58851.0, 58886.41113588895, 58912.0, 60200.0, 8689.17452841979, 8798.648054078021, 8885.4668719877, 8977.910220897707, 9029.41308814925, 36748.81625591855, 37059.6294037067, 37186.62813371832, 37421.251574967806, 37938.8103059483, 43939.56060439483, 46454.30318545292, 49202.507974921224, 49833.0, 49985.75007124941, 11670.183087183816, 11728.88271117312, 11762.470688818852, 11963.222390544935, 12022.819657705317, 13745.175289482662, 13930.651733706738, 13933.0, 14000.509982150576, 14457.204853733145, 12214.511419543118, 12319.568815091787, 12438.440270188044, 12595.370231488572, 12811.679708007374, 12630.494780208688, 12774.872251277367, 12879.098463107492, 13037.674058148623, 13102.148360356547, 12911.0, 12992.740145197233, 13202.933985330012, 13264.668383290495, 13871.23708196059, 10826.783464330827, 11018.84763583115, 11214.719632009264, 11315.603953861575, 11335.773284534429, 11045.83431248548, 11164.776704466027, 11204.887951120385, 11236.55053797839, 11478.139139564733], "value": 7177.395256971654, "unit": "score"}], "name": "dromaeo_css", "value": 7333.519217784229, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 110.0, 111.0, 123.0, 112.0, 111.0, 110.0, 109.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 153.0, 174.0, 136.0, 167.0, 157.0, 130.0, 187.0, 131.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 162.0, 163.0, 163.0, 162.0, 162.0, 165.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 187.0, 75.0, 73.0, 76.0, 76.0, 187.0, 77.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 96.0, 95.0, 93.0, 146.0, 93.0, 92.0, 146.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 120.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 68.0, 65.0, 68.0, 65.0, 65.0, 68.0, 79.0, 63.0, 62.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 71.0, 72.0, 73.0, 80.0, 73.0, 74.0, 74.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 119.0, 130.0, 117.0, 130.0, 119.0, 138.0, 166.0, 122.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 156.0, 160.0, 158.0, 167.0, 161.0, 159.0, 159.0, 164.0, 158.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 65.0, 68.0, 67.0, 65.0, 66.0, 68.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1545.4, "alertThreshold": 2.0}]} 13:56:08 INFO - Return code: 0 13:56:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:56:08 ERROR - # TBPL SUCCESS # 13:56:08 INFO - Running post-action listener: _resource_record_post_action 13:56:08 INFO - Running post-run listener: _resource_record_post_run 13:56:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 510578688; Read time: 0; Write time: 594780 13:56:09 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 258764800; Read time: 0; Write time: 365576 13:56:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 247762944; Read time: 0; Write time: 228636 13:56:09 INFO - Running post-run listener: _upload_blobber_files 13:56:09 INFO - Blob upload gear active. 13:56:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:56:09 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 13:56:09 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'] 13:56:09 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 13:56:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:11 INFO - (blobuploader) - INFO - Done attempting. 13:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:11 INFO - (blobuploader) - INFO - Done attempting. 13:56:11 INFO - (blobuploader) - INFO - Iteration through files over. 13:56:11 INFO - Return code: 0 13:56:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:56:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:56:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edac1f72f78bdf66fac5a4febe86a608cbd8a3568aecbe79e124bcc716437855511941ecd8bac8ee69dcc02be1930ba70c21cc3b1d484b4b7f2daca90c32b836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/833c1173c3da32577cce5da0f69c964f15dfe8ecc44392b67825fb4b0ef9283ead65f69838d29e92d4ee0d6fdb62036c69119c25d279103f8cef0d004309026f"} 13:56:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:56:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:56:11 INFO - Contents: 13:56:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/edac1f72f78bdf66fac5a4febe86a608cbd8a3568aecbe79e124bcc716437855511941ecd8bac8ee69dcc02be1930ba70c21cc3b1d484b4b7f2daca90c32b836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/833c1173c3da32577cce5da0f69c964f15dfe8ecc44392b67825fb4b0ef9283ead65f69838d29e92d4ee0d6fdb62036c69119c25d279103f8cef0d004309026f"} 13:56:11 INFO - Running post-run listener: copy_logs_to_upload_dir 13:56:11 INFO - Copying logs to upload dir... 13:56:11 INFO - mkdir: /builds/slave/test/build/upload/logs 13:56:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.512075 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-25 13:56:11.763749) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:56:11.767096) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 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/edac1f72f78bdf66fac5a4febe86a608cbd8a3568aecbe79e124bcc716437855511941ecd8bac8ee69dcc02be1930ba70c21cc3b1d484b4b7f2daca90c32b836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/833c1173c3da32577cce5da0f69c964f15dfe8ecc44392b67825fb4b0ef9283ead65f69838d29e92d4ee0d6fdb62036c69119c25d279103f8cef0d004309026f"} build_url:https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/a46NiOjYQzSSlKI18glfOw/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/edac1f72f78bdf66fac5a4febe86a608cbd8a3568aecbe79e124bcc716437855511941ecd8bac8ee69dcc02be1930ba70c21cc3b1d484b4b7f2daca90c32b836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/833c1173c3da32577cce5da0f69c964f15dfe8ecc44392b67825fb4b0ef9283ead65f69838d29e92d4ee0d6fdb62036c69119c25d279103f8cef0d004309026f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 13:56:11.791546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:56:11.791874) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1461616544.205147-1352385479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 13:56:11.875655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:56:11.875990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 13:56:11.876315) ========= ========= Total master_lag: 0.17 =========