builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1462876496.48 results: success (0) buildid: 20160510004007 builduid: 2f6663a6289544ba920cf23088795f59 revision: 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.478375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.478899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.479216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.497141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.497697) ========= 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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 03:34:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-05-10 03:34:57 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.607632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.607991) ========= 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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.657596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:56.658001) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d --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 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d --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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 03:34:57,962 truncating revision to first 12 chars 2016-05-10 03:34:57,962 Setting DEBUG logging. 2016-05-10 03:34:57,962 attempt 1/10 2016-05-10 03:34:57,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/63b7cc21ae7c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 03:34:58,232 unpacking tar archive at: mozilla-aurora-63b7cc21ae7c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:57.217929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:57.218301) ========= script_repo_revision: 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:57.218811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:57.219138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:34:57.228738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-10 03:34:57.229100) ========= /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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:58 INFO - MultiFileLogger online at 20160510 03:34:58 in /builds/slave/test 03:34:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:34:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:58 INFO - {'append_to_log': False, 03:34:58 INFO - 'base_work_dir': '/builds/slave/test', 03:34:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:34:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:58 INFO - 'branch': 'Mozilla-Aurora', 03:34:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:58 INFO - 'config_files': ('talos/linux_config.py',), 03:34:58 INFO - 'default_actions': ('clobber', 03:34:58 INFO - 'read-buildbot-config', 03:34:58 INFO - 'download-and-extract', 03:34:58 INFO - 'populate-webroot', 03:34:58 INFO - 'create-virtualenv', 03:34:58 INFO - 'install', 03:34:58 INFO - 'run-tests'), 03:34:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:58 INFO - 'download_minidump_stackwalk': True, 03:34:58 INFO - 'download_symbols': 'ondemand', 03:34:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:58 INFO - 'installer_path': 'installer.exe', 03:34:58 INFO - 'log_level': 'info', 03:34:58 INFO - 'log_name': 'talos', 03:34:58 INFO - 'log_to_console': True, 03:34:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:58 INFO - 'opt_config_files': (), 03:34:58 INFO - 'pip_index': False, 03:34:58 INFO - 'sps_profile': False, 03:34:58 INFO - 'sps_profile_interval': 0, 03:34:58 INFO - 'suite': 'dromaeojs-e10s', 03:34:58 INFO - 'system_bits': '32', 03:34:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:58 INFO - 'title': 'talos-linux64-ix-035', 03:34:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:58 INFO - 'use_talos_json': True, 03:34:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:58 INFO - 'work_dir': 'build'} 03:34:58 INFO - ##### 03:34:58 INFO - ##### Running clobber step. 03:34:58 INFO - ##### 03:34:58 INFO - Running pre-action listener: _resource_record_pre_action 03:34:58 INFO - Running main action method: clobber 03:34:58 INFO - rmtree: /builds/slave/test/build 03:34:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:59 INFO - Running post-action listener: _resource_record_post_action 03:34:59 INFO - ##### 03:34:59 INFO - ##### Running read-buildbot-config step. 03:34:59 INFO - ##### 03:34:59 INFO - Running pre-action listener: _resource_record_pre_action 03:34:59 INFO - Running main action method: read_buildbot_config 03:34:59 INFO - Using buildbot properties: 03:34:59 INFO - { 03:34:59 INFO - "project": "", 03:34:59 INFO - "product": "firefox", 03:34:59 INFO - "script_repo_revision": "production", 03:34:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:34:59 INFO - "repository": "", 03:34:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:34:59 INFO - "buildid": "20160510004007", 03:34:59 INFO - "stage_platform": "linux64-pgo", 03:34:59 INFO - "basedir": "/builds/slave/test", 03:34:59 INFO - "nightly_build": "True", 03:34:59 INFO - "buildnumber": 256, 03:34:59 INFO - "slavename": "talos-linux64-ix-035", 03:34:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:34:59 INFO - "platform": "ubuntu64_hw", 03:34:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:34:59 INFO - "branch": "mozilla-aurora", 03:34:59 INFO - "repo_path": "releases/mozilla-aurora", 03:34:59 INFO - "revision": "63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d", 03:34:59 INFO - "pgo_build": "True", 03:34:59 INFO - "builduid": "2f6663a6289544ba920cf23088795f59", 03:34:59 INFO - "slavebuilddir": "test" 03:34:59 INFO - } 03:34:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:34:59 INFO - Running post-action listener: _resource_record_post_action 03:34:59 INFO - ##### 03:34:59 INFO - ##### Running download-and-extract step. 03:34:59 INFO - ##### 03:34:59 INFO - Running pre-action listener: _resource_record_pre_action 03:34:59 INFO - Running main action method: download_and_extract 03:34:59 INFO - mkdir: /builds/slave/test/build/tests 03:34: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')]} 03:34:59 INFO - https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:34:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:34:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:34:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:34:59 INFO - Downloaded 1361 bytes. 03:34:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:34:59 INFO - Using the following test package requirements: 03:34:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'jsshell-linux-x86_64.zip'], 03:34:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34: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')]} 03:34:59 INFO - https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:34:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:34:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:00 INFO - Downloaded 23800613 bytes. 03:35:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:02 INFO - Return code: 0 03:35:02 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:02 INFO - https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:03 INFO - Downloaded 23800613 bytes. 03:35:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:04 INFO - Return code: 0 03:35: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')]} 03:35:04 INFO - https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:35:06 INFO - Downloaded 10840145 bytes. 03:35:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:35:06 INFO - Return code: 0 03:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:06 INFO - https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:35:07 INFO - Downloaded 62688320 bytes. 03:35:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:07 INFO - mkdir: /builds/slave/test/properties 03:35:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:07 INFO - Contents: 03:35:07 INFO - build_url:https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:35:08 INFO - Running post-action listener: _resource_record_post_action 03:35:08 INFO - Running post-action listener: set_extra_try_arguments 03:35:08 INFO - ##### 03:35:08 INFO - ##### Running populate-webroot step. 03:35:08 INFO - ##### 03:35:08 INFO - Running pre-action listener: _resource_record_pre_action 03:35:08 INFO - Running main action method: populate_webroot 03:35:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:08 INFO - '--tppagecycles', 03:35:08 INFO - '7'], 03:35:08 INFO - 'tests': ['tsvgm']}}, 03:35:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['damp', 'tps']}, 03:35:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'tests': ['damp', 'tps']}, 03:35:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['dromaeo_dom']}, 03:35:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['a11yr', 03:35:08 INFO - 'ts_paint', 03:35:08 INFO - 'tpaint', 03:35:08 INFO - 'sessionrestore', 03:35:08 INFO - 'sessionrestore_no_auto_restore', 03:35:08 INFO - 'tabpaint']}, 03:35:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['tsvgx', 03:35:08 INFO - 'tsvgr_opacity', 03:35:08 INFO - 'tart', 03:35:08 INFO - 'tscrollx', 03:35:08 INFO - 'cart']}, 03:35:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:08 INFO - 'tsvgr_opacity', 03:35:08 INFO - 'tart', 03:35:08 INFO - 'tscrollx', 03:35:08 INFO - 'cart']}, 03:35:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'talos_options': ['--disable-e10s'], 03:35:08 INFO - 'tests': ['tp5o']}, 03:35:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'tests': ['tp5o']}, 03:35:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'talos_options': ['--disable-e10s', 03:35:08 INFO - '--xperf_path', 03:35:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:08 INFO - 'tests': ['tp5n']}, 03:35:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:08 INFO - 'talos_options': ['--xperf_path', 03:35:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:08 INFO - 'tests': ['tp5n']}}, 03:35:08 INFO - 'talos.zip': {'path': '', 03:35:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:08 INFO - Running post-action listener: _resource_record_post_action 03:35:08 INFO - ##### 03:35:08 INFO - ##### Running create-virtualenv step. 03:35:08 INFO - ##### 03:35:08 INFO - Running pre-action listener: _resource_record_pre_action 03:35:08 INFO - Running main action method: create_virtualenv 03:35:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:35:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:08 INFO - Using real prefix '/usr' 03:35:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:11 INFO - Installing pip.................done. 03:35:11 INFO - Return code: 0 03:35:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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')]} 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:11 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:35:11 INFO - Using env: {'DISPLAY': ':0', 03:35:11 INFO - 'HOME': '/home/cltbld', 03:35:11 INFO - 'LANG': 'en_US.UTF-8', 03:35:11 INFO - 'LANGUAGE': 'en_US:en', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MAIL': '/var/mail/cltbld', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SHLVL': '1', 03:35:11 INFO - 'TERM': 'linux', 03:35:11 INFO - 'TMOUT': '86400', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - '_': '/tools/buildbot/bin/python'} 03:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:35:11 INFO - Cleaning up... 03:35:11 INFO - Return code: 0 03:35:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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')]} 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:11 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:35:11 INFO - Using env: {'DISPLAY': ':0', 03:35:11 INFO - 'HOME': '/home/cltbld', 03:35:11 INFO - 'LANG': 'en_US.UTF-8', 03:35:11 INFO - 'LANGUAGE': 'en_US:en', 03:35:11 INFO - 'LOGNAME': 'cltbld', 03:35:11 INFO - 'MAIL': '/var/mail/cltbld', 03:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:11 INFO - 'MOZ_NO_REMOTE': '1', 03:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:11 INFO - 'NO_EM_RESTART': '1', 03:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:11 INFO - 'PWD': '/builds/slave/test', 03:35:11 INFO - 'SHELL': '/bin/bash', 03:35:11 INFO - 'SHLVL': '1', 03:35:11 INFO - 'TERM': 'linux', 03:35:11 INFO - 'TMOUT': '86400', 03:35:11 INFO - 'USER': 'cltbld', 03:35:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:11 INFO - '_': '/tools/buildbot/bin/python'} 03:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:11 INFO - Downloading/unpacking psutil>=0.7.1 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:13 INFO - Installing collected packages: psutil 03:35:13 INFO - Running setup.py install for psutil 03:35:13 INFO - building 'psutil._psutil_linux' extension 03:35:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:35:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:35:14 INFO - building 'psutil._psutil_posix' extension 03:35:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:35:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:35:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:14 INFO - Successfully installed psutil 03:35:14 INFO - Cleaning up... 03:35:14 INFO - Return code: 0 03:35:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:35: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')]} 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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')]} 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:14 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:35:14 INFO - Using env: {'DISPLAY': ':0', 03:35:14 INFO - 'HOME': '/home/cltbld', 03:35:14 INFO - 'LANG': 'en_US.UTF-8', 03:35:14 INFO - 'LANGUAGE': 'en_US:en', 03:35:14 INFO - 'LOGNAME': 'cltbld', 03:35:14 INFO - 'MAIL': '/var/mail/cltbld', 03:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:14 INFO - 'MOZ_NO_REMOTE': '1', 03:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:14 INFO - 'NO_EM_RESTART': '1', 03:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:14 INFO - 'PWD': '/builds/slave/test', 03:35:14 INFO - 'SHELL': '/bin/bash', 03:35:14 INFO - 'SHLVL': '1', 03:35:14 INFO - 'TERM': 'linux', 03:35:14 INFO - 'TMOUT': '86400', 03:35:14 INFO - 'USER': 'cltbld', 03:35:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:14 INFO - '_': '/tools/buildbot/bin/python'} 03:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:35:16 INFO - Installing collected packages: mozsystemmonitor 03:35:16 INFO - Running setup.py install for mozsystemmonitor 03:35:16 INFO - Successfully installed mozsystemmonitor 03:35:16 INFO - Cleaning up... 03:35:16 INFO - Return code: 0 03:35:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:16 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:16 INFO - Using env: {'DISPLAY': ':0', 03:35:16 INFO - 'HOME': '/home/cltbld', 03:35:16 INFO - 'LANG': 'en_US.UTF-8', 03:35:16 INFO - 'LANGUAGE': 'en_US:en', 03:35:16 INFO - 'LOGNAME': 'cltbld', 03:35:16 INFO - 'MAIL': '/var/mail/cltbld', 03:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:16 INFO - 'MOZ_NO_REMOTE': '1', 03:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:16 INFO - 'NO_EM_RESTART': '1', 03:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:16 INFO - 'PWD': '/builds/slave/test', 03:35:16 INFO - 'SHELL': '/bin/bash', 03:35:16 INFO - 'SHLVL': '1', 03:35:16 INFO - 'TERM': 'linux', 03:35:16 INFO - 'TMOUT': '86400', 03:35:16 INFO - 'USER': 'cltbld', 03:35:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:16 INFO - '_': '/tools/buildbot/bin/python'} 03:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:19 INFO - Downloading docopt-0.6.1.tar.gz 03:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:19 INFO - Running setup.py install for blobuploader 03:35:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:19 INFO - Running setup.py install for requests 03:35:20 INFO - Running setup.py install for docopt 03:35:20 INFO - Successfully installed blobuploader requests docopt 03:35:20 INFO - Cleaning up... 03:35:20 INFO - Return code: 0 03:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:20 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:20 INFO - Using env: {'DISPLAY': ':0', 03:35:20 INFO - 'HOME': '/home/cltbld', 03:35:20 INFO - 'LANG': 'en_US.UTF-8', 03:35:20 INFO - 'LANGUAGE': 'en_US:en', 03:35:20 INFO - 'LOGNAME': 'cltbld', 03:35:20 INFO - 'MAIL': '/var/mail/cltbld', 03:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:20 INFO - 'MOZ_NO_REMOTE': '1', 03:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:20 INFO - 'NO_EM_RESTART': '1', 03:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:20 INFO - 'PWD': '/builds/slave/test', 03:35:20 INFO - 'SHELL': '/bin/bash', 03:35:20 INFO - 'SHLVL': '1', 03:35:20 INFO - 'TERM': 'linux', 03:35:20 INFO - 'TMOUT': '86400', 03:35:20 INFO - 'USER': 'cltbld', 03:35:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:20 INFO - '_': '/tools/buildbot/bin/python'} 03:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:20 INFO - Running setup.py (path:/tmp/pip-PanGOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:20 INFO - Running setup.py (path:/tmp/pip-aIH5mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:20 INFO - Running setup.py (path:/tmp/pip-JySvWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:20 INFO - Running setup.py (path:/tmp/pip-nSPttL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:20 INFO - Running setup.py (path:/tmp/pip-wrbiJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:20 INFO - Running setup.py (path:/tmp/pip-WV5Viz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:20 INFO - Running setup.py (path:/tmp/pip-ihz3Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:20 INFO - Running setup.py (path:/tmp/pip-y20Oz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:20 INFO - Running setup.py (path:/tmp/pip-O1I1ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:21 INFO - Running setup.py (path:/tmp/pip-GvpxNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:21 INFO - Running setup.py (path:/tmp/pip-u2VlXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:21 INFO - Running setup.py (path:/tmp/pip-gg4NNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:21 INFO - Running setup.py (path:/tmp/pip-t82alu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:21 INFO - Running setup.py (path:/tmp/pip-sEObL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:21 INFO - Running setup.py (path:/tmp/pip-s6RyE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:21 INFO - Running setup.py (path:/tmp/pip-xqf_6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:21 INFO - Running setup.py (path:/tmp/pip-b8qEER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:21 INFO - Running setup.py install for manifestparser 03:35:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:21 INFO - Running setup.py install for mozcrash 03:35:21 INFO - Running setup.py install for mozdebug 03:35:21 INFO - Running setup.py install for mozdevice 03:35:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozfile 03:35:22 INFO - Running setup.py install for mozhttpd 03:35:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozinfo 03:35:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozInstall 03:35:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozleak 03:35:22 INFO - Running setup.py install for mozlog 03:35:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for moznetwork 03:35:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozprocess 03:35:22 INFO - Running setup.py install for mozprofile 03:35:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:22 INFO - Running setup.py install for mozrunner 03:35:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:23 INFO - Running setup.py install for mozscreenshot 03:35:23 INFO - Running setup.py install for moztest 03:35:23 INFO - Running setup.py install for mozversion 03:35:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:23 INFO - Cleaning up... 03:35:23 INFO - Return code: 0 03:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:23 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:23 INFO - Using env: {'DISPLAY': ':0', 03:35:23 INFO - 'HOME': '/home/cltbld', 03:35:23 INFO - 'LANG': 'en_US.UTF-8', 03:35:23 INFO - 'LANGUAGE': 'en_US:en', 03:35:23 INFO - 'LOGNAME': 'cltbld', 03:35:23 INFO - 'MAIL': '/var/mail/cltbld', 03:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:23 INFO - 'MOZ_NO_REMOTE': '1', 03:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:23 INFO - 'NO_EM_RESTART': '1', 03:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:23 INFO - 'PWD': '/builds/slave/test', 03:35:23 INFO - 'SHELL': '/bin/bash', 03:35:23 INFO - 'SHLVL': '1', 03:35:23 INFO - 'TERM': 'linux', 03:35:23 INFO - 'TMOUT': '86400', 03:35:23 INFO - 'USER': 'cltbld', 03:35:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:23 INFO - '_': '/tools/buildbot/bin/python'} 03:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:23 INFO - Running setup.py (path:/tmp/pip-hwW7XY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:23 INFO - Running setup.py (path:/tmp/pip-VJu9bX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:23 INFO - Running setup.py (path:/tmp/pip-cg5jd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:23 INFO - Running setup.py (path:/tmp/pip-oYkgRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:23 INFO - Running setup.py (path:/tmp/pip-xjrTLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:23 INFO - Running setup.py (path:/tmp/pip-VhL8Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:24 INFO - Running setup.py (path:/tmp/pip-mTHSQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:24 INFO - Running setup.py (path:/tmp/pip-h7qN6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:24 INFO - Running setup.py (path:/tmp/pip-fqAEQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:24 INFO - Running setup.py (path:/tmp/pip-JAMbDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:24 INFO - Running setup.py (path:/tmp/pip-PveUyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:24 INFO - Running setup.py (path:/tmp/pip-Pt6UUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:24 INFO - Running setup.py (path:/tmp/pip-HypoHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:24 INFO - Running setup.py (path:/tmp/pip-rLwkEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:24 INFO - Running setup.py (path:/tmp/pip-WYTOPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:24 INFO - Running setup.py (path:/tmp/pip-8Jt8si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:24 INFO - Running setup.py (path:/tmp/pip-p2RKgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:35:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:26 INFO - Downloading blessings-1.6.tar.gz 03:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:26 INFO - Installing collected packages: blessings 03:35:26 INFO - Running setup.py install for blessings 03:35:26 INFO - Successfully installed blessings 03:35:26 INFO - Cleaning up... 03:35:26 INFO - Return code: 0 03:35:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:27 INFO - Reading from file tmpfile_stdout 03:35:27 INFO - Current package versions: 03:35:27 INFO - argparse == 1.2.1 03:35:27 INFO - blessings == 1.6 03:35:27 INFO - blobuploader == 1.2.4 03:35:27 INFO - docopt == 0.6.1 03:35:27 INFO - manifestparser == 1.1 03:35:27 INFO - mozInstall == 1.12 03:35:27 INFO - mozcrash == 0.17 03:35:27 INFO - mozdebug == 0.1 03:35:27 INFO - mozdevice == 0.48 03:35:27 INFO - mozfile == 1.2 03:35:27 INFO - mozhttpd == 0.7 03:35:27 INFO - mozinfo == 0.9 03:35:27 INFO - mozleak == 0.1 03:35:27 INFO - mozlog == 3.1 03:35:27 INFO - moznetwork == 0.27 03:35:27 INFO - mozprocess == 0.22 03:35:27 INFO - mozprofile == 0.28 03:35:27 INFO - mozrunner == 6.11 03:35:27 INFO - mozscreenshot == 0.1 03:35:27 INFO - mozsystemmonitor == 0.0 03:35:27 INFO - moztest == 0.7 03:35:27 INFO - mozversion == 1.4 03:35:27 INFO - psutil == 3.1.1 03:35:27 INFO - requests == 1.2.3 03:35:27 INFO - wsgiref == 0.1.2 03:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:27 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:35:27 INFO - Using env: {'DISPLAY': ':0', 03:35:27 INFO - 'HOME': '/home/cltbld', 03:35:27 INFO - 'LANG': 'en_US.UTF-8', 03:35:27 INFO - 'LANGUAGE': 'en_US:en', 03:35:27 INFO - 'LOGNAME': 'cltbld', 03:35:27 INFO - 'MAIL': '/var/mail/cltbld', 03:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:27 INFO - 'MOZ_NO_REMOTE': '1', 03:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:27 INFO - 'NO_EM_RESTART': '1', 03:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:27 INFO - 'PWD': '/builds/slave/test', 03:35:27 INFO - 'SHELL': '/bin/bash', 03:35:27 INFO - 'SHLVL': '1', 03:35:27 INFO - 'TERM': 'linux', 03:35:27 INFO - 'TMOUT': '86400', 03:35:27 INFO - 'USER': 'cltbld', 03:35:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:27 INFO - '_': '/tools/buildbot/bin/python'} 03:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:35:27 INFO - Cleaning up... 03:35:27 INFO - Return code: 0 03:35:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:27 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:35:27 INFO - Using env: {'DISPLAY': ':0', 03:35:27 INFO - 'HOME': '/home/cltbld', 03:35:27 INFO - 'LANG': 'en_US.UTF-8', 03:35:27 INFO - 'LANGUAGE': 'en_US:en', 03:35:27 INFO - 'LOGNAME': 'cltbld', 03:35:27 INFO - 'MAIL': '/var/mail/cltbld', 03:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:27 INFO - 'MOZ_NO_REMOTE': '1', 03:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:27 INFO - 'NO_EM_RESTART': '1', 03:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:27 INFO - 'PWD': '/builds/slave/test', 03:35:27 INFO - 'SHELL': '/bin/bash', 03:35:27 INFO - 'SHLVL': '1', 03:35:27 INFO - 'TERM': 'linux', 03:35:27 INFO - 'TMOUT': '86400', 03:35:27 INFO - 'USER': 'cltbld', 03:35:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:27 INFO - '_': '/tools/buildbot/bin/python'} 03:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:27 INFO - Downloading/unpacking jsonschema 03:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:29 INFO - Downloading/unpacking functools32 (from jsonschema) 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:29 INFO - warning: no files found matching '*.txt' 03:35:29 INFO - no previously-included directories found matching 'build' 03:35:29 INFO - no previously-included directories found matching 'dist' 03:35:29 INFO - no previously-included directories found matching '.git*' 03:35:29 INFO - Installing collected packages: jsonschema, functools32 03:35:29 INFO - Running setup.py install for functools32 03:35:29 INFO - warning: no files found matching '*.txt' 03:35:29 INFO - no previously-included directories found matching 'build' 03:35:29 INFO - no previously-included directories found matching 'dist' 03:35:29 INFO - no previously-included directories found matching '.git*' 03:35:29 INFO - Successfully installed jsonschema functools32 03:35:29 INFO - Cleaning up... 03:35:29 INFO - Return code: 0 03:35:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:29 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 0x7f19a767bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24895a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:35:29 INFO - Using env: {'DISPLAY': ':0', 03:35:29 INFO - 'HOME': '/home/cltbld', 03:35:29 INFO - 'LANG': 'en_US.UTF-8', 03:35:29 INFO - 'LANGUAGE': 'en_US:en', 03:35:29 INFO - 'LOGNAME': 'cltbld', 03:35:29 INFO - 'MAIL': '/var/mail/cltbld', 03:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:29 INFO - 'MOZ_NO_REMOTE': '1', 03:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:29 INFO - 'NO_EM_RESTART': '1', 03:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:29 INFO - 'PWD': '/builds/slave/test', 03:35:29 INFO - 'SHELL': '/bin/bash', 03:35:29 INFO - 'SHLVL': '1', 03:35:29 INFO - 'TERM': 'linux', 03:35:29 INFO - 'TMOUT': '86400', 03:35:29 INFO - 'USER': 'cltbld', 03:35:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:29 INFO - '_': '/tools/buildbot/bin/python'} 03:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:30 INFO - Downloading/unpacking flake8 03:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:35:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:35:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:32 INFO - no previously-included directories found matching 'docs/_build' 03:35:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:35:32 INFO - Running setup.py install for pep8 03:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:32 INFO - no previously-included directories found matching 'docs/_build' 03:35:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:35:32 INFO - Cleaning up... 03:35:32 INFO - Return code: 0 03:35:32 INFO - Running post-action listener: _resource_record_post_action 03:35:33 INFO - Running post-action listener: _start_resource_monitoring 03:35:33 INFO - Starting resource monitoring. 03:35:33 INFO - ##### 03:35:33 INFO - ##### Running install step. 03:35:33 INFO - ##### 03:35:33 INFO - Running pre-action listener: _resource_record_pre_action 03:35:33 INFO - Running main action method: install 03:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:33 INFO - Reading from file tmpfile_stdout 03:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:33 INFO - Reading from file tmpfile_stdout 03:35:33 INFO - Output received: 03:35:33 INFO - Usage: mozinstall [options] installer 03:35:33 INFO - Options: 03:35:33 INFO - -h, --help show this help message and exit 03:35:33 INFO - -d DEST, --destination=DEST 03:35:33 INFO - Directory to install application into. [default: 03:35:33 INFO - "/builds/slave/test"] 03:35:33 INFO - --app=APP Application being installed. [default: firefox] 03:35:33 INFO - mkdir: /builds/slave/test/build/application 03:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:35:48 INFO - Reading from file tmpfile_stdout 03:35:48 INFO - Output received: 03:35:48 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:48 INFO - Running post-action listener: _resource_record_post_action 03:35:48 INFO - ##### 03:35:48 INFO - ##### Running run-tests step. 03:35:48 INFO - ##### 03:35:48 INFO - Running pre-action listener: _resource_record_pre_action 03:35:48 INFO - Running main action method: run_tests 03:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:48 INFO - Python 2.7.3 03:35:48 INFO - Return code: 0 03:35:48 INFO - grabbing minidump binary from tooltool 03:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:48 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 0x2518410>, '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 0x2519310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25197a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:35:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:35:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:48 INFO - Return code: 0 03:35:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:35:49 INFO - Return code: 0 03:35:49 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/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:35:49 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/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:35:49 INFO - Using env: {'DISPLAY': ':0', 03:35:49 INFO - 'HOME': '/home/cltbld', 03:35:49 INFO - 'LANG': 'en_US.UTF-8', 03:35:49 INFO - 'LANGUAGE': 'en_US:en', 03:35:49 INFO - 'LOGNAME': 'cltbld', 03:35:49 INFO - 'MAIL': '/var/mail/cltbld', 03:35:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:49 INFO - 'MOZ_NO_REMOTE': '1', 03:35:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:49 INFO - 'NO_EM_RESTART': '1', 03:35:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:49 INFO - 'PWD': '/builds/slave/test', 03:35:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:49 INFO - 'SHELL': '/bin/bash', 03:35:49 INFO - 'SHLVL': '1', 03:35:49 INFO - 'TERM': 'linux', 03:35:49 INFO - 'TMOUT': '86400', 03:35:49 INFO - 'USER': 'cltbld', 03:35:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864', 03:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:49 INFO - '_': '/tools/buildbot/bin/python'} 03:35:49 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/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:35:50 INFO - mozversion application_buildid: 20160510004007 03:35:50 INFO - mozversion application_changeset: 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d 03:35:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:50 INFO - mozversion application_name: Firefox 03:35:50 INFO - mozversion application_remotingname: firefox-dev 03:35:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:50 INFO - mozversion application_vendor: Mozilla 03:35:50 INFO - mozversion application_version: 48.0a2 03:35:50 INFO - mozversion platform_buildid: 20160510004007 03:35:50 INFO - mozversion platform_changeset: 63b7cc21ae7cf57d72b1a3a1b169ba3ea9fc237d 03:35:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:50 INFO - mozversion platform_version: 48.0a2 03:35:50 INFO - using testdate: 1462876550 03:35:50 INFO - actual date: 1462876550 03:35:50 INFO - starting webserver on 'localhost:52594' 03:35:50 INFO - SUITE-START | Running 2 tests 03:35:50 INFO - TEST-START | dromaeo_css 03:35:50 INFO - operating with platform_type : linux_ 03:35:50 INFO - Initialising browser for dromaeo_css test... 03:35:50 INFO - TEST-INFO | started process 6613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWSXwNJ/profile http://localhost:52594/getInfo.html) 03:35:53 INFO - PROCESS | 6613 | 03:35:53 INFO - PROCESS | 6613 | (process:6693): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:35:54 INFO - PROCESS | 6613 | __metrics Screen width/height:1600/1200 03:35:54 INFO - PROCESS | 6613 | colorDepth:24 03:35:54 INFO - PROCESS | 6613 | Browser inner width/height: 1024/697 03:35:54 INFO - PROCESS | 6613 | __metrics 03:35:55 ERROR - PROCESS | 6613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:35:55 INFO - TEST-INFO | 6613: exit 0 03:35:55 INFO - Browser initialized. 03:35:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:55 INFO - TEST-INFO | started process 6744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWSXwNJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:57 INFO - PROCESS | 6744 | 03:35:57 INFO - PROCESS | 6744 | (process:6816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:36:07 INFO - PROCESS | 6744 | RSS: Main: 151781376 03:36:07 INFO - PROCESS | 6744 | 03:36:57 INFO - PROCESS | 6744 | 1462876617312 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:39:04 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52594/tests/dromaeo/cssquery-ext.html) 03:39:05 INFO - PROCESS | 6744 | RSS: Main: 155582464 03:39:05 INFO - PROCESS | 6744 | 03:42:07 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-ext.html (next: http://localhost:52594/tests/dromaeo/cssquery-jquery.html) 03:42:08 INFO - PROCESS | 6744 | RSS: Main: 153309184 03:42:08 INFO - PROCESS | 6744 | 03:45:09 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52594/tests/dromaeo/cssquery-mootools.html) 03:45:10 INFO - PROCESS | 6744 | RSS: Main: 152969216 03:45:10 INFO - PROCESS | 6744 | 03:48:12 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52594/tests/dromaeo/cssquery-prototype.html) 03:48:12 INFO - PROCESS | 6744 | RSS: Main: 153214976 03:48:12 INFO - PROCESS | 6744 | 03:51:15 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52594/tests/dromaeo/cssquery-yui.html) 03:51:15 INFO - PROCESS | 6744 | RSS: Main: 154312704 03:51:15 INFO - PROCESS | 6744 | 03:54:17 INFO - PROCESS | 6744 | Cycle 1(1): loaded http://localhost:52594/tests/dromaeo/cssquery-yui.html (next: http://localhost:52594/tests/dromaeo/cssquery-dojo.html) 03:54:18 INFO - PROCESS | 6744 | RSS: Main: 155951104 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | __start_tp_report 03:54:18 INFO - PROCESS | 6744 | _x_x_mozilla_page_load 03:54:18 INFO - PROCESS | 6744 | _x_x_mozilla_page_load_details 03:54:18 INFO - PROCESS | 6744 | |i|pagename|runs| 03:54:18 INFO - PROCESS | 6744 | |0;dojo.html;3358.848851801669;3385.77992430492;3396.575428071491;3413.5391722117524;3413.948790768139;5510.283663123793;5531.529819965308;5555.3611334696525;5562.471565201309;5568.832935011951;5536.4186760390085;5559.8888022239535;5566.109422492402;5592.916106258409;5612.831615051545;5090.236464530313;5110.233464980255;5129.230615407681;5135.666181698196;5179.559737422323;5114.539691427771;5227.973860130713;5234.450382709799;5259.368875734917;5268.262443257947;5121.846344609649;5126.128558145106;5143;5176.58587313016;5270.578353731711;5101.668391554537;5127.384713834326;5144.61415393847;5151.562117220041;5152.557283960497;5074.746262686851;5100.056489549445;5127.384713834326;5152.536271735562;5176.456472070416;5236.266922630834;5367.946320536784;5390.272313237702;5470.699111548864;5571.025070612626;5977.5815692901515;5987.161797348374;5992.0712289595185;5996.640201587918;6003.039513677791;6044.486218671418;6056.182415373913;6065.181200537915;6071.241094863142;6081.543884208702;5412.052890744104;5499.615026948115;5532.197831314477;5590.580706447033;5696.829095127111;6067.029275315928;6078.726457309432;6079.574429789961;6083.8174854754425;6084.239470066242;5791.189233507313;5820.767169313265;5838.007538718428;5846.503047241032;5851.824445266649;5993.580449368589;6031.909521357183;6037.45662890342;6039.365866583946;6090.725917333642;5996.13056106862;6097.420745029215;6098.969505152446;6108.5418593605655;6109.602875813058;5904.61619994699;5957.880842383128;6077.9392206078255;6103.664298463538;6106.969465152646;4555.2483840166005;4564.7717614119165;4570.611498022638;4580.587747102777;4580.656450766206;4088.100617864065;4092.8567500137947;4107.794610269534;4126.834926602963;4128.6284234418445;5803.187553742479;5826.737796799154;5852.678102704393;5860.120981852756;5864.70676466175;5884.235049443545;5949.553783466257;5980.461758441761;6015.4586087252355;6066.878662426727;5693.914591281134;5748.913766293509;5750.2237197978575;5761.711914404263;5767.653940763484;5085.160948443539;5113;5149.716765577929;5153.3300670913295;5221.399539053057;6252.624842509373;6270.31026587075;6276.686165691697;6285.465735412541;6318.652474113968;6013.7895173669585;6070.0591408331775;6072.574919755575;6074.848128796815;6080.300765412034;6096.847578810565;6218.160548326099;6265.373462653698;6315.115883776367;6326.588771729823;5939.316978547349;5945.752465797126;5954.285485741739;5956.463918247206;5971.880562388815;5840.474357307863;6033.245844269466;6042.244719410074;6046.425589568984;6051.515878729779;5925.496332811759;5971.581989260884;6006.309274433496;6014.1580178775885;6044.24446944132;5923.111533269872;5925.674087925206;5928.8814223716145;5929.703514824155;5933.199018132497;5594.356648985418;5726.284214473191;5818.883622327615;5829.94170058294;5839;5895.616784908967;5913.408659134052;5934.109883517507;5987.131865879336;5989.5507836913275;5748.827535173951;5806.44838740319;5819.185314056121;5829.6793676346515;5830.183774271521 03:54:18 INFO - PROCESS | 6744 | |1;ext.html;624.5347216323839;665.1054331923561;668.836135146889;676.293273529162;679.4632240529982;39779.60220397795;40616.172272247706;40698.79650601747;40931.59068409315;41098.38352424709;43458;43745.343819842645;44072.338914916305;44079.33880991788;44121.33817992725;8995.640174393033;9174.128457796498;9175.220106290973;9188.494632795193;9194.08059194082;8896.644134234622;8961.641534338618;8990.190882820545;9231.399959002676;9235.769105772375;9237.95381023094;9278.489683067428;9322.300827437935;9334.53327333634;9362.297827662953;9188.954055229715;9218.492982885939;9232.953835230814;9241.306901982345;9287.396319239228;9134.543272836332;9256.814863702688;9286.349955503118;9293.67472138472;9365.76585585359;42804;43165.784171079256;43425.56574434247;43449.56550434487;43698;3962.722609417342;4063.0654949361515;4240.957590424087;4264.573542645741;4500.977495112504;32893.17767055819;33135;33328;33351.49972750411;33957.6604233957;4405.735655860626;4519.07358991406;4591.747453890035;4595.908081838378;4650.697704649221;237179;238275;238934;239447;239871;38076;55908.720456398274;57553;57557;57558.424415755304;38305;38313.616863831005;38385;38442.615573844465;38503.807480962416;16702.749458758128;16862.578435538966;16906.40827571029;16955.406560770312;16955.49133525996;14663.046901951553;14752.926235368968;14800.407983680532;14804.92597537027;14864.70270594582;9190.207909457591;9231.907680923105;9279.211267042241;9480.33637645372;9483.525823708787;3612.223371975038;3678.6873115784924;3693.132113953219;3739.1586892948867;3762.379207430798;1143.114086582905;1143.2168964259508;1163.8428812110426;1165.6328256599145;1177.3701069927547;33024.1743956403;33113.50329745056;33115.83442082774;33660.663393366245;33665.663343366745;1105.7567335186245;1198.370855300974;1238.108561835477;1255.4727014653868;1312.4487715159655;14855.5543333698;14968.70062598742;15190.848091518943;15574.766378504104;15662.216889155497;476253;566515;573833;579753;584888;62581;63333;63426;63750;63891.36108638947;1582.9287682054335;1583.5566041508166;1585.3975489314219;1592.2277695317762;1649.307290937809;32180;33008.50487242645;33245.83377083099;33851.15372115717;33878.322433551686;53419;53905;53962.73018634882;53998.460015399345;54322.7283863594;428947;431030;431080;431133;431509;30385.08844734573;30839.691603083684;47420.2886956689;48666.270005949234;48794.512054879;44235.11529769451;45299;46005;46284.53715462802;46643.533564665275;38483.615163848;38582.80708596439;38655.42016869693;38701.80649096736;38957.2208555833;31940.041798746075;31967.36065278728;32006.6799332013;32322.83838580792;32378.190545236557;39438.605613943495;39617;40624.593754063266;43161;43583;35935.82032089823;36145.45781813222;36238.4564231542;36305.81847090748;36546.451803222444;27762.444751105268;28617.427651446436;28712;28746.137615871558;28784.424311513234 03:54:18 INFO - PROCESS | 6744 | |2;jquery.html;417.67630086682834;425.877203766997;428.8842012656585;435.9825606975721;441.9270820314648;14623;18366.540836479096;19031.809681903178;19125.99999999998;19158.425247242605;17979.37072202473;19659.5085122872;19669.803301966975;19924;19954;5626.690532020737;5666.54667626591;5811.709414529278;5845.970770146165;5888.852778680524;5667.121596152582;5746.138079288098;5767.221425107619;5784.8843023139725;5795.130730390454;5542.722863856811;5670.0927851543765;5697.544196464273;5729.398413166599;5734.053881109612;5589.077802162638;5638.267025286707;5653.8586535336535;5656.604037717361;5666.631668941526;5072.467390923936;5074.822381216677;5079.111155547801;5093.668911520739;5329.920051199235;12563.497460101586;12644.810327845089;12651.493940242379;12660.430280637302;12707.809382859265;2489.9377515562073;2501.6122501012374;2562.2569454858067;2576.3945472813875;2591.093117408892;9684.515774211332;9700;9750.561224744904;9855.950720246425;9933.90066099337;1977.6539105656595;2122.2678176029244;2131;2137.444264491228;2139.6362618354915;78422.6078869602;81089;82896.58551707263;83184.58407707984;83880;11045.116390688725;11137.888621113847;11252.26860254081;11691.824622630667;12368.690782730504;15294;15395.692086158439;15422.537323880302;15432.92283538575;15435.382584696486;8258.752237432887;8605.698800541952;8784.429012114193;8841.336899732545;8936.24041956428;8166.387520935954;8254.463459875089;8366.205210504992;8864.8670269946;8960.238379737664;4836.733979631154;4863.8540843774745;4905.386826646669;4927.7536123193695;4935.7532123393685;2076.3355726167783;2132.3070002249333;2143.132031527234;2158.4388059104745;2181.901814418355;959.4866746290701;1039.8284283093355;1107.2360071550604;1125.8536390269212;1149;18135.15399182718;18256.817431825777;18358.357457488924;18859.24563017464;18909.905450472936;1076.4187338836941;1087.8477013218155;1109.4175557832202;1142.8857114288671;1148.9827652585218;10718.142548596094;10749.301295415773;10855.348679079281;10872.510737016853;10977.95709407605;519987;525383;526489;536263;539777;84719.5764021176;91588.54205728929;93895.53052234695;94705;100656;1152.4813833774836;1162.7558212775243;1171.039747407135;1185.2651356159065;1198.7962046452124;17220.397286094925;17350.39273625417;17359.56601084983;17484.47546573605;17661.116944152996;40543.3918491217;40874.79562602168;41515;41914;41946.37080443735;60702;60835.39164608297;60858;60921.69539152276;61019.69490152521;7884.526928384315;8280.875786863322;8471.27994120482;8557.529335886586;8580.699675511327;12588.370581471074;12825.102242843284;12868.485260589472;12951.676208094874;13127.277999710108;11122.277051991594;11463.713407164887;11501.82747258775;11604.6518604442;11921.165518413627;11437.142214334124;11502.252353596989;11678.824817627572;11697.415129243675;12161.533962820553;11752.58865939688;12357.25856448616;12518.186317889307;12602.558910438458;12710.87289127134;7933.404994625542;8254.215849494289;8450.535220562928;8454.281386082252;8534.74395768128;10312.48437578103;11585;11820.113491488344;11880.465379058136;12026.579069732867 03:54:18 INFO - PROCESS | 6744 | |3;mootools.html;1575.676986217825;1625.4717216904505;1851.5648822526705;1895.7251198576207;1942.126043280524;7720.382369410434;8212.260896519312;8596.914030859689;8790.91209087909;8792.69225577105;8473.618687159078;8556.229939305462;8556.828863422743;8623.827523449527;8624.95687521563;2372.240882917463;2390.8924098415614;2394.8682822444844;2395.161693407302;2398.028798336668;2388.5700573896693;2411.987940060297;2440.890159942807;2440.987795061022;2444.9022039118413;2420.6127019676856;2444;2466.9259922202364;2483.801295896324;2505.3110394641526;2427.2354208424376;2445.400876785181;2451.852888826676;2451.9754802452017;2490.10356271742;2364.846284991487;2408.397900524869;2412.6260429633435;2414.9517009659885;2427.1990243219693;8784.78038049054;8890.06654301302;8890.155435233642;8895.377323587352;8935.687250946186;5393.946060539383;5463.836084917459;5508.64193827404;5524.116141417394;5548.4174161713245;3431.9485207721905;3460.1176699941607;3522.5244591980013;3538.2569660371096;3541.6458354164633;1134.9659510214706;1175.294823106138;1180.698921774942;1201.3212534917743;1208.7763763703656;12482.188657737308;12518.499260029588;12551.874481255161;12554;12559.372031398394;4633.9536604634195;4675.205215113371;4725.125851717443;4756.738379389167;4772.236442169236;10620;10671.146308295318;10678.466076696133;10682.465876706134;10690.465476726133;5420.945790542123;5467.835964921059;5475.6440831345835;5477.233187353773;5507.201455788888;4358.978205108954;4805.639577031737;4901.50984901507;4906.55840974314;5014.924776128361;4128.752274863457;4184.225918205142;4218.430511880918;4233.280342341809;4242.703010789277;1281.4169552853616;1293.8318018657515;1305.0733978875105;1305.2690493323769;1305.614843621134;906.8322360363354;977.2133432586694;978.4814048554277;1000.2645410213274;1014.4471263161595;5515.283013208337;5641.351244606841;5755.452834778992;5807.361190269067;5833.708314584339;463.1801710971561;467.7544289248172;468.6906641616517;475.57198521331077;480.8485327122015;4048.4534587830854;4072.2873497137884;4091.9181616367505;4099.118689481776;4107.8973025674;10640.733981650521;10919.290246133976;10988.175886808362;11083.556657733761;11106.278091924;10831.24181307301;10889.183311251687;10936.671899843017;10952.780944381228;10965.56137754481;8412.411131220879;8415.200555947175;8438.282745966662;8509.489430634181;8522.616482258314;5244.187150991603;5375.4087050425205;5441.329593519477;5451.536619387396;5506.889862202814;9471.28965327617;9497.097775711296;9730.17293530058;9848.261380396356;9852.359596626196;9818.361806482555;9973.002699729968;10012.299139060196;10022.298439109192;10130.08829205375;6969.512134150561;7445.851082978418;7637.770866874002;7813.492123011986;8027.959860200662;8172.754817355489;8191.058028326819;8211.917880821355;8275.917240827515;8319.792005199919;7130.964345178241;7566.016417865642;7623.504472209289;7654.69381224767;7796.688132474637;7584.582847943416;7595.620218988918;7670.463067585216;7715.189905060112;7731.961340193263;7007.159140903124;7023.508354415347;7043.049188359506;7097.467689923174;7104.431645468247;5297.655652382583;5327.493888080626;5418.241446197457;5483.424240454695;5510.6969116698965;5215.16557350822;5265.629527492249;5435.891282174255;5482.506574408322;5512.779488820403 03:54:18 INFO - PROCESS | 6744 | |4;prototype.html;318.09026185110594;327.5528903047341;336.7558520072947;337.47859556984463;338.95085212644153;6477.190351206099;6582.637954912478;6635.535512514126;6648.26869044406;6767;6604.141461609996;6625.536212465129;6718.664066796665;6738.663066846662;6746.696398662059;5047.873803154923;5054.9494505054845;5063.088644044089;5063.518965698253;5064.113780088488;5053.949460505385;5059.6458247922665;5063.569596584295;5065.113605119108;5067.670601410897;4999.475055119215;5008.974955125219;5010.599152067844;5011.974940125294;5017.473165317626;4755.857324280277;4881.1213981483315;5001.699898006132;5011.523905228997;5017.297578339054;4205.66354691627;4212.073343864345;4212.4523811904255;4220.050488640062;4232.343986682069;6448.419642232222;6449.226092868839;6453.419192272671;6459.321771214002;6468.967655161694;5713.885722285572;5726.169705392736;5735.885282294373;5742.569307301969;5743.16724075011;6964.0598519200275;6989.405900498464;7048.612326322051;7063.92936070643;7068.222495525488;4480.619147372445;4613.63090952723;4659.720416775004;4664.230401983668;4671.929921051187;7322.377597904185;7336.706531738778;7400.555966642019;7412.703491860265;7425.294597013275;4747.121782470254;4759.643026773006;4760.500147484534;4761.619070474354;4772.260299653559;4813.566778989908;4820.71075735457;4822.300766388854;4825.324454576362;4828.975855120702;5707.971460142756;5710.600257981901;5711.086226203787;5716.256886604715;5722.7710891563875;6988.231294557595;7132.679029443688;7139.357457828821;7140;7148.28517148281;1677.6057626457773;1686.6795308891271;1697.3634886917405;1698.9065601391794;1700.9149542522825;1010.8281592129356;1057.6404022632341;1059.89930956559;1073.7476692977143;1077.9946100269449;6819.897701534481;6954.65226738661;6988.895166572505;7013.684384202723;7019;7392.186859445456;7406.703731850774;7412.740554080581;7425.7029718810645;7428.368588669916;6924.584524928419;6972.1284839395075;6974.721011159497;6988.37104660583;6989.161300643956;3888.2417928504237;3959.8416063357718;3991.201759648082;3992.401139829049;4001.8799436016966;7648.317370178552;7657.272559106876;7665.348445382205;7671.884921726179;7672.5012874163;7468.066491688539;7494.962525187339;7498.212687667826;7527.2849079337375;7533.962330188424;7714.691412343555;7727.459077864608;7733.690652373954;7734.4585878989055;7749.4575379724;7143.178534468602;7334.559926404219;7364.889526656997;7398.741044063432;7410.888836667562;7254.347108760237;7277.708891644275;7306.525075870051;7309.597972111585;7341.4126869849215;7733.922660773545;7746.49647772893;7747.72882949094;7759.534427934342;7760.262775036363;4726.220173671306;4764.6664733469715;4767.618590512681;4767.952320476889;4770.689905156154;7150.10623672041;7330.706771729071;7387.556746595222;7389.556626602421;7435.405167586472;7185.748498802517;7236.493445458978;7237.8914316284245;7246.094238220223;7249.492535522674;7188.820279492846;7195.820104497429;7197.388222000979;7203.135623725187;7209.134903811576;7026.508144429841;7050.189228238818;7057.153141623038;7060.329268719669;7064.611446370499;6991.3008699131715;7187.712491500281;7228.710851565878;7250.166230883516;7255.963720181577;6852.862942741217;6986.336298051677;7036.788896333118;7073.328033836778;7104.183018952886 03:54:18 INFO - PROCESS | 6744 | |5;yui.html;840.9075001749807;865.9567021648916;935.4434111703536;947.6825263536715;953.4565297780264;14902.92548537257;15137.940344175911;15159.090454572734;15166.317515711791;15184.696306073873;12851.935740321309;12979.091463597528;13048;13050.477980880778;13066.934665326684;892.8660700894885;904.8009437923646;911.0161026091838;911.1480765484293;911.7447114807865;888.5290795878162;892.8794612727264;894.1728900766798;896.1979028769248;906.2976193450063;934.8550974598948;935.7847695030113;939.3143005605912;945.6264775413707;955.7467271173144;937.4703292639671;941.0213378086781;941.6421759731327;943.0663642993455;952.7999120184735;703.6868593475905;706.4842664854633;708.0158579574396;711.01524388722;714.5355518912696;15488.612784680361;15573.143477108755;15626.921865390714;15654.530364089096;15840.683186336324;14601.415943362254;14620.926895365561;14731.337089830984;14779;14860.182689952047;12396.256224626552;12424.503019879194;12561.120721549496;12651;12666.936665316707;4021.97989010056;4037.4347591337237;4064.1871625674985;4079.63283304504;4086.7956602169775;58484.70757646227;58681.70659146677;59780;60920.08619870705;61486.69256653733;11008.284461509977;11130.944345278383;11165.888341116648;11259.042981346514;11307.717307067389;19066;19123.521911952314;19307.324243651405;19323.51691207731;19348.32280870163;8628.78428039304;8783.824323513494;8808.03111657717;8850;8879.422837515542;5095.31213286209;5138.691678499302;5145.099607568661;5160.993606246746;5169.922451163236;3677.5403074615674;3746.4754934309217;3754.2679177560112;3807.1053302473897;3809.657130858236;717.9856402871914;725.1044959475045;726.8437285983433;729.9270072992658;736.8784150615196;744.3747252308087;763.2253262938123;771.6488997506121;784.2823816208106;789.577575996839;9480.810383792423;9731.41611503312;10180.786388318584;10200.489975501196;10775.676729698122;840.3025488844245;852.1733918099434;859.4671303791689;861.67687117331;870.7997160653085;4444.2000439920475;4882.36529251195;4884.8290309838985;4893.755312234445;4904.60763138948;67308.66345668338;69274.65362673154;69282.65358673174;69316;69416;56161.71919140378;56393;58073;58708.11937820936;59298;53424.465755342724;53428;54255.18617220824;54281;54600.180997285075;9791.26565507604;9960.402375857471;10099.798004040025;10118.291719579853;10242.385456872611;40879.38680919729;41459.585404145575;41514.58485415107;41589.16821663489;41940.370894436;47839.282410764565;48094.75952620214;53736;54338.45661543334;54879.725601371734;11782.11634127461;11809.409529523662;11831.76336473283;11926.045916326499;12018.699532511757;14090.436382544583;14139.858601413855;14361.784573231202;14455.49405770835;14587.927060364631;13339.599812005656;13366.866331336561;13520;13835.169889806644;13901.791473128114;13169.604911852659;13317.067805253539;13593.252371119288;13707.931460342634;13735.759462101538;13039;13169.802452963404;13610.59168224955;13729.656758581115;14057;11508.88491115078;11566.768664626492;11578.536858525564;11795.233309834834;11809.173357864867;11707.121965852424;11765.11761617865;11854;12104.455299511366;12204.816927745913 03:54:18 INFO - PROCESS | 6744 | __end_tp_report 03:54:18 INFO - PROCESS | 6744 | __start_cc_report 03:54:18 INFO - PROCESS | 6744 | _x_x_mozilla_cycle_collect,316 03:54:18 INFO - PROCESS | 6744 | __end_cc_report 03:54:18 INFO - PROCESS | 6744 | __startTimestamp1462877658029__endTimestamp 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | ------- Summary: start ------- 03:54:18 INFO - PROCESS | 6744 | Number of tests: 6 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#0] dojo.html Cycles:165 Average:5597.76 Median:5830.18 stddev:624.29 (10.7%) stddev-sans-first:600.99 03:54:18 INFO - PROCESS | 6744 | Values: 3358.8 3385.8 3396.6 3413.5 3413.9 5510.3 5531.5 5555.4 5562.5 5568.8 5536.4 5559.9 5566.1 5592.9 5612.8 5090.2 5110.2 5129.2 5135.7 5179.6 5114.5 5228.0 5234.5 5259.4 5268.3 5121.8 5126.1 5143.0 5176.6 5270.6 5101.7 5127.4 5144.6 5151.6 5152.6 5074.7 5100.1 5127.4 5152.5 5176.5 5236.3 5367.9 5390.3 5470.7 5571.0 5977.6 5987.2 5992.1 5996.6 6003.0 6044.5 6056.2 6065.2 6071.2 6081.5 5412.1 5499.6 5532.2 5590.6 5696.8 6067.0 6078.7 6079.6 6083.8 6084.2 5791.2 5820.8 5838.0 5846.5 5851.8 5993.6 6031.9 6037.5 6039.4 6090.7 5996.1 6097.4 6099.0 6108.5 6109.6 5904.6 5957.9 6077.9 6103.7 6107.0 4555.2 4564.8 4570.6 4580.6 4580.7 4088.1 4092.9 4107.8 4126.8 4128.6 5803.2 5826.7 5852.7 5860.1 5864.7 5884.2 5949.6 5980.5 6015.5 6066.9 5693.9 5748.9 5750.2 5761.7 5767.7 5085.2 5113.0 5149.7 5153.3 5221.4 6252.6 6270.3 6276.7 6285.5 6318.7 6013.8 6070.1 6072.6 6074.8 6080.3 6096.8 6218.2 6265.4 6315.1 6326.6 5939.3 5945.8 5954.3 5956.5 5971.9 5840.5 6033.2 6042.2 6046.4 6051.5 5925.5 5971.6 6006.3 6014.2 6044.2 5923.1 5925.7 5928.9 5929.7 5933.2 5594.4 5726.3 5818.9 5829.9 5839.0 5895.6 5913.4 5934.1 5987.1 5989.6 5748.8 5806.4 5819.2 5829.7 5830.2 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#1] ext.html Cycles:180 Average:56821.91 Median:40815.19 stddev:114453.23 (280.4%) stddev-sans-first:114696.53 03:54:18 INFO - PROCESS | 6744 | Values: 624.5 665.1 668.8 676.3 679.5 39779.6 40616.2 40698.8 40931.6 41098.4 43458.0 43745.3 44072.3 44079.3 44121.3 8995.6 9174.1 9175.2 9188.5 9194.1 8896.6 8961.6 8990.2 9231.4 9235.8 9238.0 9278.5 9322.3 9334.5 9362.3 9189.0 9218.5 9233.0 9241.3 9287.4 9134.5 9256.8 9286.3 9293.7 9365.8 42804.0 43165.8 43425.6 43449.6 43698.0 3962.7 4063.1 4241.0 4264.6 4501.0 32893.2 33135.0 33328.0 33351.5 33957.7 4405.7 4519.1 4591.7 4595.9 4650.7 237179.0 238275.0 238934.0 239447.0 239871.0 38076.0 55908.7 57553.0 57557.0 57558.4 38305.0 38313.6 38385.0 38442.6 38503.8 16702.7 16862.6 16906.4 16955.4 16955.5 14663.0 14752.9 14800.4 14804.9 14864.7 9190.2 9231.9 9279.2 9480.3 9483.5 3612.2 3678.7 3693.1 3739.2 3762.4 1143.1 1143.2 1163.8 1165.6 1177.4 33024.2 33113.5 33115.8 33660.7 33665.7 1105.8 1198.4 1238.1 1255.5 1312.4 14855.6 14968.7 15190.8 15574.8 15662.2 476253.0 566515.0 573833.0 579753.0 584888.0 62581.0 63333.0 63426.0 63750.0 63891.4 1582.9 1583.6 1585.4 1592.2 1649.3 32180.0 33008.5 33245.8 33851.2 33878.3 53419.0 53905.0 53962.7 53998.5 54322.7 428947.0 431030.0 431080.0 431133.0 431509.0 30385.1 30839.7 47420.3 48666.3 48794.5 44235.1 45299.0 46005.0 46284.5 46643.5 38483.6 38582.8 38655.4 38701.8 38957.2 31940.0 31967.4 32006.7 32322.8 32378.2 39438.6 39617.0 40624.6 43161.0 43583.0 35935.8 36145.5 36238.5 36305.8 36546.5 27762.4 28617.4 28712.0 28746.1 28784.4 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#2] jquery.html Cycles:180 Average:29936.68 Median:2495.78 stddev:87225.00 (3494.9%) stddev-sans-first:87441.53 03:54:18 INFO - PROCESS | 6744 | Values: 417.7 425.9 428.9 436.0 441.9 14623.0 18366.5 19031.8 19126.0 19158.4 17979.4 19659.5 19669.8 19924.0 19954.0 5626.7 5666.5 5811.7 5846.0 5888.9 5667.1 5746.1 5767.2 5784.9 5795.1 5542.7 5670.1 5697.5 5729.4 5734.1 5589.1 5638.3 5653.9 5656.6 5666.6 5072.5 5074.8 5079.1 5093.7 5329.9 12563.5 12644.8 12651.5 12660.4 12707.8 2489.9 2501.6 2562.3 2576.4 2591.1 9684.5 9700.0 9750.6 9856.0 9933.9 1977.7 2122.3 2131.0 2137.4 2139.6 78422.6 81089.0 82896.6 83184.6 83880.0 11045.1 11137.9 11252.3 11691.8 12368.7 15294.0 15395.7 15422.5 15432.9 15435.4 8258.8 8605.7 8784.4 8841.3 8936.2 8166.4 8254.5 8366.2 8864.9 8960.2 4836.7 4863.9 4905.4 4927.8 4935.8 2076.3 2132.3 2143.1 2158.4 2181.9 959.5 1039.8 1107.2 1125.9 1149.0 18135.2 18256.8 18358.4 18859.2 18909.9 1076.4 1087.8 1109.4 1142.9 1149.0 10718.1 10749.3 10855.3 10872.5 10978.0 519987.0 525383.0 526489.0 536263.0 539777.0 84719.6 91588.5 93895.5 94705.0 100656.0 1152.5 1162.8 1171.0 1185.3 1198.8 17220.4 17350.4 17359.6 17484.5 17661.1 40543.4 40874.8 41515.0 41914.0 41946.4 60702.0 60835.4 60858.0 60921.7 61019.7 7884.5 8280.9 8471.3 8557.5 8580.7 12588.4 12825.1 12868.5 12951.7 13127.3 11122.3 11463.7 11501.8 11604.7 11921.2 11437.1 11502.3 11678.8 11697.4 12161.5 11752.6 12357.3 12518.2 12602.6 12710.9 7933.4 8254.2 8450.5 8454.3 8534.7 10312.5 11585.0 11820.1 11880.5 12026.6 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#3] mootools.html Cycles:180 Average:5809.57 Median:2643.24 stddev:3271.59 (123.8%) stddev-sans-first:3265.29 03:54:18 INFO - PROCESS | 6744 | Values: 1575.7 1625.5 1851.6 1895.7 1942.1 7720.4 8212.3 8596.9 8790.9 8792.7 8473.6 8556.2 8556.8 8623.8 8625.0 2372.2 2390.9 2394.9 2395.2 2398.0 2388.6 2412.0 2440.9 2441.0 2444.9 2420.6 2444.0 2466.9 2483.8 2505.3 2427.2 2445.4 2451.9 2452.0 2490.1 2364.8 2408.4 2412.6 2415.0 2427.2 8784.8 8890.1 8890.2 8895.4 8935.7 5393.9 5463.8 5508.6 5524.1 5548.4 3431.9 3460.1 3522.5 3538.3 3541.6 1135.0 1175.3 1180.7 1201.3 1208.8 12482.2 12518.5 12551.9 12554.0 12559.4 4634.0 4675.2 4725.1 4756.7 4772.2 10620.0 10671.1 10678.5 10682.5 10690.5 5420.9 5467.8 5475.6 5477.2 5507.2 4359.0 4805.6 4901.5 4906.6 5014.9 4128.8 4184.2 4218.4 4233.3 4242.7 1281.4 1293.8 1305.1 1305.3 1305.6 906.8 977.2 978.5 1000.3 1014.4 5515.3 5641.4 5755.5 5807.4 5833.7 463.2 467.8 468.7 475.6 480.8 4048.5 4072.3 4091.9 4099.1 4107.9 10640.7 10919.3 10988.2 11083.6 11106.3 10831.2 10889.2 10936.7 10952.8 10965.6 8412.4 8415.2 8438.3 8509.5 8522.6 5244.2 5375.4 5441.3 5451.5 5506.9 9471.3 9497.1 9730.2 9848.3 9852.4 9818.4 9973.0 10012.3 10022.3 10130.1 6969.5 7445.9 7637.8 7813.5 8028.0 8172.8 8191.1 8211.9 8275.9 8319.8 7131.0 7566.0 7623.5 7654.7 7796.7 7584.6 7595.6 7670.5 7715.2 7732.0 7007.2 7023.5 7043.0 7097.5 7104.4 5297.7 5327.5 5418.2 5483.4 5510.7 5215.2 5265.6 5435.9 5482.5 5512.8 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#4] prototype.html Cycles:180 Average:5906.87 Median:6836.38 stddev:1865.26 (27.3%) stddev-sans-first:1822.71 03:54:18 INFO - PROCESS | 6744 | Values: 318.1 327.6 336.8 337.5 339.0 6477.2 6582.6 6635.5 6648.3 6767.0 6604.1 6625.5 6718.7 6738.7 6746.7 5047.9 5054.9 5063.1 5063.5 5064.1 5053.9 5059.6 5063.6 5065.1 5067.7 4999.5 5009.0 5010.6 5012.0 5017.5 4755.9 4881.1 5001.7 5011.5 5017.3 4205.7 4212.1 4212.5 4220.1 4232.3 6448.4 6449.2 6453.4 6459.3 6469.0 5713.9 5726.2 5735.9 5742.6 5743.2 6964.1 6989.4 7048.6 7063.9 7068.2 4480.6 4613.6 4659.7 4664.2 4671.9 7322.4 7336.7 7400.6 7412.7 7425.3 4747.1 4759.6 4760.5 4761.6 4772.3 4813.6 4820.7 4822.3 4825.3 4829.0 5708.0 5710.6 5711.1 5716.3 5722.8 6988.2 7132.7 7139.4 7140.0 7148.3 1677.6 1686.7 1697.4 1698.9 1700.9 1010.8 1057.6 1059.9 1073.7 1078.0 6819.9 6954.7 6988.9 7013.7 7019.0 7392.2 7406.7 7412.7 7425.7 7428.4 6924.6 6972.1 6974.7 6988.4 6989.2 3888.2 3959.8 3991.2 3992.4 4001.9 7648.3 7657.3 7665.3 7671.9 7672.5 7468.1 7495.0 7498.2 7527.3 7534.0 7714.7 7727.5 7733.7 7734.5 7749.5 7143.2 7334.6 7364.9 7398.7 7410.9 7254.3 7277.7 7306.5 7309.6 7341.4 7733.9 7746.5 7747.7 7759.5 7760.3 4726.2 4764.7 4767.6 4768.0 4770.7 7150.1 7330.7 7387.6 7389.6 7435.4 7185.7 7236.5 7237.9 7246.1 7249.5 7188.8 7195.8 7197.4 7203.1 7209.1 7026.5 7050.2 7057.2 7060.3 7064.6 6991.3 7187.7 7228.7 7250.2 7256.0 6852.9 6986.3 7036.8 7073.3 7104.2 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - PROCESS | 6744 | [#5] yui.html Cycles:180 Average:16108.53 Median:23192.29 stddev:18840.56 (81.2%) stddev-sans-first:18858.53 03:54:18 INFO - PROCESS | 6744 | Values: 840.9 866.0 935.4 947.7 953.5 14902.9 15137.9 15159.1 15166.3 15184.7 12851.9 12979.1 13048.0 13050.5 13066.9 892.9 904.8 911.0 911.1 911.7 888.5 892.9 894.2 896.2 906.3 934.9 935.8 939.3 945.6 955.7 937.5 941.0 941.6 943.1 952.8 703.7 706.5 708.0 711.0 714.5 15488.6 15573.1 15626.9 15654.5 15840.7 14601.4 14620.9 14731.3 14779.0 14860.2 12396.3 12424.5 12561.1 12651.0 12666.9 4022.0 4037.4 4064.2 4079.6 4086.8 58484.7 58681.7 59780.0 60920.1 61486.7 11008.3 11130.9 11165.9 11259.0 11307.7 19066.0 19123.5 19307.3 19323.5 19348.3 8628.8 8783.8 8808.0 8850.0 8879.4 5095.3 5138.7 5145.1 5161.0 5169.9 3677.5 3746.5 3754.3 3807.1 3809.7 718.0 725.1 726.8 729.9 736.9 744.4 763.2 771.6 784.3 789.6 9480.8 9731.4 10180.8 10200.5 10775.7 840.3 852.2 859.5 861.7 870.8 4444.2 4882.4 4884.8 4893.8 4904.6 67308.7 69274.7 69282.7 69316.0 69416.0 56161.7 56393.0 58073.0 58708.1 59298.0 53424.5 53428.0 54255.2 54281.0 54600.2 9791.3 9960.4 10099.8 10118.3 10242.4 40879.4 41459.6 41514.6 41589.2 41940.4 47839.3 48094.8 53736.0 54338.5 54879.7 11782.1 11809.4 11831.8 11926.0 12018.7 14090.4 14139.9 14361.8 14455.5 14587.9 13339.6 13366.9 13520.0 13835.2 13901.8 13169.6 13317.1 13593.3 13707.9 13735.8 13039.0 13169.8 13610.6 13729.7 14057.0 11508.9 11566.8 11578.5 11795.2 11809.2 11707.1 11765.1 11854.0 12104.5 12204.8 03:54:18 INFO - PROCESS | 6744 | -------- Summary: end -------- 03:54:18 INFO - PROCESS | 6744 | 03:54:18 INFO - TEST-INFO | 6744: exit 0 03:54:18 INFO - TEST-OK | dromaeo_css | took 1108650ms 03:54:18 INFO - TEST-START | kraken 03:54:18 INFO - operating with platform_type : linux_ 03:54:18 INFO - Initialising browser for kraken test... 03:54:18 INFO - TEST-INFO | started process 6986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckFWYb/profile http://localhost:52594/getInfo.html) 03:54:22 INFO - PROCESS | 6986 | 03:54:22 INFO - PROCESS | 6986 | (process:7062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:54:22 INFO - PROCESS | 6986 | __metrics Screen width/height:1600/1200 03:54:22 INFO - PROCESS | 6986 | colorDepth:24 03:54:22 INFO - PROCESS | 6986 | Browser inner width/height: 1024/697 03:54:22 INFO - PROCESS | 6986 | __metrics 03:54:23 ERROR - PROCESS | 6986 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:54:24 INFO - TEST-INFO | 6986: exit 0 03:54:24 INFO - Browser initialized. 03:54:24 INFO - Running cycle 1/1 for kraken test... 03:54:24 INFO - TEST-INFO | started process 7113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpckFWYb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:26 INFO - PROCESS | 7113 | 03:54:26 INFO - PROCESS | 7113 | (process:7183): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:54:36 INFO - PROCESS | 7113 | RSS: Main: 151740416 03:54:36 INFO - PROCESS | 7113 | 03:54:38 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52594/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:39 INFO - PROCESS | 7113 | RSS: Main: 156794880 03:54:39 INFO - PROCESS | 7113 | 03:54:42 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52594/tests/kraken/driver.html?testName=audio-dft) 03:54:42 INFO - PROCESS | 7113 | RSS: Main: 156639232 03:54:42 INFO - PROCESS | 7113 | 03:54:45 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52594/tests/kraken/driver.html?testName=audio-fft) 03:54:46 INFO - PROCESS | 7113 | RSS: Main: 157007872 03:54:46 INFO - PROCESS | 7113 | 03:54:48 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52594/tests/kraken/driver.html?testName=audio-oscillator) 03:54:49 INFO - PROCESS | 7113 | RSS: Main: 157134848 03:54:49 INFO - PROCESS | 7113 | 03:54:51 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:51 INFO - PROCESS | 7113 | RSS: Main: 156995584 03:54:51 INFO - PROCESS | 7113 | 03:54:54 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52594/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:55 INFO - PROCESS | 7113 | RSS: Main: 157044736 03:54:55 INFO - PROCESS | 7113 | 03:54:58 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52594/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:59 INFO - PROCESS | 7113 | RSS: Main: 157065216 03:54:59 INFO - PROCESS | 7113 | 03:55:02 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52594/tests/kraken/driver.html?testName=json-parse-financial) 03:55:02 INFO - PROCESS | 7113 | RSS: Main: 157159424 03:55:02 INFO - PROCESS | 7113 | 03:55:04 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:05 INFO - PROCESS | 7113 | RSS: Main: 156995584 03:55:05 INFO - PROCESS | 7113 | 03:55:06 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:07 INFO - PROCESS | 7113 | RSS: Main: 157106176 03:55:07 INFO - PROCESS | 7113 | 03:55:09 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:10 INFO - PROCESS | 7113 | RSS: Main: 157220864 03:55:10 INFO - PROCESS | 7113 | 03:55:12 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:13 INFO - PROCESS | 7113 | RSS: Main: 157806592 03:55:13 INFO - PROCESS | 7113 | 03:55:15 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:16 INFO - PROCESS | 7113 | RSS: Main: 157937664 03:55:16 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | Cycle 1(1): loaded http://localhost:52594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52594/tests/kraken/driver.html?testName=ai-astar) 03:55:18 INFO - PROCESS | 7113 | RSS: Main: 159150080 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | __start_tp_report 03:55:18 INFO - PROCESS | 7113 | _x_x_mozilla_page_load 03:55:18 INFO - PROCESS | 7113 | _x_x_mozilla_page_load_details 03:55:18 INFO - PROCESS | 7113 | |i|pagename|runs| 03:55:18 INFO - PROCESS | 7113 | |0;ai-astar;108;115;105;108;111;112;101;110;112;111 03:55:18 INFO - PROCESS | 7113 | |1;audio-beat-detection;153;135;167;183;131;159;157;128;179;126 03:55:18 INFO - PROCESS | 7113 | |2;audio-dft;162;161;163;163;161;162;162;166;161;163 03:55:18 INFO - PROCESS | 7113 | |3;audio-fft;72;74;77;172;75;76;74;76;166;74 03:55:18 INFO - PROCESS | 7113 | |4;audio-oscillator;93;93;150;91;92;92;146;91;93;148 03:55:18 INFO - PROCESS | 7113 | |5;imaging-gaussian-blur;118;118;117;116;118;117;118;117;117;118 03:55:18 INFO - PROCESS | 7113 | |6;imaging-darkroom;147;147;149;146;146;146;147;147;147;147 03:55:18 INFO - PROCESS | 7113 | |7;imaging-desaturate;95;95;97;95;96;95;95;95;95;96 03:55:18 INFO - PROCESS | 7113 | |8;json-parse-financial;54;60;62;56;58;56;58;77;60;56 03:55:18 INFO - PROCESS | 7113 | |9;json-stringify-tinderbox;58;58;57;58;58;59;57;59;57;58 03:55:18 INFO - PROCESS | 7113 | |10;stanford-crypto-aes;72;81;73;73;74;73;73;76;74;76 03:55:18 INFO - PROCESS | 7113 | |11;stanford-crypto-ccm;117;115;119;117;117;113;116;114;134;125 03:55:18 INFO - PROCESS | 7113 | |12;stanford-crypto-pbkdf2;163;160;161;167;168;158;160;160;163;158 03:55:18 INFO - PROCESS | 7113 | |13;stanford-crypto-sha256-iterative;68;69;69;68;67;66;67;68;69;66 03:55:18 INFO - PROCESS | 7113 | __end_tp_report 03:55:18 INFO - PROCESS | 7113 | __start_cc_report 03:55:18 INFO - PROCESS | 7113 | _x_x_mozilla_cycle_collect,827 03:55:18 INFO - PROCESS | 7113 | __end_cc_report 03:55:18 INFO - PROCESS | 7113 | __startTimestamp1462877718421__endTimestamp 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | ------- Summary: start ------- 03:55:18 INFO - PROCESS | 7113 | Number of tests: 14 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:4.00 (3.6%) stddev-sans-first:4.22 03:55:18 INFO - PROCESS | 7113 | Values: 108.0 115.0 105.0 108.0 111.0 112.0 101.0 110.0 112.0 111.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.00 stddev:21.01 (13.3%) stddev-sans-first:22.28 03:55:18 INFO - PROCESS | 7113 | Values: 153.0 135.0 167.0 183.0 131.0 159.0 157.0 128.0 179.0 126.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 03:55:18 INFO - PROCESS | 7113 | Values: 162.0 161.0 163.0 163.0 161.0 162.0 162.0 166.0 161.0 163.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#3] audio-fft Cycles:10 Average:93.60 Median:74.50 stddev:39.79 (53.4%) stddev-sans-first:41.43 03:55:18 INFO - PROCESS | 7113 | Values: 72.0 74.0 77.0 172.0 75.0 76.0 74.0 76.0 166.0 74.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:27.01 (29.4%) stddev-sans-first:28.03 03:55:18 INFO - PROCESS | 7113 | Values: 93.0 93.0 150.0 91.0 92.0 92.0 146.0 91.0 93.0 148.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:55:18 INFO - PROCESS | 7113 | Values: 118.0 118.0 117.0 116.0 118.0 117.0 118.0 117.0 117.0 118.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:55:18 INFO - PROCESS | 7113 | Values: 147.0 147.0 149.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:55:18 INFO - PROCESS | 7113 | Values: 95.0 95.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:6.53 (11.1%) stddev-sans-first:6.60 03:55:18 INFO - PROCESS | 7113 | Values: 54.0 60.0 62.0 56.0 58.0 56.0 58.0 77.0 60.0 56.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 03:55:18 INFO - PROCESS | 7113 | Values: 58.0 58.0 57.0 58.0 58.0 59.0 57.0 59.0 57.0 58.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.64 (3.6%) stddev-sans-first:2.64 03:55:18 INFO - PROCESS | 7113 | Values: 72.0 81.0 73.0 73.0 74.0 73.0 73.0 76.0 74.0 76.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:117.00 stddev:6.31 (5.4%) stddev-sans-first:6.66 03:55:18 INFO - PROCESS | 7113 | Values: 117.0 115.0 119.0 117.0 117.0 113.0 116.0 114.0 134.0 125.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:3.46 (2.1%) stddev-sans-first:3.64 03:55:18 INFO - PROCESS | 7113 | Values: 163.0 160.0 161.0 167.0 168.0 158.0 160.0 160.0 163.0 158.0 03:55:18 INFO - PROCESS | 7113 | 03:55:18 INFO - PROCESS | 7113 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 03:55:18 INFO - PROCESS | 7113 | Values: 68.0 69.0 69.0 68.0 67.0 66.0 67.0 68.0 69.0 66.0 03:55:18 INFO - PROCESS | 7113 | -------- Summary: end -------- 03:55:18 INFO - PROCESS | 7113 | 03:55:19 INFO - TEST-INFO | 7113: exit 0 03:55:19 INFO - TEST-OK | kraken | took 60598ms 03:55:19 INFO - SUITE-END | took 1169s 03:55:19 INFO - Completed test suite (00:19:29) 03:55:19 INFO - javascript benchmark 03:55:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3358.848851801669, 3385.77992430492, 3396.575428071491, 3413.5391722117524, 3413.948790768139, 5510.283663123793, 5531.529819965308, 5555.3611334696525, 5562.471565201309, 5568.832935011951, 5536.4186760390085, 5559.8888022239535, 5566.109422492402, 5592.916106258409, 5612.831615051545, 5090.236464530313, 5110.233464980255, 5129.230615407681, 5135.666181698196, 5179.559737422323, 5114.539691427771, 5227.973860130713, 5234.450382709799, 5259.368875734917, 5268.262443257947, 5121.846344609649, 5126.128558145106, 5143.0, 5176.58587313016, 5270.578353731711, 5101.668391554537, 5127.384713834326, 5144.61415393847, 5151.562117220041, 5152.557283960497, 5074.746262686851, 5100.056489549445, 5127.384713834326, 5152.536271735562, 5176.456472070416, 5236.266922630834, 5367.946320536784, 5390.272313237702, 5470.699111548864, 5571.025070612626, 5977.5815692901515, 5987.161797348374, 5992.0712289595185, 5996.640201587918, 6003.039513677791, 6044.486218671418, 6056.182415373913, 6065.181200537915, 6071.241094863142, 6081.543884208702, 5412.052890744104, 5499.615026948115, 5532.197831314477, 5590.580706447033, 5696.829095127111, 6067.029275315928, 6078.726457309432, 6079.574429789961, 6083.8174854754425, 6084.239470066242, 5791.189233507313, 5820.767169313265, 5838.007538718428, 5846.503047241032, 5851.824445266649, 5993.580449368589, 6031.909521357183, 6037.45662890342, 6039.365866583946, 6090.725917333642, 5996.13056106862, 6097.420745029215, 6098.969505152446, 6108.5418593605655, 6109.602875813058, 5904.61619994699, 5957.880842383128, 6077.9392206078255, 6103.664298463538, 6106.969465152646, 4555.2483840166005, 4564.7717614119165, 4570.611498022638, 4580.587747102777, 4580.656450766206, 4088.100617864065, 4092.8567500137947, 4107.794610269534, 4126.834926602963, 4128.6284234418445, 5803.187553742479, 5826.737796799154, 5852.678102704393, 5860.120981852756, 5864.70676466175, 5884.235049443545, 5949.553783466257, 5980.461758441761, 6015.4586087252355, 6066.878662426727, 5693.914591281134, 5748.913766293509, 5750.2237197978575, 5761.711914404263, 5767.653940763484, 5085.160948443539, 5113.0, 5149.716765577929, 5153.3300670913295, 5221.399539053057, 6252.624842509373, 6270.31026587075, 6276.686165691697, 6285.465735412541, 6318.652474113968, 6013.7895173669585, 6070.0591408331775, 6072.574919755575, 6074.848128796815, 6080.300765412034, 6096.847578810565, 6218.160548326099, 6265.373462653698, 6315.115883776367, 6326.588771729823, 5939.316978547349, 5945.752465797126, 5954.285485741739, 5956.463918247206, 5971.880562388815, 5840.474357307863, 6033.245844269466, 6042.244719410074, 6046.425589568984, 6051.515878729779, 5925.496332811759, 5971.581989260884, 6006.309274433496, 6014.1580178775885, 6044.24446944132, 5923.111533269872, 5925.674087925206, 5928.8814223716145, 5929.703514824155, 5933.199018132497, 5594.356648985418, 5726.284214473191, 5818.883622327615, 5829.94170058294, 5839.0, 5895.616784908967, 5913.408659134052, 5934.109883517507, 5987.131865879336, 5989.5507836913275, 5748.827535173951, 5806.44838740319, 5819.185314056121, 5829.6793676346515, 5830.183774271521], "value": 5557.126533630356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.5347216323839, 665.1054331923561, 668.836135146889, 676.293273529162, 679.4632240529982, 39779.60220397795, 40616.172272247706, 40698.79650601747, 40931.59068409315, 41098.38352424709, 43458.0, 43745.343819842645, 44072.338914916305, 44079.33880991788, 44121.33817992725, 8995.640174393033, 9174.128457796498, 9175.220106290973, 9188.494632795193, 9194.08059194082, 8896.644134234622, 8961.641534338618, 8990.190882820545, 9231.399959002676, 9235.769105772375, 9237.95381023094, 9278.489683067428, 9322.300827437935, 9334.53327333634, 9362.297827662953, 9188.954055229715, 9218.492982885939, 9232.953835230814, 9241.306901982345, 9287.396319239228, 9134.543272836332, 9256.814863702688, 9286.349955503118, 9293.67472138472, 9365.76585585359, 42804.0, 43165.784171079256, 43425.56574434247, 43449.56550434487, 43698.0, 3962.722609417342, 4063.0654949361515, 4240.957590424087, 4264.573542645741, 4500.977495112504, 32893.17767055819, 33135.0, 33328.0, 33351.49972750411, 33957.6604233957, 4405.735655860626, 4519.07358991406, 4591.747453890035, 4595.908081838378, 4650.697704649221, 237179.0, 238275.0, 238934.0, 239447.0, 239871.0, 38076.0, 55908.720456398274, 57553.0, 57557.0, 57558.424415755304, 38305.0, 38313.616863831005, 38385.0, 38442.615573844465, 38503.807480962416, 16702.749458758128, 16862.578435538966, 16906.40827571029, 16955.406560770312, 16955.49133525996, 14663.046901951553, 14752.926235368968, 14800.407983680532, 14804.92597537027, 14864.70270594582, 9190.207909457591, 9231.907680923105, 9279.211267042241, 9480.33637645372, 9483.525823708787, 3612.223371975038, 3678.6873115784924, 3693.132113953219, 3739.1586892948867, 3762.379207430798, 1143.114086582905, 1143.2168964259508, 1163.8428812110426, 1165.6328256599145, 1177.3701069927547, 33024.1743956403, 33113.50329745056, 33115.83442082774, 33660.663393366245, 33665.663343366745, 1105.7567335186245, 1198.370855300974, 1238.108561835477, 1255.4727014653868, 1312.4487715159655, 14855.5543333698, 14968.70062598742, 15190.848091518943, 15574.766378504104, 15662.216889155497, 476253.0, 566515.0, 573833.0, 579753.0, 584888.0, 62581.0, 63333.0, 63426.0, 63750.0, 63891.36108638947, 1582.9287682054335, 1583.5566041508166, 1585.3975489314219, 1592.2277695317762, 1649.307290937809, 32180.0, 33008.50487242645, 33245.83377083099, 33851.15372115717, 33878.322433551686, 53419.0, 53905.0, 53962.73018634882, 53998.460015399345, 54322.7283863594, 428947.0, 431030.0, 431080.0, 431133.0, 431509.0, 30385.08844734573, 30839.691603083684, 47420.2886956689, 48666.270005949234, 48794.512054879, 44235.11529769451, 45299.0, 46005.0, 46284.53715462802, 46643.533564665275, 38483.615163848, 38582.80708596439, 38655.42016869693, 38701.80649096736, 38957.2208555833, 31940.041798746075, 31967.36065278728, 32006.6799332013, 32322.83838580792, 32378.190545236557, 39438.605613943495, 39617.0, 40624.593754063266, 43161.0, 43583.0, 35935.82032089823, 36145.45781813222, 36238.4564231542, 36305.81847090748, 36546.451803222444, 27762.444751105268, 28617.427651446436, 28712.0, 28746.137615871558, 28784.424311513234], "value": 19516.501584469148, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.67630086682834, 425.877203766997, 428.8842012656585, 435.9825606975721, 441.9270820314648, 14623.0, 18366.540836479096, 19031.809681903178, 19125.99999999998, 19158.425247242605, 17979.37072202473, 19659.5085122872, 19669.803301966975, 19924.0, 19954.0, 5626.690532020737, 5666.54667626591, 5811.709414529278, 5845.970770146165, 5888.852778680524, 5667.121596152582, 5746.138079288098, 5767.221425107619, 5784.8843023139725, 5795.130730390454, 5542.722863856811, 5670.0927851543765, 5697.544196464273, 5729.398413166599, 5734.053881109612, 5589.077802162638, 5638.267025286707, 5653.8586535336535, 5656.604037717361, 5666.631668941526, 5072.467390923936, 5074.822381216677, 5079.111155547801, 5093.668911520739, 5329.920051199235, 12563.497460101586, 12644.810327845089, 12651.493940242379, 12660.430280637302, 12707.809382859265, 2489.9377515562073, 2501.6122501012374, 2562.2569454858067, 2576.3945472813875, 2591.093117408892, 9684.515774211332, 9700.0, 9750.561224744904, 9855.950720246425, 9933.90066099337, 1977.6539105656595, 2122.2678176029244, 2131.0, 2137.444264491228, 2139.6362618354915, 78422.6078869602, 81089.0, 82896.58551707263, 83184.58407707984, 83880.0, 11045.116390688725, 11137.888621113847, 11252.26860254081, 11691.824622630667, 12368.690782730504, 15294.0, 15395.692086158439, 15422.537323880302, 15432.92283538575, 15435.382584696486, 8258.752237432887, 8605.698800541952, 8784.429012114193, 8841.336899732545, 8936.24041956428, 8166.387520935954, 8254.463459875089, 8366.205210504992, 8864.8670269946, 8960.238379737664, 4836.733979631154, 4863.8540843774745, 4905.386826646669, 4927.7536123193695, 4935.7532123393685, 2076.3355726167783, 2132.3070002249333, 2143.132031527234, 2158.4388059104745, 2181.901814418355, 959.4866746290701, 1039.8284283093355, 1107.2360071550604, 1125.8536390269212, 1149.0, 18135.15399182718, 18256.817431825777, 18358.357457488924, 18859.24563017464, 18909.905450472936, 1076.4187338836941, 1087.8477013218155, 1109.4175557832202, 1142.8857114288671, 1148.9827652585218, 10718.142548596094, 10749.301295415773, 10855.348679079281, 10872.510737016853, 10977.95709407605, 519987.0, 525383.0, 526489.0, 536263.0, 539777.0, 84719.5764021176, 91588.54205728929, 93895.53052234695, 94705.0, 100656.0, 1152.4813833774836, 1162.7558212775243, 1171.039747407135, 1185.2651356159065, 1198.7962046452124, 17220.397286094925, 17350.39273625417, 17359.56601084983, 17484.47546573605, 17661.116944152996, 40543.3918491217, 40874.79562602168, 41515.0, 41914.0, 41946.37080443735, 60702.0, 60835.39164608297, 60858.0, 60921.69539152276, 61019.69490152521, 7884.526928384315, 8280.875786863322, 8471.27994120482, 8557.529335886586, 8580.699675511327, 12588.370581471074, 12825.102242843284, 12868.485260589472, 12951.676208094874, 13127.277999710108, 11122.277051991594, 11463.713407164887, 11501.82747258775, 11604.6518604442, 11921.165518413627, 11437.142214334124, 11502.252353596989, 11678.824817627572, 11697.415129243675, 12161.533962820553, 11752.58865939688, 12357.25856448616, 12518.186317889307, 12602.558910438458, 12710.87289127134, 7933.404994625542, 8254.215849494289, 8450.535220562928, 8454.281386082252, 8534.74395768128, 10312.48437578103, 11585.0, 11820.113491488344, 11880.465379058136, 12026.579069732867], "value": 9266.95884863954, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.676986217825, 1625.4717216904505, 1851.5648822526705, 1895.7251198576207, 1942.126043280524, 7720.382369410434, 8212.260896519312, 8596.914030859689, 8790.91209087909, 8792.69225577105, 8473.618687159078, 8556.229939305462, 8556.828863422743, 8623.827523449527, 8624.95687521563, 2372.240882917463, 2390.8924098415614, 2394.8682822444844, 2395.161693407302, 2398.028798336668, 2388.5700573896693, 2411.987940060297, 2440.890159942807, 2440.987795061022, 2444.9022039118413, 2420.6127019676856, 2444.0, 2466.9259922202364, 2483.801295896324, 2505.3110394641526, 2427.2354208424376, 2445.400876785181, 2451.852888826676, 2451.9754802452017, 2490.10356271742, 2364.846284991487, 2408.397900524869, 2412.6260429633435, 2414.9517009659885, 2427.1990243219693, 8784.78038049054, 8890.06654301302, 8890.155435233642, 8895.377323587352, 8935.687250946186, 5393.946060539383, 5463.836084917459, 5508.64193827404, 5524.116141417394, 5548.4174161713245, 3431.9485207721905, 3460.1176699941607, 3522.5244591980013, 3538.2569660371096, 3541.6458354164633, 1134.9659510214706, 1175.294823106138, 1180.698921774942, 1201.3212534917743, 1208.7763763703656, 12482.188657737308, 12518.499260029588, 12551.874481255161, 12554.0, 12559.372031398394, 4633.9536604634195, 4675.205215113371, 4725.125851717443, 4756.738379389167, 4772.236442169236, 10620.0, 10671.146308295318, 10678.466076696133, 10682.465876706134, 10690.465476726133, 5420.945790542123, 5467.835964921059, 5475.6440831345835, 5477.233187353773, 5507.201455788888, 4358.978205108954, 4805.639577031737, 4901.50984901507, 4906.55840974314, 5014.924776128361, 4128.752274863457, 4184.225918205142, 4218.430511880918, 4233.280342341809, 4242.703010789277, 1281.4169552853616, 1293.8318018657515, 1305.0733978875105, 1305.2690493323769, 1305.614843621134, 906.8322360363354, 977.2133432586694, 978.4814048554277, 1000.2645410213274, 1014.4471263161595, 5515.283013208337, 5641.351244606841, 5755.452834778992, 5807.361190269067, 5833.708314584339, 463.1801710971561, 467.7544289248172, 468.6906641616517, 475.57198521331077, 480.8485327122015, 4048.4534587830854, 4072.2873497137884, 4091.9181616367505, 4099.118689481776, 4107.8973025674, 10640.733981650521, 10919.290246133976, 10988.175886808362, 11083.556657733761, 11106.278091924, 10831.24181307301, 10889.183311251687, 10936.671899843017, 10952.780944381228, 10965.56137754481, 8412.411131220879, 8415.200555947175, 8438.282745966662, 8509.489430634181, 8522.616482258314, 5244.187150991603, 5375.4087050425205, 5441.329593519477, 5451.536619387396, 5506.889862202814, 9471.28965327617, 9497.097775711296, 9730.17293530058, 9848.261380396356, 9852.359596626196, 9818.361806482555, 9973.002699729968, 10012.299139060196, 10022.298439109192, 10130.08829205375, 6969.512134150561, 7445.851082978418, 7637.770866874002, 7813.492123011986, 8027.959860200662, 8172.754817355489, 8191.058028326819, 8211.917880821355, 8275.917240827515, 8319.792005199919, 7130.964345178241, 7566.016417865642, 7623.504472209289, 7654.69381224767, 7796.688132474637, 7584.582847943416, 7595.620218988918, 7670.463067585216, 7715.189905060112, 7731.961340193263, 7007.159140903124, 7023.508354415347, 7043.049188359506, 7097.467689923174, 7104.431645468247, 5297.655652382583, 5327.493888080626, 5418.241446197457, 5483.424240454695, 5510.6969116698965, 5215.16557350822, 5265.629527492249, 5435.891282174255, 5482.506574408322, 5512.779488820403], "value": 4617.214196681833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.09026185110594, 327.5528903047341, 336.7558520072947, 337.47859556984463, 338.95085212644153, 6477.190351206099, 6582.637954912478, 6635.535512514126, 6648.26869044406, 6767.0, 6604.141461609996, 6625.536212465129, 6718.664066796665, 6738.663066846662, 6746.696398662059, 5047.873803154923, 5054.9494505054845, 5063.088644044089, 5063.518965698253, 5064.113780088488, 5053.949460505385, 5059.6458247922665, 5063.569596584295, 5065.113605119108, 5067.670601410897, 4999.475055119215, 5008.974955125219, 5010.599152067844, 5011.974940125294, 5017.473165317626, 4755.857324280277, 4881.1213981483315, 5001.699898006132, 5011.523905228997, 5017.297578339054, 4205.66354691627, 4212.073343864345, 4212.4523811904255, 4220.050488640062, 4232.343986682069, 6448.419642232222, 6449.226092868839, 6453.419192272671, 6459.321771214002, 6468.967655161694, 5713.885722285572, 5726.169705392736, 5735.885282294373, 5742.569307301969, 5743.16724075011, 6964.0598519200275, 6989.405900498464, 7048.612326322051, 7063.92936070643, 7068.222495525488, 4480.619147372445, 4613.63090952723, 4659.720416775004, 4664.230401983668, 4671.929921051187, 7322.377597904185, 7336.706531738778, 7400.555966642019, 7412.703491860265, 7425.294597013275, 4747.121782470254, 4759.643026773006, 4760.500147484534, 4761.619070474354, 4772.260299653559, 4813.566778989908, 4820.71075735457, 4822.300766388854, 4825.324454576362, 4828.975855120702, 5707.971460142756, 5710.600257981901, 5711.086226203787, 5716.256886604715, 5722.7710891563875, 6988.231294557595, 7132.679029443688, 7139.357457828821, 7140.0, 7148.28517148281, 1677.6057626457773, 1686.6795308891271, 1697.3634886917405, 1698.9065601391794, 1700.9149542522825, 1010.8281592129356, 1057.6404022632341, 1059.89930956559, 1073.7476692977143, 1077.9946100269449, 6819.897701534481, 6954.65226738661, 6988.895166572505, 7013.684384202723, 7019.0, 7392.186859445456, 7406.703731850774, 7412.740554080581, 7425.7029718810645, 7428.368588669916, 6924.584524928419, 6972.1284839395075, 6974.721011159497, 6988.37104660583, 6989.161300643956, 3888.2417928504237, 3959.8416063357718, 3991.201759648082, 3992.401139829049, 4001.8799436016966, 7648.317370178552, 7657.272559106876, 7665.348445382205, 7671.884921726179, 7672.5012874163, 7468.066491688539, 7494.962525187339, 7498.212687667826, 7527.2849079337375, 7533.962330188424, 7714.691412343555, 7727.459077864608, 7733.690652373954, 7734.4585878989055, 7749.4575379724, 7143.178534468602, 7334.559926404219, 7364.889526656997, 7398.741044063432, 7410.888836667562, 7254.347108760237, 7277.708891644275, 7306.525075870051, 7309.597972111585, 7341.4126869849215, 7733.922660773545, 7746.49647772893, 7747.72882949094, 7759.534427934342, 7760.262775036363, 4726.220173671306, 4764.6664733469715, 4767.618590512681, 4767.952320476889, 4770.689905156154, 7150.10623672041, 7330.706771729071, 7387.556746595222, 7389.556626602421, 7435.405167586472, 7185.748498802517, 7236.493445458978, 7237.8914316284245, 7246.094238220223, 7249.492535522674, 7188.820279492846, 7195.820104497429, 7197.388222000979, 7203.135623725187, 7209.134903811576, 7026.508144429841, 7050.189228238818, 7057.153141623038, 7060.329268719669, 7064.611446370499, 6991.3008699131715, 7187.712491500281, 7228.710851565878, 7250.166230883516, 7255.963720181577, 6852.862942741217, 6986.336298051677, 7036.788896333118, 7073.328033836778, 7104.183018952886], "value": 5272.917981944328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.9075001749807, 865.9567021648916, 935.4434111703536, 947.6825263536715, 953.4565297780264, 14902.92548537257, 15137.940344175911, 15159.090454572734, 15166.317515711791, 15184.696306073873, 12851.935740321309, 12979.091463597528, 13048.0, 13050.477980880778, 13066.934665326684, 892.8660700894885, 904.8009437923646, 911.0161026091838, 911.1480765484293, 911.7447114807865, 888.5290795878162, 892.8794612727264, 894.1728900766798, 896.1979028769248, 906.2976193450063, 934.8550974598948, 935.7847695030113, 939.3143005605912, 945.6264775413707, 955.7467271173144, 937.4703292639671, 941.0213378086781, 941.6421759731327, 943.0663642993455, 952.7999120184735, 703.6868593475905, 706.4842664854633, 708.0158579574396, 711.01524388722, 714.5355518912696, 15488.612784680361, 15573.143477108755, 15626.921865390714, 15654.530364089096, 15840.683186336324, 14601.415943362254, 14620.926895365561, 14731.337089830984, 14779.0, 14860.182689952047, 12396.256224626552, 12424.503019879194, 12561.120721549496, 12651.0, 12666.936665316707, 4021.97989010056, 4037.4347591337237, 4064.1871625674985, 4079.63283304504, 4086.7956602169775, 58484.70757646227, 58681.70659146677, 59780.0, 60920.08619870705, 61486.69256653733, 11008.284461509977, 11130.944345278383, 11165.888341116648, 11259.042981346514, 11307.717307067389, 19066.0, 19123.521911952314, 19307.324243651405, 19323.51691207731, 19348.32280870163, 8628.78428039304, 8783.824323513494, 8808.03111657717, 8850.0, 8879.422837515542, 5095.31213286209, 5138.691678499302, 5145.099607568661, 5160.993606246746, 5169.922451163236, 3677.5403074615674, 3746.4754934309217, 3754.2679177560112, 3807.1053302473897, 3809.657130858236, 717.9856402871914, 725.1044959475045, 726.8437285983433, 729.9270072992658, 736.8784150615196, 744.3747252308087, 763.2253262938123, 771.6488997506121, 784.2823816208106, 789.577575996839, 9480.810383792423, 9731.41611503312, 10180.786388318584, 10200.489975501196, 10775.676729698122, 840.3025488844245, 852.1733918099434, 859.4671303791689, 861.67687117331, 870.7997160653085, 4444.2000439920475, 4882.36529251195, 4884.8290309838985, 4893.755312234445, 4904.60763138948, 67308.66345668338, 69274.65362673154, 69282.65358673174, 69316.0, 69416.0, 56161.71919140378, 56393.0, 58073.0, 58708.11937820936, 59298.0, 53424.465755342724, 53428.0, 54255.18617220824, 54281.0, 54600.180997285075, 9791.26565507604, 9960.402375857471, 10099.798004040025, 10118.291719579853, 10242.385456872611, 40879.38680919729, 41459.585404145575, 41514.58485415107, 41589.16821663489, 41940.370894436, 47839.282410764565, 48094.75952620214, 53736.0, 54338.45661543334, 54879.725601371734, 11782.11634127461, 11809.409529523662, 11831.76336473283, 11926.045916326499, 12018.699532511757, 14090.436382544583, 14139.858601413855, 14361.784573231202, 14455.49405770835, 14587.927060364631, 13339.599812005656, 13366.866331336561, 13520.0, 13835.169889806644, 13901.791473128114, 13169.604911852659, 13317.067805253539, 13593.252371119288, 13707.931460342634, 13735.759462101538, 13039.0, 13169.802452963404, 13610.59168224955, 13729.656758581115, 14057.0, 11508.88491115078, 11566.768664626492, 11578.536858525564, 11795.233309834834, 11809.173357864867, 11707.121965852424, 11765.11761617865, 11854.0, 12104.455299511366, 12204.816927745913], "value": 7343.5455862235785, "unit": "score"}], "name": "dromaeo_css", "value": 7512.083010676467, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 105.0, 108.0, 111.0, 112.0, 101.0, 110.0, 112.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 135.0, 167.0, 183.0, 131.0, 159.0, 157.0, 128.0, 179.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 163.0, 161.0, 162.0, 162.0, 166.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 77.0, 172.0, 75.0, 76.0, 74.0, 76.0, 166.0, 74.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 91.0, 92.0, 92.0, 146.0, 91.0, 93.0, 148.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 62.0, 56.0, 58.0, 56.0, 58.0, 77.0, 60.0, 56.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 59.0, 57.0, 59.0, 57.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 73.0, 73.0, 74.0, 73.0, 73.0, 76.0, 74.0, 76.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 119.0, 117.0, 117.0, 113.0, 116.0, 114.0, 134.0, 125.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 167.0, 168.0, 158.0, 160.0, 160.0, 163.0, 158.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 67.0, 66.0, 67.0, 68.0, 69.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1526.0, "alertThreshold": 2.0}]} 03:55:19 INFO - Return code: 0 03:55:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:55:19 ERROR - # TBPL SUCCESS # 03:55:19 INFO - Running post-action listener: _resource_record_post_action 03:55:19 INFO - Running post-run listener: _resource_record_post_run 03:55:20 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 499433472; Read time: 8; Write time: 373612 03:55:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248651776; Read time: 0; Write time: 211496 03:55:20 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250781696; Read time: 8; Write time: 162116 03:55:20 INFO - Running post-run listener: _upload_blobber_files 03:55:20 INFO - Blob upload gear active. 03:55:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:21 INFO - (blobuploader) - INFO - Done attempting. 03:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:22 INFO - (blobuploader) - INFO - Done attempting. 03:55:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:22 INFO - Return code: 0 03:55:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29a25d23fe1cf08540460ccc261a5de89654e159b3bdbffe2bd83f9c87d144737909d6ef7cb1561a301bcaacd41eb9ae6d9a0687e5f2fcb87982e10d7d2178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02758266851b7ca502a48f81c63ba4201548ef29e0eb7c961de2e0fde21c7ca4e2bdd958b5928c2674242a43d1e92257a6479f67a8d4110f51778767c520d023"} 03:55:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:22 INFO - Contents: 03:55:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d29a25d23fe1cf08540460ccc261a5de89654e159b3bdbffe2bd83f9c87d144737909d6ef7cb1561a301bcaacd41eb9ae6d9a0687e5f2fcb87982e10d7d2178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02758266851b7ca502a48f81c63ba4201548ef29e0eb7c961de2e0fde21c7ca4e2bdd958b5928c2674242a43d1e92257a6479f67a8d4110f51778767c520d023"} 03:55:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:22 INFO - Copying logs to upload dir... 03:55:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.247313 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-10 03:55:21.489957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:55:21.493909) ========= 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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 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/d29a25d23fe1cf08540460ccc261a5de89654e159b3bdbffe2bd83f9c87d144737909d6ef7cb1561a301bcaacd41eb9ae6d9a0687e5f2fcb87982e10d7d2178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02758266851b7ca502a48f81c63ba4201548ef29e0eb7c961de2e0fde21c7ca4e2bdd958b5928c2674242a43d1e92257a6479f67a8d4110f51778767c520d023"} build_url:https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/MksZPTWYT7yyLHab8nqPjw/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/d29a25d23fe1cf08540460ccc261a5de89654e159b3bdbffe2bd83f9c87d144737909d6ef7cb1561a301bcaacd41eb9ae6d9a0687e5f2fcb87982e10d7d2178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02758266851b7ca502a48f81c63ba4201548ef29e0eb7c961de2e0fde21c7ca4e2bdd958b5928c2674242a43d1e92257a6479f67a8d4110f51778767c520d023"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:55:21.518403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:55:21.518752) ========= 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=ed14279e38b05397cf4aa391000001a4-1462876497.46199-1677101864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:55:21.601439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:55:21.601779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:55:21.602087) ========= ========= Total master_lag: 0.16 =========