builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1464059014.29 results: success (0) buildid: 20160523170350 builduid: 1c7caa8606bd45b590752adeac87ea70 revision: a2baee5a734efd4bb9646e5ad06d7552d6618bcb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.295367) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.296113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.296584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.313947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.314338) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 20:03:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-23 20:03:34 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.457568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.457885) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019280 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.507541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:34.507900) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2baee5a734efd4bb9646e5ad06d7552d6618bcb --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 a2baee5a734efd4bb9646e5ad06d7552d6618bcb --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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 20:03:34,596 truncating revision to first 12 chars 2016-05-23 20:03:34,596 Setting DEBUG logging. 2016-05-23 20:03:34,596 attempt 1/10 2016-05-23 20:03:34,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a2baee5a734e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 20:03:34,849 unpacking tar archive at: mozilla-aurora-a2baee5a734e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:35.063650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:35.064011) ========= script_repo_revision: a2baee5a734efd4bb9646e5ad06d7552d6618bcb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:35.064555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:35.064837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:03:35.075043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-23 20:03:35.075513) ========= /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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:03:35 INFO - MultiFileLogger online at 20160523 20:03:35 in /builds/slave/test 20:03:35 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 20:03:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:35 INFO - {'append_to_log': False, 20:03:35 INFO - 'base_work_dir': '/builds/slave/test', 20:03:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:03:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:35 INFO - 'branch': 'Mozilla-Aurora', 20:03:35 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:35 INFO - 'config_files': ('talos/linux_config.py',), 20:03:35 INFO - 'default_actions': ('clobber', 20:03:35 INFO - 'read-buildbot-config', 20:03:35 INFO - 'download-and-extract', 20:03:35 INFO - 'populate-webroot', 20:03:35 INFO - 'create-virtualenv', 20:03:35 INFO - 'install', 20:03:35 INFO - 'run-tests'), 20:03:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:35 INFO - 'download_minidump_stackwalk': True, 20:03:35 INFO - 'download_symbols': 'ondemand', 20:03:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:35 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:35 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:35 INFO - 'installer_path': 'installer.exe', 20:03:35 INFO - 'log_level': 'info', 20:03:35 INFO - 'log_name': 'talos', 20:03:35 INFO - 'log_to_console': True, 20:03:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:03:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:03:35 INFO - 'opt_config_files': (), 20:03:35 INFO - 'pip_index': False, 20:03:35 INFO - 'sps_profile': False, 20:03:35 INFO - 'sps_profile_interval': 0, 20:03:35 INFO - 'suite': 'dromaeojs-e10s', 20:03:35 INFO - 'system_bits': '32', 20:03:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:35 INFO - 'title': 'talos-linux64-ix-060', 20:03:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:35 INFO - 'use_talos_json': True, 20:03:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:35 INFO - 'work_dir': 'build'} 20:03:35 INFO - ##### 20:03:35 INFO - ##### Running clobber step. 20:03:35 INFO - ##### 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: clobber 20:03:35 INFO - rmtree: /builds/slave/test/build 20:03:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - ##### 20:03:35 INFO - ##### Running read-buildbot-config step. 20:03:35 INFO - ##### 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: read_buildbot_config 20:03:35 INFO - Using buildbot properties: 20:03:35 INFO - { 20:03:35 INFO - "project": "", 20:03:35 INFO - "product": "firefox", 20:03:35 INFO - "script_repo_revision": "production", 20:03:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:03:35 INFO - "repository": "", 20:03:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:03:35 INFO - "buildid": "20160523170350", 20:03:35 INFO - "pgo_build": "True", 20:03:35 INFO - "basedir": "/builds/slave/test", 20:03:35 INFO - "buildnumber": 283, 20:03:35 INFO - "slavename": "talos-linux64-ix-060", 20:03:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:03:35 INFO - "platform": "ubuntu64_hw", 20:03:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:03:35 INFO - "branch": "mozilla-aurora", 20:03:35 INFO - "repo_path": "releases/mozilla-aurora", 20:03:35 INFO - "revision": "a2baee5a734efd4bb9646e5ad06d7552d6618bcb", 20:03:35 INFO - "stage_platform": "linux64-pgo", 20:03:35 INFO - "builduid": "1c7caa8606bd45b590752adeac87ea70", 20:03:35 INFO - "slavebuilddir": "test" 20:03:35 INFO - } 20:03:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 20:03:35 INFO - Running post-action listener: _resource_record_post_action 20:03:35 INFO - ##### 20:03:35 INFO - ##### Running download-and-extract step. 20:03:35 INFO - ##### 20:03:35 INFO - Running pre-action listener: _resource_record_pre_action 20:03:35 INFO - Running main action method: download_and_extract 20:03:35 INFO - mkdir: /builds/slave/test/build/tests 20:03:35 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')]} 20:03:35 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:36 INFO - Downloaded 1361 bytes. 20:03:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:03:36 INFO - Using the following test package requirements: 20:03:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:03:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:03:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:03:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'jsshell-linux-x86_64.zip'], 20:03:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:03:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:03:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:03:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:03:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:03:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:03:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:03:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:36 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:37 INFO - Downloaded 23813419 bytes. 20:03:37 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'] 20:03:37 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 20:03:38 INFO - Return code: 0 20:03:38 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 20:03:38 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')]} 20:03:38 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:39 INFO - Downloaded 23813419 bytes. 20:03:39 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'] 20:03:39 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 20:03:41 INFO - Return code: 0 20:03:41 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')]} 20:03:41 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:42 INFO - Downloaded 10840145 bytes. 20:03:42 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'] 20:03:42 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 20:03:42 INFO - Return code: 0 20:03:42 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')]} 20:03:42 INFO - https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dnqrQu9CSVyaeH1FugZp7A/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 20:03:43 INFO - Downloaded 62728879 bytes. 20:03:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:03:44 INFO - mkdir: /builds/slave/test/properties 20:03:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:44 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:44 INFO - Contents: 20:03:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:03:44 INFO - Running post-action listener: _resource_record_post_action 20:03:44 INFO - Running post-action listener: set_extra_try_arguments 20:03:44 INFO - ##### 20:03:44 INFO - ##### Running populate-webroot step. 20:03:44 INFO - ##### 20:03:44 INFO - Running pre-action listener: _resource_record_pre_action 20:03:44 INFO - Running main action method: populate_webroot 20:03:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:44 INFO - '--tppagecycles', 20:03:44 INFO - '7'], 20:03:44 INFO - 'tests': ['tsvgm']}}, 20:03:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['damp', 'tps']}, 20:03:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'tests': ['damp', 'tps']}, 20:03:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['dromaeo_dom']}, 20:03:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['a11yr', 20:03:44 INFO - 'ts_paint', 20:03:44 INFO - 'tpaint', 20:03:44 INFO - 'sessionrestore', 20:03:44 INFO - 'sessionrestore_no_auto_restore', 20:03:44 INFO - 'tabpaint']}, 20:03:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['tsvgx', 20:03:44 INFO - 'tsvgr_opacity', 20:03:44 INFO - 'tart', 20:03:44 INFO - 'tscrollx', 20:03:44 INFO - 'cart']}, 20:03:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:44 INFO - 'tsvgr_opacity', 20:03:44 INFO - 'tart', 20:03:44 INFO - 'tscrollx', 20:03:44 INFO - 'cart']}, 20:03:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'talos_options': ['--disable-e10s'], 20:03:44 INFO - 'tests': ['tp5o']}, 20:03:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'tests': ['tp5o']}, 20:03:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'talos_options': ['--disable-e10s', 20:03:44 INFO - '--xperf_path', 20:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:44 INFO - 'tests': ['tp5n']}, 20:03:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:03:44 INFO - 'talos_options': ['--xperf_path', 20:03:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:44 INFO - 'tests': ['tp5n']}}, 20:03:44 INFO - 'talos.zip': {'path': '', 20:03:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:44 INFO - Running post-action listener: _resource_record_post_action 20:03:44 INFO - ##### 20:03:44 INFO - ##### Running create-virtualenv step. 20:03:44 INFO - ##### 20:03:44 INFO - Running pre-action listener: _resource_record_pre_action 20:03:44 INFO - Running main action method: create_virtualenv 20:03:44 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:44 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 20:03:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:45 INFO - Using real prefix '/usr' 20:03:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:45 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:47 INFO - Installing pip.................done. 20:03:47 INFO - Return code: 0 20:03:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:03:47 INFO - Using env: {'DISPLAY': ':0', 20:03:47 INFO - 'HOME': '/home/cltbld', 20:03:47 INFO - 'LANG': 'en_US.UTF-8', 20:03:47 INFO - 'LANGUAGE': 'en_US:en', 20:03:47 INFO - 'LOGNAME': 'cltbld', 20:03:47 INFO - 'MAIL': '/var/mail/cltbld', 20:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:47 INFO - 'MOZ_NO_REMOTE': '1', 20:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:47 INFO - 'NO_EM_RESTART': '1', 20:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:47 INFO - 'PWD': '/builds/slave/test', 20:03:47 INFO - 'SHELL': '/bin/bash', 20:03:47 INFO - 'SHLVL': '1', 20:03:47 INFO - 'TERM': 'linux', 20:03:47 INFO - 'TMOUT': '86400', 20:03:47 INFO - 'USER': 'cltbld', 20:03:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:47 INFO - '_': '/tools/buildbot/bin/python'} 20:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:47 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 20:03:47 INFO - Cleaning up... 20:03:47 INFO - Return code: 0 20:03:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:03:47 INFO - Using env: {'DISPLAY': ':0', 20:03:47 INFO - 'HOME': '/home/cltbld', 20:03:47 INFO - 'LANG': 'en_US.UTF-8', 20:03:47 INFO - 'LANGUAGE': 'en_US:en', 20:03:47 INFO - 'LOGNAME': 'cltbld', 20:03:47 INFO - 'MAIL': '/var/mail/cltbld', 20:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:47 INFO - 'MOZ_NO_REMOTE': '1', 20:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:47 INFO - 'NO_EM_RESTART': '1', 20:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:47 INFO - 'PWD': '/builds/slave/test', 20:03:47 INFO - 'SHELL': '/bin/bash', 20:03:47 INFO - 'SHLVL': '1', 20:03:47 INFO - 'TERM': 'linux', 20:03:47 INFO - 'TMOUT': '86400', 20:03:47 INFO - 'USER': 'cltbld', 20:03:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:47 INFO - '_': '/tools/buildbot/bin/python'} 20:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:48 INFO - Downloading/unpacking psutil>=0.7.1 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:48 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 20:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:50 INFO - Installing collected packages: psutil 20:03:50 INFO - Running setup.py install for psutil 20:03:50 INFO - building 'psutil._psutil_linux' extension 20:03:50 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 20:03:50 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 20:03:50 INFO - building 'psutil._psutil_posix' extension 20:03:50 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 20:03:51 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 20:03:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:51 INFO - Successfully installed psutil 20:03:51 INFO - Cleaning up... 20:03:51 INFO - Return code: 0 20:03:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:51 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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:03:51 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 20:03:51 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 20:03:51 INFO - Using env: {'DISPLAY': ':0', 20:03:51 INFO - 'HOME': '/home/cltbld', 20:03:51 INFO - 'LANG': 'en_US.UTF-8', 20:03:51 INFO - 'LANGUAGE': 'en_US:en', 20:03:51 INFO - 'LOGNAME': 'cltbld', 20:03:51 INFO - 'MAIL': '/var/mail/cltbld', 20:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:51 INFO - 'MOZ_NO_REMOTE': '1', 20:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:51 INFO - 'NO_EM_RESTART': '1', 20:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:51 INFO - 'PWD': '/builds/slave/test', 20:03:51 INFO - 'SHELL': '/bin/bash', 20:03:51 INFO - 'SHLVL': '1', 20:03:51 INFO - 'TERM': 'linux', 20:03:51 INFO - 'TMOUT': '86400', 20:03:51 INFO - 'USER': 'cltbld', 20:03:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:51 INFO - '_': '/tools/buildbot/bin/python'} 20:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:03:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:03:53 INFO - Installing collected packages: mozsystemmonitor 20:03:53 INFO - Running setup.py install for mozsystemmonitor 20:03:53 INFO - Successfully installed mozsystemmonitor 20:03:53 INFO - Cleaning up... 20:03:53 INFO - Return code: 0 20:03:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03:53 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')]} 20:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:53 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')]} 20:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:53 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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:03:53 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 20:03:53 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 20:03:53 INFO - Using env: {'DISPLAY': ':0', 20:03:53 INFO - 'HOME': '/home/cltbld', 20:03:53 INFO - 'LANG': 'en_US.UTF-8', 20:03:53 INFO - 'LANGUAGE': 'en_US:en', 20:03:53 INFO - 'LOGNAME': 'cltbld', 20:03:53 INFO - 'MAIL': '/var/mail/cltbld', 20:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:53 INFO - 'MOZ_NO_REMOTE': '1', 20:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:53 INFO - 'NO_EM_RESTART': '1', 20:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:53 INFO - 'PWD': '/builds/slave/test', 20:03:53 INFO - 'SHELL': '/bin/bash', 20:03:53 INFO - 'SHLVL': '1', 20:03:53 INFO - 'TERM': 'linux', 20:03:53 INFO - 'TMOUT': '86400', 20:03:53 INFO - 'USER': 'cltbld', 20:03:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:53 INFO - '_': '/tools/buildbot/bin/python'} 20:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:53 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:53 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 20:03:55 INFO - Downloading blobuploader-1.2.4.tar.gz 20:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:56 INFO - Downloading docopt-0.6.1.tar.gz 20:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:03:56 INFO - Installing collected packages: blobuploader, requests, docopt 20:03:56 INFO - Running setup.py install for blobuploader 20:03:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:03:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:03:56 INFO - Running setup.py install for requests 20:03:56 INFO - Running setup.py install for docopt 20:03:56 INFO - Successfully installed blobuploader requests docopt 20:03:56 INFO - Cleaning up... 20:03:56 INFO - Return code: 0 20:03:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:03:56 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')]} 20:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 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')]} 20:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:56 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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:03:56 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 20:03:56 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 20:03:56 INFO - Using env: {'DISPLAY': ':0', 20:03:56 INFO - 'HOME': '/home/cltbld', 20:03:56 INFO - 'LANG': 'en_US.UTF-8', 20:03:56 INFO - 'LANGUAGE': 'en_US:en', 20:03:56 INFO - 'LOGNAME': 'cltbld', 20:03:56 INFO - 'MAIL': '/var/mail/cltbld', 20:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:56 INFO - 'MOZ_NO_REMOTE': '1', 20:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:03:56 INFO - 'NO_EM_RESTART': '1', 20:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:56 INFO - 'PWD': '/builds/slave/test', 20:03:56 INFO - 'SHELL': '/bin/bash', 20:03:56 INFO - 'SHLVL': '1', 20:03:56 INFO - 'TERM': 'linux', 20:03:56 INFO - 'TMOUT': '86400', 20:03:56 INFO - 'USER': 'cltbld', 20:03:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:56 INFO - '_': '/tools/buildbot/bin/python'} 20:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:03:57 INFO - Running setup.py (path:/tmp/pip-YSpUvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:03:57 INFO - Running setup.py (path:/tmp/pip-GBXXf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:03:57 INFO - Running setup.py (path:/tmp/pip-UWw2Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:03:57 INFO - Running setup.py (path:/tmp/pip-5fdeIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:03:57 INFO - Running setup.py (path:/tmp/pip-QDKZB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:03:57 INFO - Running setup.py (path:/tmp/pip-KY272y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:03:57 INFO - Running setup.py (path:/tmp/pip-BDWWSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:03:57 INFO - Running setup.py (path:/tmp/pip-Lje7By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:03:57 INFO - Running setup.py (path:/tmp/pip-fcTCNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:03:57 INFO - Running setup.py (path:/tmp/pip-ZS3fpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:03:57 INFO - Running setup.py (path:/tmp/pip-gkGvQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:03:57 INFO - Running setup.py (path:/tmp/pip-jBUfS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:03:57 INFO - Running setup.py (path:/tmp/pip-f7Oarb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:03:58 INFO - Running setup.py (path:/tmp/pip-QxiweR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:58 INFO - Running setup.py (path:/tmp/pip-_yeu3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:03:58 INFO - Running setup.py (path:/tmp/pip-Q93ZGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:03:58 INFO - Running setup.py (path:/tmp/pip-48cfms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:03:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:03:58 INFO - Running setup.py install for manifestparser 20:03:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozcrash 20:03:58 INFO - Running setup.py install for mozdebug 20:03:58 INFO - Running setup.py install for mozdevice 20:03:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozfile 20:03:58 INFO - Running setup.py install for mozhttpd 20:03:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:03:58 INFO - Running setup.py install for mozinfo 20:03:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozInstall 20:03:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozleak 20:03:59 INFO - Running setup.py install for mozlog 20:03:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for moznetwork 20:03:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozprocess 20:03:59 INFO - Running setup.py install for mozprofile 20:03:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozrunner 20:03:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:03:59 INFO - Running setup.py install for mozscreenshot 20:03:59 INFO - Running setup.py install for moztest 20:04:00 INFO - Running setup.py install for mozversion 20:04:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:00 INFO - Cleaning up... 20:04:00 INFO - Return code: 0 20:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:00 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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:04:00 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 20:04:00 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 20:04:00 INFO - Using env: {'DISPLAY': ':0', 20:04:00 INFO - 'HOME': '/home/cltbld', 20:04:00 INFO - 'LANG': 'en_US.UTF-8', 20:04:00 INFO - 'LANGUAGE': 'en_US:en', 20:04:00 INFO - 'LOGNAME': 'cltbld', 20:04:00 INFO - 'MAIL': '/var/mail/cltbld', 20:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:00 INFO - 'MOZ_NO_REMOTE': '1', 20:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:00 INFO - 'NO_EM_RESTART': '1', 20:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:00 INFO - 'PWD': '/builds/slave/test', 20:04:00 INFO - 'SHELL': '/bin/bash', 20:04:00 INFO - 'SHLVL': '1', 20:04:00 INFO - 'TERM': 'linux', 20:04:00 INFO - 'TMOUT': '86400', 20:04:00 INFO - 'USER': 'cltbld', 20:04:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:00 INFO - '_': '/tools/buildbot/bin/python'} 20:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:00 INFO - Running setup.py (path:/tmp/pip-EbopoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:00 INFO - Running setup.py (path:/tmp/pip-sBnQG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:00 INFO - Running setup.py (path:/tmp/pip-Xh6TuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:00 INFO - Running setup.py (path:/tmp/pip-eRvC5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:00 INFO - Running setup.py (path:/tmp/pip-GaSKlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:00 INFO - Running setup.py (path:/tmp/pip-0s6yLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:00 INFO - Running setup.py (path:/tmp/pip-8xIWLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:00 INFO - Running setup.py (path:/tmp/pip-hmlyKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:00 INFO - Running setup.py (path:/tmp/pip-9SJBG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:00 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)) 20:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:00 INFO - Running setup.py (path:/tmp/pip-zsCgOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:01 INFO - Running setup.py (path:/tmp/pip-ZChIVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:01 INFO - Running setup.py (path:/tmp/pip-tsxWkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:01 INFO - Running setup.py (path:/tmp/pip-VDQvzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:01 INFO - Running setup.py (path:/tmp/pip-BeQ6w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:01 INFO - Running setup.py (path:/tmp/pip-CQ83K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:01 INFO - Running setup.py (path:/tmp/pip-45j2h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:01 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)) 20:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:01 INFO - Running setup.py (path:/tmp/pip-06w3fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:01 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)) 20:04:01 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)) 20:04:01 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)) 20:04:01 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)) 20:04:01 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)) 20:04:01 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)) 20:04:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:01 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 20:04:03 INFO - Downloading blessings-1.6.tar.gz 20:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:03 INFO - Installing collected packages: blessings 20:04:03 INFO - Running setup.py install for blessings 20:04:03 INFO - Successfully installed blessings 20:04:03 INFO - Cleaning up... 20:04:03 INFO - Return code: 0 20:04:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:03 INFO - Reading from file tmpfile_stdout 20:04:03 INFO - Current package versions: 20:04:03 INFO - argparse == 1.2.1 20:04:03 INFO - blessings == 1.6 20:04:03 INFO - blobuploader == 1.2.4 20:04:03 INFO - docopt == 0.6.1 20:04:03 INFO - manifestparser == 1.1 20:04:03 INFO - mozInstall == 1.12 20:04:03 INFO - mozcrash == 0.17 20:04:03 INFO - mozdebug == 0.1 20:04:03 INFO - mozdevice == 0.48 20:04:03 INFO - mozfile == 1.2 20:04:03 INFO - mozhttpd == 0.7 20:04:03 INFO - mozinfo == 0.9 20:04:03 INFO - mozleak == 0.1 20:04:03 INFO - mozlog == 3.1 20:04:03 INFO - moznetwork == 0.27 20:04:03 INFO - mozprocess == 0.22 20:04:03 INFO - mozprofile == 0.28 20:04:03 INFO - mozrunner == 6.11 20:04:03 INFO - mozscreenshot == 0.1 20:04:03 INFO - mozsystemmonitor == 0.0 20:04:03 INFO - moztest == 0.7 20:04:03 INFO - mozversion == 1.4 20:04:03 INFO - psutil == 3.1.1 20:04:03 INFO - requests == 1.2.3 20:04:03 INFO - wsgiref == 0.1.2 20:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:03 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 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:04:03 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 20:04:03 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 20:04:03 INFO - Using env: {'DISPLAY': ':0', 20:04:03 INFO - 'HOME': '/home/cltbld', 20:04:03 INFO - 'LANG': 'en_US.UTF-8', 20:04:03 INFO - 'LANGUAGE': 'en_US:en', 20:04:03 INFO - 'LOGNAME': 'cltbld', 20:04:03 INFO - 'MAIL': '/var/mail/cltbld', 20:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:03 INFO - 'MOZ_NO_REMOTE': '1', 20:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:03 INFO - 'NO_EM_RESTART': '1', 20:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:03 INFO - 'PWD': '/builds/slave/test', 20:04:03 INFO - 'SHELL': '/bin/bash', 20:04:03 INFO - 'SHLVL': '1', 20:04:03 INFO - 'TERM': 'linux', 20:04:03 INFO - 'TMOUT': '86400', 20:04:03 INFO - 'USER': 'cltbld', 20:04:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:03 INFO - '_': '/tools/buildbot/bin/python'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 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)) 20:04:04 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:04:04 INFO - Using env: {'DISPLAY': ':0', 20:04:04 INFO - 'HOME': '/home/cltbld', 20:04:04 INFO - 'LANG': 'en_US.UTF-8', 20:04:04 INFO - 'LANGUAGE': 'en_US:en', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MAIL': '/var/mail/cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SHLVL': '1', 20:04:04 INFO - 'TERM': 'linux', 20:04:04 INFO - 'TMOUT': '86400', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - '_': '/tools/buildbot/bin/python'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 INFO - Downloading/unpacking jsonschema 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:06 INFO - Downloading/unpacking functools32 (from jsonschema) 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:06 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:06 INFO - warning: no files found matching '*.txt' 20:04:06 INFO - no previously-included directories found matching 'build' 20:04:06 INFO - no previously-included directories found matching 'dist' 20:04:06 INFO - no previously-included directories found matching '.git*' 20:04:06 INFO - Installing collected packages: jsonschema, functools32 20:04:06 INFO - Running setup.py install for functools32 20:04:06 INFO - warning: no files found matching '*.txt' 20:04:06 INFO - no previously-included directories found matching 'build' 20:04:06 INFO - no previously-included directories found matching 'dist' 20:04:06 INFO - no previously-included directories found matching '.git*' 20:04:06 INFO - Successfully installed jsonschema functools32 20:04:06 INFO - Cleaning up... 20:04:06 INFO - Return code: 0 20:04:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:04: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')]} 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04: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')]} 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7271307f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', '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 20:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:04:06 INFO - Using env: {'DISPLAY': ':0', 20:04:06 INFO - 'HOME': '/home/cltbld', 20:04:06 INFO - 'LANG': 'en_US.UTF-8', 20:04:06 INFO - 'LANGUAGE': 'en_US:en', 20:04:06 INFO - 'LOGNAME': 'cltbld', 20:04:06 INFO - 'MAIL': '/var/mail/cltbld', 20:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:06 INFO - 'MOZ_NO_REMOTE': '1', 20:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:06 INFO - 'NO_EM_RESTART': '1', 20:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:06 INFO - 'PWD': '/builds/slave/test', 20:04:06 INFO - 'SHELL': '/bin/bash', 20:04:06 INFO - 'SHLVL': '1', 20:04:06 INFO - 'TERM': 'linux', 20:04:06 INFO - 'TMOUT': '86400', 20:04:06 INFO - 'USER': 'cltbld', 20:04:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:06 INFO - '_': '/tools/buildbot/bin/python'} 20:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:06 INFO - Downloading/unpacking flake8 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:04:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:08 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 20:04:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:04:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:04:09 INFO - no previously-included directories found matching 'docs/_build' 20:04:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:04:09 INFO - Running setup.py install for pep8 20:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:04:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:04:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:04:09 INFO - no previously-included directories found matching 'docs/_build' 20:04:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:04:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:04:09 INFO - Cleaning up... 20:04:09 INFO - Return code: 0 20:04:09 INFO - Running post-action listener: _resource_record_post_action 20:04:09 INFO - Running post-action listener: _start_resource_monitoring 20:04:09 INFO - Starting resource monitoring. 20:04:09 INFO - ##### 20:04:09 INFO - ##### Running install step. 20:04:09 INFO - ##### 20:04:09 INFO - Running pre-action listener: _resource_record_pre_action 20:04:09 INFO - Running main action method: install 20:04:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:10 INFO - Reading from file tmpfile_stdout 20:04:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:10 INFO - Reading from file tmpfile_stdout 20:04:10 INFO - Output received: 20:04:10 INFO - Usage: mozinstall [options] installer 20:04:10 INFO - Options: 20:04:10 INFO - -h, --help show this help message and exit 20:04:10 INFO - -d DEST, --destination=DEST 20:04:10 INFO - Directory to install application into. [default: 20:04:10 INFO - "/builds/slave/test"] 20:04:10 INFO - --app=APP Application being installed. [default: firefox] 20:04:10 INFO - mkdir: /builds/slave/test/build/application 20:04:10 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'] 20:04:10 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 20:04:25 INFO - Reading from file tmpfile_stdout 20:04:25 INFO - Output received: 20:04:25 INFO - /builds/slave/test/build/application/firefox/firefox 20:04:25 INFO - Running post-action listener: _resource_record_post_action 20:04:25 INFO - ##### 20:04:25 INFO - ##### Running run-tests step. 20:04:25 INFO - ##### 20:04:25 INFO - Running pre-action listener: _resource_record_pre_action 20:04:25 INFO - Running main action method: run_tests 20:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:25 INFO - Python 2.7.3 20:04:25 INFO - Return code: 0 20:04:25 INFO - grabbing minidump binary from tooltool 20:04:25 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')]} 20:04:25 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 0x28dd410>, '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 0x28de310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28de7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:25 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 20:04:25 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 20:04:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:25 INFO - Return code: 0 20:04:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:04:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:04:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:04:26 INFO - Return code: 0 20:04:26 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/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:04:26 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/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:04:26 INFO - Using env: {'DISPLAY': ':0', 20:04:26 INFO - 'HOME': '/home/cltbld', 20:04:26 INFO - 'LANG': 'en_US.UTF-8', 20:04:26 INFO - 'LANGUAGE': 'en_US:en', 20:04:26 INFO - 'LOGNAME': 'cltbld', 20:04:26 INFO - 'MAIL': '/var/mail/cltbld', 20:04:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:26 INFO - 'MOZ_NO_REMOTE': '1', 20:04:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:04:26 INFO - 'NO_EM_RESTART': '1', 20:04:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:26 INFO - 'PWD': '/builds/slave/test', 20:04:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:26 INFO - 'SHELL': '/bin/bash', 20:04:26 INFO - 'SHLVL': '1', 20:04:26 INFO - 'TERM': 'linux', 20:04:26 INFO - 'TMOUT': '86400', 20:04:26 INFO - 'USER': 'cltbld', 20:04:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761', 20:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:26 INFO - '_': '/tools/buildbot/bin/python'} 20:04:26 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/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:04:26 INFO - mozversion application_buildid: 20160523170350 20:04:26 INFO - mozversion application_changeset: a2baee5a734efd4bb9646e5ad06d7552d6618bcb 20:04:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:04:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:26 INFO - mozversion application_name: Firefox 20:04:26 INFO - mozversion application_remotingname: firefox-dev 20:04:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:26 INFO - mozversion application_vendor: Mozilla 20:04:26 INFO - mozversion application_version: 48.0a2 20:04:26 INFO - mozversion platform_buildid: 20160523170350 20:04:26 INFO - mozversion platform_changeset: a2baee5a734efd4bb9646e5ad06d7552d6618bcb 20:04:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:26 INFO - mozversion platform_version: 48.0a2 20:04:26 INFO - using testdate: 1464059066 20:04:26 INFO - actual date: 1464059066 20:04:26 INFO - starting webserver on 'localhost:52938' 20:04:26 INFO - SUITE-START | Running 2 tests 20:04:26 INFO - TEST-START | dromaeo_css 20:04:26 INFO - operating with platform_type : linux_ 20:04:26 INFO - Initialising browser for dromaeo_css test... 20:04:26 INFO - TEST-INFO | started process 7394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_WxTa/profile http://localhost:52938/getInfo.html) 20:04:30 INFO - PROCESS | 7394 | 20:04:30 INFO - PROCESS | 7394 | (process:7472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:04:31 INFO - PROCESS | 7394 | __metrics Screen width/height:1600/1200 20:04:31 INFO - PROCESS | 7394 | colorDepth:24 20:04:31 INFO - PROCESS | 7394 | Browser inner width/height: 1024/697 20:04:31 INFO - PROCESS | 7394 | __metrics 20:04:32 ERROR - PROCESS | 7394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:04:32 INFO - TEST-INFO | 7394: exit 0 20:04:32 INFO - Browser initialized. 20:04:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:32 INFO - TEST-INFO | started process 7523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_WxTa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:34 INFO - PROCESS | 7523 | 20:04:34 INFO - PROCESS | 7523 | (process:7589): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:04:44 INFO - PROCESS | 7523 | RSS: Main: 151883776 20:04:44 INFO - PROCESS | 7523 | 20:05:34 INFO - PROCESS | 7523 | 1464059134346 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] 20:07:42 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52938/tests/dromaeo/cssquery-ext.html) 20:07:43 INFO - PROCESS | 7523 | RSS: Main: 155115520 20:07:43 INFO - PROCESS | 7523 | 20:10:45 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-ext.html (next: http://localhost:52938/tests/dromaeo/cssquery-jquery.html) 20:10:45 INFO - PROCESS | 7523 | RSS: Main: 153427968 20:10:45 INFO - PROCESS | 7523 | 20:13:47 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52938/tests/dromaeo/cssquery-mootools.html) 20:13:47 INFO - PROCESS | 7523 | RSS: Main: 153038848 20:13:47 INFO - PROCESS | 7523 | 20:16:49 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52938/tests/dromaeo/cssquery-prototype.html) 20:16:50 INFO - PROCESS | 7523 | RSS: Main: 152657920 20:16:50 INFO - PROCESS | 7523 | 20:19:52 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52938/tests/dromaeo/cssquery-yui.html) 20:19:53 INFO - PROCESS | 7523 | RSS: Main: 154374144 20:19:53 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:52938/tests/dromaeo/cssquery-yui.html (next: http://localhost:52938/tests/dromaeo/cssquery-dojo.html) 20:22:55 INFO - PROCESS | 7523 | RSS: Main: 155799552 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | __start_tp_report 20:22:55 INFO - PROCESS | 7523 | _x_x_mozilla_page_load 20:22:55 INFO - PROCESS | 7523 | _x_x_mozilla_page_load_details 20:22:55 INFO - PROCESS | 7523 | |i|pagename|runs| 20:22:55 INFO - PROCESS | 7523 | |0;dojo.html;3314.585676790401;3367.2423704666444;3376.5948086229655;3391.287829555793;3422.007617790841;5531.1426728856995;5537.086380747177;5572.192032155345;5575.358833734122;5598.888022239558;5527.198556209357;5548.389677135512;5550.417206193352;5552.639078459907;5567.053600887849;5021.497850214968;5074.238864170386;5136.537711605954;5143.691378517282;5179.611529135311;5027.2207807789855;5106.361704786902;5144.819931302405;5196.142636464979;5226.425093239741;5124.103281925667;5136.460671629481;5151.201563757623;5152.845414637548;5191.766370513317;5145.511176438233;5156.845294641167;5162.612804039693;5164.173732202867;5199.558037566811;4920.926186107211;5044.949550504484;5058.2412638104215;5116.539511443988;5119.3088932994315;5390.434004429518;5451.427600101972;5461.563074953994;5481.506664400184;5513.862153446196;5955.970220148914;5970.313413957364;5997.730102145414;6005.3394126646035;6019.428154325332;5724.484796368347;5930.822075337746;6046.758129674808;6051.727672254759;6057.121717351003;5515.972420137914;5517.779288828482;5519;5530.419305972855;5559.8888022239735;5986.880262394815;5993.0710739835395;5993.310769261503;5996.070609055516;6001.549883758736;5769.682667453247;5778.8266352009505;5788.363280039192;5790.88418231633;5855.858107669049;5844.26946631671;5847.239858818326;5849.502792262705;5858.707064646751;5867.383924687846;5743.253377061039;5779.88440231193;5809.215755872988;5823.301203855564;5842.532597392198;5756.971215143897;5824.737886795105;5888.764449421975;5943.465088142088;5973.671448070311;4492.415985921809;4528.864134075983;4544.818207271672;4551.067031258584;4560.794764235618;4021.235965166609;4046.5346485154582;4061.573534778806;4067.3695577185586;4098.057446787196;5486.506214440639;5559.833205003856;5698.287714035746;5712.057510510802;5738.1679656450415;5928;5993.250843644544;6002.759889604455;6035.245594300713;6066.4540191382985;5699.943000570024;5725.141228815711;5726.570507211893;5738.426157384311;5748.367679555246;4881.243407271879;4957.405111386584;4997.150484417658;4999.075171093359;5027.824026159067;6127.4485296322655;6138.5396095292135;6141.84645383869;6145.600535965148;6150.846228844314;5811.070228763378;5938.940610593839;5939.316978547436;5941.0494320910175;5943.702814859326;6141.263048434216;6173.197484327188;6186.381361863778;6196.566240363131;6199.876002479835;5846.970765146147;5852.824415267549;5853.590248682552;5861.882762344814;5862.413758624103;5850.707464626837;5871.119332100219;5932.762689492372;5970.850728731816;5971.522278217819;5834.03738383162;5848.0350742127075;5849.356570777296;5851.970740146272;5890.1164825276555;5769.855753606025;5804.1293805929445;5812.3025236971835;5818.679972601548;5819.15622234782;5668.26312579362;5678.14827775837;5708.058170402003;5717.885642287048;5723.828285151452;5797.246357973437;5837.445442682938;5848.327442344185;5862.237909071793;5871.588988770916;5690.630109042899;5710.8001219957105;5713.657180569179;5714.399988001366;5714.914276285942 20:22:55 INFO - PROCESS | 7523 | |1;ext.html;631.1952260867394;645.6578013652766;650.3756393861893;662.9591541280189;688.7072993977558;37511.437328440064;38282.99999999996;38322.23355532888;38326;38359.61640383596;41493.37759933596;42414.15171696564;42538.36192457116;42542.57457425425;42573;8709.738707838758;8857.247133993618;8881.289496840269;8901.910980890172;8910.821783564325;8771.386002979794;8873.378863479558;8873.600687969058;8892.15524525169;8910.777230569223;9085.636574537011;9148.17666410023;9157.130072643089;9158.221551168159;9161.221296189831;8964.641414343387;8975.910240897572;9113.362064655477;9117.908820911773;9124.589393477243;8922.910770892338;8987.146221108984;8998.05520420353;9016.639334426614;9063;40643.390349144785;41051;41180.794096029626;41204;41206.79396603028;3672.320620685182;3825.08198032473;4025.376066709665;4125.773082480462;4412.84555040572;31634.36731265385;31738.841305793554;31916;32125.03624891257;32770.344593108246;4643.094596553673;4664.393628828265;4696.53034696531;4749.453812811536;4822.927656085161;310773;311078;311270;312336;313182.99999999773;38328.8083559586;38539.807300963315;38851.80574097111;38863.41704874429;55767.44232557622;36262.45606315907;36353.63646363556;36387.4541881872;36474.27051458956;36566.817165914;15704;15774.76337854933;15790.21048947571;15801.36794528229;15803.36786528526;14117.505887293895;14160.150390976574;14163.079399838978;14195.64510887236;14213.147211167363;9101.362904596615;9188.908110918805;9237.584308706124;9309.255259579217;9371.48456834867;3568.411212149966;3577.248777756648;3597.5862775780597;3614.1868079682386;3662.5238718966366;1083.3716444462193;1099.1097211258907;1099.1866019145934;1151.3034614058374;1176.4705882352805;31597.526037109463;31689.841550792098;32146;32809.835950820096;33152.50271245933;1135.602539111321;1149.6493569461227;1174.4656181437426;1178.4991378664033;1274.0699289518518;16893.493195204162;16935.91319100671;17069.829301707072;17184.484465466056;17244.224009919584;484126;590560;591983;594221;606958;54240;54411;54549.72725136349;55068;55103.173452398245;1467.8532146785235;1503.1732547099052;1528.8318284988643;1530.8851836112335;1607.541850572581;32182.517262240617;32355.514667279538;33114.17214569655;33497;34434;51553.742231288605;52134.739326303126;52196.73901630467;52603;52608.210876836114;472283;472556;473208;475171;478299;43987.78006109949;44080.77959610181;44666.3300050493;44819.55180448154;45042.32436513389;48531.75734121448;48798;49028;49341.2598811011;50133.49866501434;42425.78787106045;42647.147057058064;43102.137957240055;43160.35259471048;44172;41951.58048419477;42213.366799498646;42253.15493690047;42754.144917100864;43395;41812.3728144072;42556;42598.78700606477;42768.1446371077;43559;35849;36531.086722832144;37287.81356093202;37431.81284093671;37439.62560374361;28523.144305670863;29289.267768305963;29442;29751.851240744523;30028.549571756877 20:22:55 INFO - PROCESS | 7523 | |2;jquery.html;425.41505430033703;428.37457312323994;434.8434563557119;440.27354864473614;443.11377245508976;19529.804701952995;19829.801701982993;20068.59862802743;20309.289174878864;20454.386368408934;18848.9057554712;19459.902700486513;19690.803091969075;19732;19787.50531236716;5521.475459831329;5646.407127251641;5686.431356864322;5915.9704201478935;5917.289925208981;5827.125931110325;5862.794802181925;5869.031609784402;5869.1196320551835;5893.204417403638;5824.485633735217;5838.4453476919625;6452.451541618968;6638.17022872141;6669.899951500732;6558.147440832661;6581.078648989097;6595.802125936206;6620.139381880349;6636.93363066368;5752.741126649311;5844.590878638497;5936.079907614327;5952.58331916766;5964.493018093423;12965.805512917314;13264.137831041047;13375;19873;22944.31167064974;2448.5347783920997;2514.4719608882156;2600.9479810403686;2643.1145566235336;2969.9011365794577;9796.657117000943;9898;10054.9497252514;10163.390196588154;10317.896821031844;1876.934307299238;1932.2464238946823;1979.823706150374;2016.5664382157906;2028.6247044296704;60026.39973600252;72424;76222.61888690577;80443;82269.9999999994;11109.44452777358;11272.380019099028;11299.322040677585;11417.885821141848;11449.084073274285;15764.211789410483;15916.363345466052;15922.76115858263;16043.438479653156;16098.275577599035;8781.868271975925;8797.648094076294;8828.470291782514;8875.112488751203;8944.418612790148;8699.260562852101;8724.302055835646;8746.65013399457;8806.647734090564;8857.689980850639;4800.423949126127;4862.489438608965;4958.876028099255;4968.552830245223;5039.370078740158;1985.9900700496405;2005.3582853487037;2019.131773337479;2086.6869969504696;2096;1052.5737076484036;1053.3521884041413;1067.6156583629886;1100.158378840172;1126.214949305344;17666.911665441592;18031.311858916775;18298.268069277347;18662.720059199124;20117;1047.9738006549896;1052.7947050325113;1054.0460882900986;1074.9677509674723;1100.4057808783168;10105.949470252748;10612.681619551426;10713.78572428547;10782.67651970442;10813.922329518833;540366;545541;550928;555164;561550;93641.5317923406;97132;97694.02305976991;98146;98489;1097.6158344579333;1120.56298043763;1133.552246862501;1136.9431528423545;1141.7887690777234;16747.581310467336;16780.580485487473;16995;17021.234044468278;17056;38081;38799;39445.60554394419;40138.39792403058;42612;56758.71620641871;57633.711831440574;57764.4223557759;57842.7107864458;58141.4185858136;8376.748697539084;8553;8704.477731335886;8744.08187140341;8763.649454022023;9736.73648377456;12899.871001289866;13007.544735934196;13370.331483425984;13438.865611344152;11714.414279286171;11818.290902545874;11829.822552661544;11905.404729763304;12039;11477.253978491372;11778.293302401884;11812.70468238301;11846.881531184923;11871.584494542649;12051.51793928233;12078.27530348182;12193.085518585964;12223.511059557519;12377.566785162477;8758.167974042455;8797.824043519222;8864.42381245217;8891.422057566237;8910.86633700482;8967.10328967098;11493.942530287295;12086.214396064228;12198.63404097843;12212.511499539918 20:22:55 INFO - PROCESS | 7523 | |3;mootools.html;1389.1248513436533;1414.639266986918;1561.4925149326473;1849.2048419179748;1875.465492334685;7598.658060387282;8219.260266576008;8266.4626799258;8494.362922780785;8495.447795893271;8217.794555136124;8223.259906608404;8233.094359620436;8326.375521835856;8340.582970851448;2316.9652455213145;2327.767223277676;2346.0146738369926;2350.3419042667997;2351.012574718614;2244.012634440841;2262.1403866530777;2263.0721404224273;2275.1695631094613;2280.1677387753434;2367.4673198530277;2388.3790214544256;2399;2403.879806009701;2404.302752201859;2364.1370899621515;2369.9881500592473;2372.9406764830933;2382.142428725666;2389.9522009559887;2348.765123487655;2358.563665721847;2361.1027809432308;2363.6572696959015;2363.865344634585;8440.957795211047;8443.1134730853;8463.06906240313;8480.957595212047;8503.914960850374;5174.09453345663;5200.193969934666;5244.842654720364;5261.815836445706;5317.069512835277;3438.484227365915;3486.3852110916814;3511.9648803511895;3526.4710293456187;3556.05764472415;1193.7015746063485;1214.4717048084112;1223.6017405884388;1239.8016317389265;1272.2684456437585;11403;11518.136139789549;11570.785067567953;11597.652070437816;11669.649910502698;4266.786660666954;4366.716163449366;4367.410399596014;4393.51671316155;4450.844220452269;9290.814183716422;9527.38072025316;9548.61805527785;9556.139947404767;9575.808483830284;5201.531862132426;5232.293640358579;5254.5533629641905;5262.92105618416;5264.815731449381;4405.427294451765;4780.235162374003;4844.055409195244;4925.704457732548;4958.231474121517;3805.5623603285976;3852.57621661617;3876.7480113792512;3905.941410878839;3921.941170882439;1172.818213176942;1178.7583545373177;1180.1208099965581;1190.2798806721808;1191.0412118244897;883.3772190605607;976.0873583199731;979.2655508368723;990.2721499697716;991.008991008991;5387.218853266255;5429.728513574306;5477.123660214346;5492.231087647652;5667.886642267132;458.21416271095234;458.57581736893906;460.6591122569342;468.6133939499926;481.2876942125674;3828.3874580067054;3846.653801157909;3848.3842585186235;3854.248421557825;3862.092408284051;10299.53652085658;10631.52158152885;10703.625373111903;10725.463726813628;10728.141748660088;10263.846042309371;10381.169506439466;10525.36847789135;10551.788964220672;10561.735956601147;8163.591820408956;8238.629261683238;8249.133840946733;8265.628046737911;8292.792680183044;5323.946760532345;5344.5991550634635;5428.972855135699;5430.782768689366;5435.103207970798;9340.673076442292;9352.859707104262;9563.952180239054;9592.328537002342;9600.711978640651;8935.553222338987;9194.908050919405;9332.860007099764;9421.481818500048;9678.85481717789;6916.481263905328;7382.52013619113;7424.96287518559;7448.664810083451;7559.244075592616;8219.917800821915;8238.382121341043;8261.339092872677;8264.669413223644;8272.875906861282;7148.64256787169;7427.925720742724;7444.441666874898;7533.54798712079;7550.924490755022;7278.163011253773;7372.631368431665;7384.298491643285;7391.704331826667;7393.186749457663;6808.080909077211;6866.519343645897;6888.758893438706;6931.757388491378;6940.13248343957;4873.634477414279;4879.170541008109;4899.191633380452;4928.186849169991;4986.700797952134;4822.734749588806;4835.637327200544;4840.95159048405;4864.075825593126;4903.485134061015 20:22:55 INFO - PROCESS | 7523 | |4;prototype.html;347.1754582865694;350.53028941218764;351.4675266970539;356.98348951360975;358.6951091572164;6552.934470655292;6569.44159746421;6578.243501997272;6593.439557637595;6598.5710928789595;6496.902546461807;6524.836879078025;6531.771388001421;6537.411632953033;6567.244766851813;4609.769511524427;4754.358161648185;4842.636802239828;4861.562459378655;4863.27050942358;4839;4865.026994601077;4866.197077482228;4866.829660961867;4878.146324393235;4815.3258543803895;4838.516148385151;4870.780814863339;4873.415190177166;4891.021795640868;4887.975560122194;4894.804207831682;4895.510448955094;4898.387701537308;4903.436104847917;4243.469566304212;4255.5957184067465;4259.190753756808;4261.573842615745;4265.87202383929;6213;6223.236940624022;6327.746890124389;6331.873362532723;6333.271673757531;5626.859328516779;5653.575981801381;5682.545396368322;5685.658860468385;5690.345610254791;6854.074699915497;6862.4853136015;6863.450923926074;6868.7252509899545;6869.4847886408215;4689.1793936061395;4699.483056863743;4701.247800351927;4701.670883038189;4704.411948506437;7169.211386747454;7201.3158749918675;7208.279172082802;7208.459365547553;7215.062041934515;4545.272756358967;4695.131400690815;4717.150912835654;4760.262159365304;4829.830955916526;4809.663323567317;4837.032593481318;4839.104765618372;4846.709197448165;4856.150173719585;5649.971750141223;5654.434556544313;5656.236408084856;5657.32112146545;5666.801661941812;6892.965535172392;6940.583564986117;6969;6971.79084627462;6978.825529361807;1673.4477622384827;1698.8980661160122;1699.3287651377884;1700.6173610937687;1702.2254874032285;1053.4679986606868;1089.6894385100209;1098.791229666377;1100.2023532938715;1100.8899110089087;6719.630420326929;6748.156480439945;6776.288489708608;6787.117674702257;6791.864162716817;7150.606716630531;7152.606606636685;7154.499185056996;7176.1388633363285;7192.496525243183;6884.345987131214;6891.862162756817;6895.275996020446;6901.033855260268;6914.343137401939;3907.238088572758;3924.646781789653;3928.7428023032357;3928.941065884014;3939.094008378032;7607.65765540552;7610.505317154478;7615.885761713579;7643.923560764321;7644.655990480442;7342.4493163012985;7346.412287017026;7494.40044796415;7497.962510187414;7508.774736757906;7500.437467189982;7537.133229678548;7554.508956917783;7575.659095340613;7578.052743407075;7232.204457509775;7248.601326926859;7275.236100209402;7275.563466192046;7278.8891221545155;7102.573845569283;7138.214796372498;7155.749548765768;7164.749233776793;7181.461390395846;7424.96287518559;7599.050118735158;7606.885896711665;7607.771766847003;7617;4731.574158325767;4732.2428411454;4762.76186190696;4764.356811830358;4770.570648641639;7204.063471748848;7232.89150662751;7242.529235599669;7250.057492526149;7283.672234749343;7035.613041282779;7059.894101588377;7060.117485314336;7061.964690176516;7062.611556364449;6842.349976752201;6940.826479338057;6992.965035174791;6999.30006999296;7013;6852.657367131524;6879.7248110077035;6892.758753443806;6896.7586134485055;6908.930910690829;7037.7184912602925;7041.3310735480045;7051.612161331176;7054.8236294091;7089.361957423856;6848.1097457330225;6851.623160726208;6866.34769696878;6893.482988775962;6899.862002760017 20:22:55 INFO - PROCESS | 7523 | |5;yui.html;842.6039761312184;854.1885209051403;897.076011707941;897.9146981036799;913.2283220678524;15331.54005379839;15426.074435533876;15437.382504699799;15502.844971550281;15567.143807090619;12760.36198190089;14051.367688454018;14104.294785260721;14108.717825643482;14138.57584272471;851.8637018077109;864.4553931023446;865.0786911938796;869.4218344800731;871.9607617657189;851.7529916324289;857.4555157474986;857.9356548258905;858.1547176031604;861.8621020636699;894.6108442827358;895.3956079646246;895.4985208283349;896.7937374403891;897.7441429192681;879.8416285068685;889.0975659705405;889.4218757807412;889.4307643108416;891.9375643704943;653.5163978655808;654.5385503220266;654.6726636681659;655.1646650520577;656.2092678322609;14468;14528.491502797351;14576.635584110376;14597.197154156516;14645.487407940778;13362.265075420848;14593.927030364886;15212.695746085126;15354;15390.384384624602;11704;11780;11896.940515297454;12044.457999390048;12151.513939442411;4030.738002029888;4049.866037509502;4062.2078694654556;4115.691323150776;4123;54342.99999999961;54373.184402234;54601.180982285296;54899.72550137264;55049;11229.550817967352;11531.654050378502;11674;11815.763684726257;11819.409029548488;20462.079206435745;20531.076101575465;20557.69163462549;20570.074346654437;20642.483937901674;8129.593520324079;8222.38332125093;8320.500769953822;8326.292265157408;8424.873626895602;4712.387389639325;4772.427308722906;4801.4718380978065;4833.516648335209;4910.189818679949;3461.79229246241;3500.5274287971306;3500.7024402925526;3503.0366649171174;3519.5424594803026;716.8709632266242;735.0260904301822;737.1854101218184;738.6823665823747;738.7119023580808;556.5964675610151;581.3488892440494;638.9840253993688;665.6372277108987;699.8635266123057;8751.606177722018;9033.77415564603;9063.81872362549;9183;9473.905260947302;617.675720246874;727.3017902813252;730.1695957777146;749.4042236422058;760.5930827007525;4219.346001369792;4321.632661223831;4364.10535840152;4381.846635367747;4388.012697143117;60684.513589242146;61649.69175154096;61830.381696183365;62226.68886655538;62564;55170.72414637901;55857;56413;56522;56664.43335566674;49114;49717.502824971285;49813.750931245115;50118;50254.49745502571;8639.222469977733;8749.606267717842;8845.24815390699;8866.955665221632;8927.375083744075;37662.623373767005;38019.619803802714;38040.619593803705;39486;39578.60421395749;45041;46021;48894.26658600195;48971.265431019274;49099.75450122727;10475.16198704117;10689.984451477098;11144.832827507757;11198.832017519906;11221.66335009951;11973.700657483632;12284.692882678004;12456.564020259248;12633.620991370273;12875.35623218854;11498.482568284615;11840.1711880171;11897.107716921093;11951.641450756491;12232.633021009384;11464.484098215768;11694.70763230926;11772.823407649063;11847.229930054518;12203.14577979533;10823.67528974132;11243.887561124284;11251.606193783178;11366.090712743126;11541.769164616828;8802.647894084164;9128.45229286245;9375.85936210971;9395.483248421402;9440.433573985583;9039.412438191497;9414.764630884009;9457.10157535033;9555.18780903631;9561.426314421156 20:22:55 INFO - PROCESS | 7523 | __end_tp_report 20:22:55 INFO - PROCESS | 7523 | __start_cc_report 20:22:55 INFO - PROCESS | 7523 | _x_x_mozilla_cycle_collect,334 20:22:55 INFO - PROCESS | 7523 | __end_cc_report 20:22:55 INFO - PROCESS | 7523 | __startTimestamp1464060175608__endTimestamp 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | ------- Summary: start ------- 20:22:55 INFO - PROCESS | 7523 | Number of tests: 6 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#0] dojo.html Cycles:165 Average:5522.08 Median:5726.57 stddev:600.14 (10.5%) stddev-sans-first:576.46 20:22:55 INFO - PROCESS | 7523 | Values: 3314.6 3367.2 3376.6 3391.3 3422.0 5531.1 5537.1 5572.2 5575.4 5598.9 5527.2 5548.4 5550.4 5552.6 5567.1 5021.5 5074.2 5136.5 5143.7 5179.6 5027.2 5106.4 5144.8 5196.1 5226.4 5124.1 5136.5 5151.2 5152.8 5191.8 5145.5 5156.8 5162.6 5164.2 5199.6 4920.9 5044.9 5058.2 5116.5 5119.3 5390.4 5451.4 5461.6 5481.5 5513.9 5956.0 5970.3 5997.7 6005.3 6019.4 5724.5 5930.8 6046.8 6051.7 6057.1 5516.0 5517.8 5519.0 5530.4 5559.9 5986.9 5993.1 5993.3 5996.1 6001.5 5769.7 5778.8 5788.4 5790.9 5855.9 5844.3 5847.2 5849.5 5858.7 5867.4 5743.3 5779.9 5809.2 5823.3 5842.5 5757.0 5824.7 5888.8 5943.5 5973.7 4492.4 4528.9 4544.8 4551.1 4560.8 4021.2 4046.5 4061.6 4067.4 4098.1 5486.5 5559.8 5698.3 5712.1 5738.2 5928.0 5993.3 6002.8 6035.2 6066.5 5699.9 5725.1 5726.6 5738.4 5748.4 4881.2 4957.4 4997.2 4999.1 5027.8 6127.4 6138.5 6141.8 6145.6 6150.8 5811.1 5938.9 5939.3 5941.0 5943.7 6141.3 6173.2 6186.4 6196.6 6199.9 5847.0 5852.8 5853.6 5861.9 5862.4 5850.7 5871.1 5932.8 5970.9 5971.5 5834.0 5848.0 5849.4 5852.0 5890.1 5769.9 5804.1 5812.3 5818.7 5819.2 5668.3 5678.1 5708.1 5717.9 5723.8 5797.2 5837.4 5848.3 5862.2 5871.6 5690.6 5710.8 5713.7 5714.4 5714.9 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#1] ext.html Cycles:180 Average:60283.27 Median:42082.47 stddev:124250.92 (295.3%) stddev-sans-first:124518.75 20:22:55 INFO - PROCESS | 7523 | Values: 631.2 645.7 650.4 663.0 688.7 37511.4 38283.0 38322.2 38326.0 38359.6 41493.4 42414.2 42538.4 42542.6 42573.0 8709.7 8857.2 8881.3 8901.9 8910.8 8771.4 8873.4 8873.6 8892.2 8910.8 9085.6 9148.2 9157.1 9158.2 9161.2 8964.6 8975.9 9113.4 9117.9 9124.6 8922.9 8987.1 8998.1 9016.6 9063.0 40643.4 41051.0 41180.8 41204.0 41206.8 3672.3 3825.1 4025.4 4125.8 4412.8 31634.4 31738.8 31916.0 32125.0 32770.3 4643.1 4664.4 4696.5 4749.5 4822.9 310773.0 311078.0 311270.0 312336.0 313183.0 38328.8 38539.8 38851.8 38863.4 55767.4 36262.5 36353.6 36387.5 36474.3 36566.8 15704.0 15774.8 15790.2 15801.4 15803.4 14117.5 14160.2 14163.1 14195.6 14213.1 9101.4 9188.9 9237.6 9309.3 9371.5 3568.4 3577.2 3597.6 3614.2 3662.5 1083.4 1099.1 1099.2 1151.3 1176.5 31597.5 31689.8 32146.0 32809.8 33152.5 1135.6 1149.6 1174.5 1178.5 1274.1 16893.5 16935.9 17069.8 17184.5 17244.2 484126.0 590560.0 591983.0 594221.0 606958.0 54240.0 54411.0 54549.7 55068.0 55103.2 1467.9 1503.2 1528.8 1530.9 1607.5 32182.5 32355.5 33114.2 33497.0 34434.0 51553.7 52134.7 52196.7 52603.0 52608.2 472283.0 472556.0 473208.0 475171.0 478299.0 43987.8 44080.8 44666.3 44819.6 45042.3 48531.8 48798.0 49028.0 49341.3 50133.5 42425.8 42647.1 43102.1 43160.4 44172.0 41951.6 42213.4 42253.2 42754.1 43395.0 41812.4 42556.0 42598.8 42768.1 43559.0 35849.0 36531.1 37287.8 37431.8 37439.6 28523.1 29289.3 29442.0 29751.9 30028.5 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#2] jquery.html Cycles:180 Average:30535.64 Median:12696.42 stddev:90501.95 (712.8%) stddev-sans-first:90727.59 20:22:55 INFO - PROCESS | 7523 | Values: 425.4 428.4 434.8 440.3 443.1 19529.8 19829.8 20068.6 20309.3 20454.4 18848.9 19459.9 19690.8 19732.0 19787.5 5521.5 5646.4 5686.4 5916.0 5917.3 5827.1 5862.8 5869.0 5869.1 5893.2 5824.5 5838.4 6452.5 6638.2 6669.9 6558.1 6581.1 6595.8 6620.1 6636.9 5752.7 5844.6 5936.1 5952.6 5964.5 12965.8 13264.1 13375.0 19873.0 22944.3 2448.5 2514.5 2600.9 2643.1 2969.9 9796.7 9898.0 10054.9 10163.4 10317.9 1876.9 1932.2 1979.8 2016.6 2028.6 60026.4 72424.0 76222.6 80443.0 82270.0 11109.4 11272.4 11299.3 11417.9 11449.1 15764.2 15916.4 15922.8 16043.4 16098.3 8781.9 8797.6 8828.5 8875.1 8944.4 8699.3 8724.3 8746.7 8806.6 8857.7 4800.4 4862.5 4958.9 4968.6 5039.4 1986.0 2005.4 2019.1 2086.7 2096.0 1052.6 1053.4 1067.6 1100.2 1126.2 17666.9 18031.3 18298.3 18662.7 20117.0 1048.0 1052.8 1054.0 1075.0 1100.4 10105.9 10612.7 10713.8 10782.7 10813.9 540366.0 545541.0 550928.0 555164.0 561550.0 93641.5 97132.0 97694.0 98146.0 98489.0 1097.6 1120.6 1133.6 1136.9 1141.8 16747.6 16780.6 16995.0 17021.2 17056.0 38081.0 38799.0 39445.6 40138.4 42612.0 56758.7 57633.7 57764.4 57842.7 58141.4 8376.7 8553.0 8704.5 8744.1 8763.6 9736.7 12899.9 13007.5 13370.3 13438.9 11714.4 11818.3 11829.8 11905.4 12039.0 11477.3 11778.3 11812.7 11846.9 11871.6 12051.5 12078.3 12193.1 12223.5 12377.6 8758.2 8797.8 8864.4 8891.4 8910.9 8967.1 11493.9 12086.2 12198.6 12212.5 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#3] mootools.html Cycles:180 Average:5558.04 Median:4914.59 stddev:3105.46 (63.2%) stddev-sans-first:3098.37 20:22:55 INFO - PROCESS | 7523 | Values: 1389.1 1414.6 1561.5 1849.2 1875.5 7598.7 8219.3 8266.5 8494.4 8495.4 8217.8 8223.3 8233.1 8326.4 8340.6 2317.0 2327.8 2346.0 2350.3 2351.0 2244.0 2262.1 2263.1 2275.2 2280.2 2367.5 2388.4 2399.0 2403.9 2404.3 2364.1 2370.0 2372.9 2382.1 2390.0 2348.8 2358.6 2361.1 2363.7 2363.9 8441.0 8443.1 8463.1 8481.0 8503.9 5174.1 5200.2 5244.8 5261.8 5317.1 3438.5 3486.4 3512.0 3526.5 3556.1 1193.7 1214.5 1223.6 1239.8 1272.3 11403.0 11518.1 11570.8 11597.7 11669.6 4266.8 4366.7 4367.4 4393.5 4450.8 9290.8 9527.4 9548.6 9556.1 9575.8 5201.5 5232.3 5254.6 5262.9 5264.8 4405.4 4780.2 4844.1 4925.7 4958.2 3805.6 3852.6 3876.7 3905.9 3921.9 1172.8 1178.8 1180.1 1190.3 1191.0 883.4 976.1 979.3 990.3 991.0 5387.2 5429.7 5477.1 5492.2 5667.9 458.2 458.6 460.7 468.6 481.3 3828.4 3846.7 3848.4 3854.2 3862.1 10299.5 10631.5 10703.6 10725.5 10728.1 10263.8 10381.2 10525.4 10551.8 10561.7 8163.6 8238.6 8249.1 8265.6 8292.8 5323.9 5344.6 5429.0 5430.8 5435.1 9340.7 9352.9 9564.0 9592.3 9600.7 8935.6 9194.9 9332.9 9421.5 9678.9 6916.5 7382.5 7425.0 7448.7 7559.2 8219.9 8238.4 8261.3 8264.7 8272.9 7148.6 7427.9 7444.4 7533.5 7550.9 7278.2 7372.6 7384.3 7391.7 7393.2 6808.1 6866.5 6888.8 6931.8 6940.1 4873.6 4879.2 4899.2 4928.2 4986.7 4822.7 4835.6 4841.0 4864.1 4903.5 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#4] prototype.html Cycles:180 Average:5804.08 Median:6733.89 stddev:1812.37 (26.9%) stddev-sans-first:1770.56 20:22:55 INFO - PROCESS | 7523 | Values: 347.2 350.5 351.5 357.0 358.7 6552.9 6569.4 6578.2 6593.4 6598.6 6496.9 6524.8 6531.8 6537.4 6567.2 4609.8 4754.4 4842.6 4861.6 4863.3 4839.0 4865.0 4866.2 4866.8 4878.1 4815.3 4838.5 4870.8 4873.4 4891.0 4888.0 4894.8 4895.5 4898.4 4903.4 4243.5 4255.6 4259.2 4261.6 4265.9 6213.0 6223.2 6327.7 6331.9 6333.3 5626.9 5653.6 5682.5 5685.7 5690.3 6854.1 6862.5 6863.5 6868.7 6869.5 4689.2 4699.5 4701.2 4701.7 4704.4 7169.2 7201.3 7208.3 7208.5 7215.1 4545.3 4695.1 4717.2 4760.3 4829.8 4809.7 4837.0 4839.1 4846.7 4856.2 5650.0 5654.4 5656.2 5657.3 5666.8 6893.0 6940.6 6969.0 6971.8 6978.8 1673.4 1698.9 1699.3 1700.6 1702.2 1053.5 1089.7 1098.8 1100.2 1100.9 6719.6 6748.2 6776.3 6787.1 6791.9 7150.6 7152.6 7154.5 7176.1 7192.5 6884.3 6891.9 6895.3 6901.0 6914.3 3907.2 3924.6 3928.7 3928.9 3939.1 7607.7 7610.5 7615.9 7643.9 7644.7 7342.4 7346.4 7494.4 7498.0 7508.8 7500.4 7537.1 7554.5 7575.7 7578.1 7232.2 7248.6 7275.2 7275.6 7278.9 7102.6 7138.2 7155.7 7164.7 7181.5 7425.0 7599.1 7606.9 7607.8 7617.0 4731.6 4732.2 4762.8 4764.4 4770.6 7204.1 7232.9 7242.5 7250.1 7283.7 7035.6 7059.9 7060.1 7062.0 7062.6 6842.3 6940.8 6993.0 6999.3 7013.0 6852.7 6879.7 6892.8 6896.8 6908.9 7037.7 7041.3 7051.6 7054.8 7089.4 6848.1 6851.6 6866.3 6893.5 6899.9 20:22:55 INFO - PROCESS | 7523 | 20:22:55 INFO - PROCESS | 7523 | [#5] yui.html Cycles:180 Average:14950.76 Median:49415.75 stddev:17423.70 (35.3%) stddev-sans-first:17440.37 20:22:55 INFO - PROCESS | 7523 | Values: 842.6 854.2 897.1 897.9 913.2 15331.5 15426.1 15437.4 15502.8 15567.1 12760.4 14051.4 14104.3 14108.7 14138.6 851.9 864.5 865.1 869.4 872.0 851.8 857.5 857.9 858.2 861.9 894.6 895.4 895.5 896.8 897.7 879.8 889.1 889.4 889.4 891.9 653.5 654.5 654.7 655.2 656.2 14468.0 14528.5 14576.6 14597.2 14645.5 13362.3 14593.9 15212.7 15354.0 15390.4 11704.0 11780.0 11896.9 12044.5 12151.5 4030.7 4049.9 4062.2 4115.7 4123.0 54343.0 54373.2 54601.2 54899.7 55049.0 11229.6 11531.7 11674.0 11815.8 11819.4 20462.1 20531.1 20557.7 20570.1 20642.5 8129.6 8222.4 8320.5 8326.3 8424.9 4712.4 4772.4 4801.5 4833.5 4910.2 3461.8 3500.5 3500.7 3503.0 3519.5 716.9 735.0 737.2 738.7 738.7 556.6 581.3 639.0 665.6 699.9 8751.6 9033.8 9063.8 9183.0 9473.9 617.7 727.3 730.2 749.4 760.6 4219.3 4321.6 4364.1 4381.8 4388.0 60684.5 61649.7 61830.4 62226.7 62564.0 55170.7 55857.0 56413.0 56522.0 56664.4 49114.0 49717.5 49813.8 50118.0 50254.5 8639.2 8749.6 8845.2 8867.0 8927.4 37662.6 38019.6 38040.6 39486.0 39578.6 45041.0 46021.0 48894.3 48971.3 49099.8 10475.2 10690.0 11144.8 11198.8 11221.7 11973.7 12284.7 12456.6 12633.6 12875.4 11498.5 11840.2 11897.1 11951.6 12232.6 11464.5 11694.7 11772.8 11847.2 12203.1 10823.7 11243.9 11251.6 11366.1 11541.8 8802.6 9128.5 9375.9 9395.5 9440.4 9039.4 9414.8 9457.1 9555.2 9561.4 20:22:55 INFO - PROCESS | 7523 | -------- Summary: end -------- 20:22:55 INFO - PROCESS | 7523 | 20:22:56 INFO - TEST-INFO | 7523: exit 0 20:22:56 INFO - TEST-OK | dromaeo_css | took 1109447ms 20:22:56 INFO - TEST-START | kraken 20:22:56 INFO - operating with platform_type : linux_ 20:22:56 INFO - Initialising browser for kraken test... 20:22:56 INFO - TEST-INFO | started process 7764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjjIR5L/profile http://localhost:52938/getInfo.html) 20:22:59 INFO - PROCESS | 7764 | 20:22:59 INFO - PROCESS | 7764 | (process:7845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:23:00 INFO - PROCESS | 7764 | __metrics Screen width/height:1600/1200 20:23:00 INFO - PROCESS | 7764 | colorDepth:24 20:23:00 INFO - PROCESS | 7764 | Browser inner width/height: 1024/697 20:23:00 INFO - PROCESS | 7764 | __metrics 20:23:01 ERROR - PROCESS | 7764 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:23:02 INFO - TEST-INFO | 7764: exit 0 20:23:02 INFO - Browser initialized. 20:23:02 INFO - Running cycle 1/1 for kraken test... 20:23:02 INFO - TEST-INFO | started process 7897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjjIR5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:03 INFO - PROCESS | 7897 | 20:23:03 INFO - PROCESS | 7897 | (process:7965): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:23:13 INFO - PROCESS | 7897 | RSS: Main: 152342528 20:23:13 INFO - PROCESS | 7897 | 20:23:16 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:17 INFO - PROCESS | 7897 | RSS: Main: 156807168 20:23:17 INFO - PROCESS | 7897 | 20:23:19 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-dft) 20:23:20 INFO - PROCESS | 7897 | RSS: Main: 157048832 20:23:20 INFO - PROCESS | 7897 | 20:23:23 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-fft) 20:23:23 INFO - PROCESS | 7897 | RSS: Main: 156889088 20:23:23 INFO - PROCESS | 7897 | 20:23:26 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator) 20:23:26 INFO - PROCESS | 7897 | RSS: Main: 157118464 20:23:26 INFO - PROCESS | 7897 | 20:23:28 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:29 INFO - PROCESS | 7897 | RSS: Main: 156880896 20:23:29 INFO - PROCESS | 7897 | 20:23:32 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:33 INFO - PROCESS | 7897 | RSS: Main: 157413376 20:23:33 INFO - PROCESS | 7897 | 20:23:36 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:37 INFO - PROCESS | 7897 | RSS: Main: 157208576 20:23:37 INFO - PROCESS | 7897 | 20:23:39 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial) 20:23:40 INFO - PROCESS | 7897 | RSS: Main: 157298688 20:23:40 INFO - PROCESS | 7897 | 20:23:42 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:42 INFO - PROCESS | 7897 | RSS: Main: 157253632 20:23:42 INFO - PROCESS | 7897 | 20:23:44 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:23:44 INFO - PROCESS | 7897 | RSS: Main: 157233152 20:23:44 INFO - PROCESS | 7897 | 20:23:46 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:23:47 INFO - PROCESS | 7897 | RSS: Main: 157458432 20:23:47 INFO - PROCESS | 7897 | 20:23:50 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:23:50 INFO - PROCESS | 7897 | RSS: Main: 158466048 20:23:50 INFO - PROCESS | 7897 | 20:23:53 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:23:54 INFO - PROCESS | 7897 | RSS: Main: 157978624 20:23:54 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | Cycle 1(1): loaded http://localhost:52938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52938/tests/kraken/driver.html?testName=ai-astar) 20:23:55 INFO - PROCESS | 7897 | RSS: Main: 159203328 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | __start_tp_report 20:23:55 INFO - PROCESS | 7897 | _x_x_mozilla_page_load 20:23:55 INFO - PROCESS | 7897 | _x_x_mozilla_page_load_details 20:23:55 INFO - PROCESS | 7897 | |i|pagename|runs| 20:23:55 INFO - PROCESS | 7897 | |0;ai-astar;109;110;106;110;114;111;101;110;112;110 20:23:55 INFO - PROCESS | 7897 | |1;audio-beat-detection;158;126;160;176;128;164;155;129;189;131 20:23:55 INFO - PROCESS | 7897 | |2;audio-dft;163;163;164;161;162;160;160;160;163;163 20:23:55 INFO - PROCESS | 7897 | |3;audio-fft;76;75;76;175;76;77;76;76;162;76 20:23:55 INFO - PROCESS | 7897 | |4;audio-oscillator;92;92;150;92;92;92;147;93;92;140 20:23:55 INFO - PROCESS | 7897 | |5;imaging-gaussian-blur;117;119;118;121;117;117;117;118;118;117 20:23:55 INFO - PROCESS | 7897 | |6;imaging-darkroom;146;147;147;147;147;146;145;149;147;147 20:23:55 INFO - PROCESS | 7897 | |7;imaging-desaturate;95;96;95;95;96;95;96;95;94;95 20:23:55 INFO - PROCESS | 7897 | |8;json-parse-financial;57;57;56;62;59;57;56;73;56;65 20:23:55 INFO - PROCESS | 7897 | |9;json-stringify-tinderbox;57;57;58;58;58;58;56;56;58;57 20:23:55 INFO - PROCESS | 7897 | |10;stanford-crypto-aes;75;74;73;73;75;74;74;76;75;77 20:23:55 INFO - PROCESS | 7897 | |11;stanford-crypto-ccm;115;113;116;119;122;123;120;117;129;143 20:23:55 INFO - PROCESS | 7897 | |12;stanford-crypto-pbkdf2;159;164;177;160;160;159;158;160;159;162 20:23:55 INFO - PROCESS | 7897 | |13;stanford-crypto-sha256-iterative;68;68;75;66;66;68;71;65;66;66 20:23:55 INFO - PROCESS | 7897 | __end_tp_report 20:23:55 INFO - PROCESS | 7897 | __start_cc_report 20:23:55 INFO - PROCESS | 7897 | _x_x_mozilla_cycle_collect,856 20:23:55 INFO - PROCESS | 7897 | __end_cc_report 20:23:55 INFO - PROCESS | 7897 | __startTimestamp1464060235980__endTimestamp 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | ------- Summary: start ------- 20:23:55 INFO - PROCESS | 7897 | Number of tests: 14 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.56 (3.2%) stddev-sans-first:3.77 20:23:55 INFO - PROCESS | 7897 | Values: 109.0 110.0 106.0 110.0 114.0 111.0 101.0 110.0 112.0 110.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:159.00 stddev:22.16 (13.9%) stddev-sans-first:23.38 20:23:55 INFO - PROCESS | 7897 | Values: 158.0 126.0 160.0 176.0 128.0 164.0 155.0 129.0 189.0 131.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#2] audio-dft Cycles:10 Average:161.90 Median:163.00 stddev:1.52 (0.9%) stddev-sans-first:1.56 20:23:55 INFO - PROCESS | 7897 | Values: 163.0 163.0 164.0 161.0 162.0 160.0 160.0 160.0 163.0 163.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.12 (51.5%) stddev-sans-first:40.92 20:23:55 INFO - PROCESS | 7897 | Values: 76.0 75.0 76.0 175.0 76.0 77.0 76.0 76.0 162.0 76.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:25.97 (28.2%) stddev-sans-first:26.87 20:23:55 INFO - PROCESS | 7897 | Values: 92.0 92.0 150.0 92.0 92.0 92.0 147.0 93.0 92.0 140.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 20:23:55 INFO - PROCESS | 7897 | Values: 117.0 119.0 118.0 121.0 117.0 117.0 117.0 118.0 118.0 117.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 20:23:55 INFO - PROCESS | 7897 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 145.0 149.0 147.0 147.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:23:55 INFO - PROCESS | 7897 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 94.0 95.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:5.51 (9.5%) stddev-sans-first:5.75 20:23:55 INFO - PROCESS | 7897 | Values: 57.0 57.0 56.0 62.0 59.0 57.0 56.0 73.0 56.0 65.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 20:23:55 INFO - PROCESS | 7897 | Values: 57.0 57.0 58.0 58.0 58.0 58.0 56.0 56.0 58.0 57.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:1.26 (1.7%) stddev-sans-first:1.33 20:23:55 INFO - PROCESS | 7897 | Values: 75.0 74.0 73.0 73.0 75.0 74.0 74.0 76.0 75.0 77.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.00 stddev:8.78 (7.3%) stddev-sans-first:8.97 20:23:55 INFO - PROCESS | 7897 | Values: 115.0 113.0 116.0 119.0 122.0 123.0 120.0 117.0 129.0 143.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:160.00 stddev:5.61 (3.5%) stddev-sans-first:5.86 20:23:55 INFO - PROCESS | 7897 | Values: 159.0 164.0 177.0 160.0 160.0 159.0 158.0 160.0 159.0 162.0 20:23:55 INFO - PROCESS | 7897 | 20:23:55 INFO - PROCESS | 7897 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:3.03 (4.5%) stddev-sans-first:3.22 20:23:55 INFO - PROCESS | 7897 | Values: 68.0 68.0 75.0 66.0 66.0 68.0 71.0 65.0 66.0 66.0 20:23:55 INFO - PROCESS | 7897 | -------- Summary: end -------- 20:23:55 INFO - PROCESS | 7897 | 20:23:56 INFO - TEST-INFO | 7897: exit 0 20:23:56 INFO - TEST-OK | kraken | took 60586ms 20:23:56 INFO - SUITE-END | took 1170s 20:23:57 INFO - Completed test suite (00:19:30) 20:23:57 INFO - javascript benchmark 20:23:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.585676790401, 3367.2423704666444, 3376.5948086229655, 3391.287829555793, 3422.007617790841, 5531.1426728856995, 5537.086380747177, 5572.192032155345, 5575.358833734122, 5598.888022239558, 5527.198556209357, 5548.389677135512, 5550.417206193352, 5552.639078459907, 5567.053600887849, 5021.497850214968, 5074.238864170386, 5136.537711605954, 5143.691378517282, 5179.611529135311, 5027.2207807789855, 5106.361704786902, 5144.819931302405, 5196.142636464979, 5226.425093239741, 5124.103281925667, 5136.460671629481, 5151.201563757623, 5152.845414637548, 5191.766370513317, 5145.511176438233, 5156.845294641167, 5162.612804039693, 5164.173732202867, 5199.558037566811, 4920.926186107211, 5044.949550504484, 5058.2412638104215, 5116.539511443988, 5119.3088932994315, 5390.434004429518, 5451.427600101972, 5461.563074953994, 5481.506664400184, 5513.862153446196, 5955.970220148914, 5970.313413957364, 5997.730102145414, 6005.3394126646035, 6019.428154325332, 5724.484796368347, 5930.822075337746, 6046.758129674808, 6051.727672254759, 6057.121717351003, 5515.972420137914, 5517.779288828482, 5519.0, 5530.419305972855, 5559.8888022239735, 5986.880262394815, 5993.0710739835395, 5993.310769261503, 5996.070609055516, 6001.549883758736, 5769.682667453247, 5778.8266352009505, 5788.363280039192, 5790.88418231633, 5855.858107669049, 5844.26946631671, 5847.239858818326, 5849.502792262705, 5858.707064646751, 5867.383924687846, 5743.253377061039, 5779.88440231193, 5809.215755872988, 5823.301203855564, 5842.532597392198, 5756.971215143897, 5824.737886795105, 5888.764449421975, 5943.465088142088, 5973.671448070311, 4492.415985921809, 4528.864134075983, 4544.818207271672, 4551.067031258584, 4560.794764235618, 4021.235965166609, 4046.5346485154582, 4061.573534778806, 4067.3695577185586, 4098.057446787196, 5486.506214440639, 5559.833205003856, 5698.287714035746, 5712.057510510802, 5738.1679656450415, 5928.0, 5993.250843644544, 6002.759889604455, 6035.245594300713, 6066.4540191382985, 5699.943000570024, 5725.141228815711, 5726.570507211893, 5738.426157384311, 5748.367679555246, 4881.243407271879, 4957.405111386584, 4997.150484417658, 4999.075171093359, 5027.824026159067, 6127.4485296322655, 6138.5396095292135, 6141.84645383869, 6145.600535965148, 6150.846228844314, 5811.070228763378, 5938.940610593839, 5939.316978547436, 5941.0494320910175, 5943.702814859326, 6141.263048434216, 6173.197484327188, 6186.381361863778, 6196.566240363131, 6199.876002479835, 5846.970765146147, 5852.824415267549, 5853.590248682552, 5861.882762344814, 5862.413758624103, 5850.707464626837, 5871.119332100219, 5932.762689492372, 5970.850728731816, 5971.522278217819, 5834.03738383162, 5848.0350742127075, 5849.356570777296, 5851.970740146272, 5890.1164825276555, 5769.855753606025, 5804.1293805929445, 5812.3025236971835, 5818.679972601548, 5819.15622234782, 5668.26312579362, 5678.14827775837, 5708.058170402003, 5717.885642287048, 5723.828285151452, 5797.246357973437, 5837.445442682938, 5848.327442344185, 5862.237909071793, 5871.588988770916, 5690.630109042899, 5710.8001219957105, 5713.657180569179, 5714.399988001366, 5714.914276285942], "value": 5483.873563225044, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.1952260867394, 645.6578013652766, 650.3756393861893, 662.9591541280189, 688.7072993977558, 37511.437328440064, 38282.99999999996, 38322.23355532888, 38326.0, 38359.61640383596, 41493.37759933596, 42414.15171696564, 42538.36192457116, 42542.57457425425, 42573.0, 8709.738707838758, 8857.247133993618, 8881.289496840269, 8901.910980890172, 8910.821783564325, 8771.386002979794, 8873.378863479558, 8873.600687969058, 8892.15524525169, 8910.777230569223, 9085.636574537011, 9148.17666410023, 9157.130072643089, 9158.221551168159, 9161.221296189831, 8964.641414343387, 8975.910240897572, 9113.362064655477, 9117.908820911773, 9124.589393477243, 8922.910770892338, 8987.146221108984, 8998.05520420353, 9016.639334426614, 9063.0, 40643.390349144785, 41051.0, 41180.794096029626, 41204.0, 41206.79396603028, 3672.320620685182, 3825.08198032473, 4025.376066709665, 4125.773082480462, 4412.84555040572, 31634.36731265385, 31738.841305793554, 31916.0, 32125.03624891257, 32770.344593108246, 4643.094596553673, 4664.393628828265, 4696.53034696531, 4749.453812811536, 4822.927656085161, 310773.0, 311078.0, 311270.0, 312336.0, 313182.99999999773, 38328.8083559586, 38539.807300963315, 38851.80574097111, 38863.41704874429, 55767.44232557622, 36262.45606315907, 36353.63646363556, 36387.4541881872, 36474.27051458956, 36566.817165914, 15704.0, 15774.76337854933, 15790.21048947571, 15801.36794528229, 15803.36786528526, 14117.505887293895, 14160.150390976574, 14163.079399838978, 14195.64510887236, 14213.147211167363, 9101.362904596615, 9188.908110918805, 9237.584308706124, 9309.255259579217, 9371.48456834867, 3568.411212149966, 3577.248777756648, 3597.5862775780597, 3614.1868079682386, 3662.5238718966366, 1083.3716444462193, 1099.1097211258907, 1099.1866019145934, 1151.3034614058374, 1176.4705882352805, 31597.526037109463, 31689.841550792098, 32146.0, 32809.835950820096, 33152.50271245933, 1135.602539111321, 1149.6493569461227, 1174.4656181437426, 1178.4991378664033, 1274.0699289518518, 16893.493195204162, 16935.91319100671, 17069.829301707072, 17184.484465466056, 17244.224009919584, 484126.0, 590560.0, 591983.0, 594221.0, 606958.0, 54240.0, 54411.0, 54549.72725136349, 55068.0, 55103.173452398245, 1467.8532146785235, 1503.1732547099052, 1528.8318284988643, 1530.8851836112335, 1607.541850572581, 32182.517262240617, 32355.514667279538, 33114.17214569655, 33497.0, 34434.0, 51553.742231288605, 52134.739326303126, 52196.73901630467, 52603.0, 52608.210876836114, 472283.0, 472556.0, 473208.0, 475171.0, 478299.0, 43987.78006109949, 44080.77959610181, 44666.3300050493, 44819.55180448154, 45042.32436513389, 48531.75734121448, 48798.0, 49028.0, 49341.2598811011, 50133.49866501434, 42425.78787106045, 42647.147057058064, 43102.137957240055, 43160.35259471048, 44172.0, 41951.58048419477, 42213.366799498646, 42253.15493690047, 42754.144917100864, 43395.0, 41812.3728144072, 42556.0, 42598.78700606477, 42768.1446371077, 43559.0, 35849.0, 36531.086722832144, 37287.81356093202, 37431.81284093671, 37439.62560374361, 28523.144305670863, 29289.267768305963, 29442.0, 29751.851240744523, 30028.549571756877], "value": 19532.475954761878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.41505430033703, 428.37457312323994, 434.8434563557119, 440.27354864473614, 443.11377245508976, 19529.804701952995, 19829.801701982993, 20068.59862802743, 20309.289174878864, 20454.386368408934, 18848.9057554712, 19459.902700486513, 19690.803091969075, 19732.0, 19787.50531236716, 5521.475459831329, 5646.407127251641, 5686.431356864322, 5915.9704201478935, 5917.289925208981, 5827.125931110325, 5862.794802181925, 5869.031609784402, 5869.1196320551835, 5893.204417403638, 5824.485633735217, 5838.4453476919625, 6452.451541618968, 6638.17022872141, 6669.899951500732, 6558.147440832661, 6581.078648989097, 6595.802125936206, 6620.139381880349, 6636.93363066368, 5752.741126649311, 5844.590878638497, 5936.079907614327, 5952.58331916766, 5964.493018093423, 12965.805512917314, 13264.137831041047, 13375.0, 19873.0, 22944.31167064974, 2448.5347783920997, 2514.4719608882156, 2600.9479810403686, 2643.1145566235336, 2969.9011365794577, 9796.657117000943, 9898.0, 10054.9497252514, 10163.390196588154, 10317.896821031844, 1876.934307299238, 1932.2464238946823, 1979.823706150374, 2016.5664382157906, 2028.6247044296704, 60026.39973600252, 72424.0, 76222.61888690577, 80443.0, 82269.9999999994, 11109.44452777358, 11272.380019099028, 11299.322040677585, 11417.885821141848, 11449.084073274285, 15764.211789410483, 15916.363345466052, 15922.76115858263, 16043.438479653156, 16098.275577599035, 8781.868271975925, 8797.648094076294, 8828.470291782514, 8875.112488751203, 8944.418612790148, 8699.260562852101, 8724.302055835646, 8746.65013399457, 8806.647734090564, 8857.689980850639, 4800.423949126127, 4862.489438608965, 4958.876028099255, 4968.552830245223, 5039.370078740158, 1985.9900700496405, 2005.3582853487037, 2019.131773337479, 2086.6869969504696, 2096.0, 1052.5737076484036, 1053.3521884041413, 1067.6156583629886, 1100.158378840172, 1126.214949305344, 17666.911665441592, 18031.311858916775, 18298.268069277347, 18662.720059199124, 20117.0, 1047.9738006549896, 1052.7947050325113, 1054.0460882900986, 1074.9677509674723, 1100.4057808783168, 10105.949470252748, 10612.681619551426, 10713.78572428547, 10782.67651970442, 10813.922329518833, 540366.0, 545541.0, 550928.0, 555164.0, 561550.0, 93641.5317923406, 97132.0, 97694.02305976991, 98146.0, 98489.0, 1097.6158344579333, 1120.56298043763, 1133.552246862501, 1136.9431528423545, 1141.7887690777234, 16747.581310467336, 16780.580485487473, 16995.0, 17021.234044468278, 17056.0, 38081.0, 38799.0, 39445.60554394419, 40138.39792403058, 42612.0, 56758.71620641871, 57633.711831440574, 57764.4223557759, 57842.7107864458, 58141.4185858136, 8376.748697539084, 8553.0, 8704.477731335886, 8744.08187140341, 8763.649454022023, 9736.73648377456, 12899.871001289866, 13007.544735934196, 13370.331483425984, 13438.865611344152, 11714.414279286171, 11818.290902545874, 11829.822552661544, 11905.404729763304, 12039.0, 11477.253978491372, 11778.293302401884, 11812.70468238301, 11846.881531184923, 11871.584494542649, 12051.51793928233, 12078.27530348182, 12193.085518585964, 12223.511059557519, 12377.566785162477, 8758.167974042455, 8797.824043519222, 8864.42381245217, 8891.422057566237, 8910.86633700482, 8967.10328967098, 11493.942530287295, 12086.214396064228, 12198.63404097843, 12212.511499539918], "value": 9433.807171642089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.1248513436533, 1414.639266986918, 1561.4925149326473, 1849.2048419179748, 1875.465492334685, 7598.658060387282, 8219.260266576008, 8266.4626799258, 8494.362922780785, 8495.447795893271, 8217.794555136124, 8223.259906608404, 8233.094359620436, 8326.375521835856, 8340.582970851448, 2316.9652455213145, 2327.767223277676, 2346.0146738369926, 2350.3419042667997, 2351.012574718614, 2244.012634440841, 2262.1403866530777, 2263.0721404224273, 2275.1695631094613, 2280.1677387753434, 2367.4673198530277, 2388.3790214544256, 2399.0, 2403.879806009701, 2404.302752201859, 2364.1370899621515, 2369.9881500592473, 2372.9406764830933, 2382.142428725666, 2389.9522009559887, 2348.765123487655, 2358.563665721847, 2361.1027809432308, 2363.6572696959015, 2363.865344634585, 8440.957795211047, 8443.1134730853, 8463.06906240313, 8480.957595212047, 8503.914960850374, 5174.09453345663, 5200.193969934666, 5244.842654720364, 5261.815836445706, 5317.069512835277, 3438.484227365915, 3486.3852110916814, 3511.9648803511895, 3526.4710293456187, 3556.05764472415, 1193.7015746063485, 1214.4717048084112, 1223.6017405884388, 1239.8016317389265, 1272.2684456437585, 11403.0, 11518.136139789549, 11570.785067567953, 11597.652070437816, 11669.649910502698, 4266.786660666954, 4366.716163449366, 4367.410399596014, 4393.51671316155, 4450.844220452269, 9290.814183716422, 9527.38072025316, 9548.61805527785, 9556.139947404767, 9575.808483830284, 5201.531862132426, 5232.293640358579, 5254.5533629641905, 5262.92105618416, 5264.815731449381, 4405.427294451765, 4780.235162374003, 4844.055409195244, 4925.704457732548, 4958.231474121517, 3805.5623603285976, 3852.57621661617, 3876.7480113792512, 3905.941410878839, 3921.941170882439, 1172.818213176942, 1178.7583545373177, 1180.1208099965581, 1190.2798806721808, 1191.0412118244897, 883.3772190605607, 976.0873583199731, 979.2655508368723, 990.2721499697716, 991.008991008991, 5387.218853266255, 5429.728513574306, 5477.123660214346, 5492.231087647652, 5667.886642267132, 458.21416271095234, 458.57581736893906, 460.6591122569342, 468.6133939499926, 481.2876942125674, 3828.3874580067054, 3846.653801157909, 3848.3842585186235, 3854.248421557825, 3862.092408284051, 10299.53652085658, 10631.52158152885, 10703.625373111903, 10725.463726813628, 10728.141748660088, 10263.846042309371, 10381.169506439466, 10525.36847789135, 10551.788964220672, 10561.735956601147, 8163.591820408956, 8238.629261683238, 8249.133840946733, 8265.628046737911, 8292.792680183044, 5323.946760532345, 5344.5991550634635, 5428.972855135699, 5430.782768689366, 5435.103207970798, 9340.673076442292, 9352.859707104262, 9563.952180239054, 9592.328537002342, 9600.711978640651, 8935.553222338987, 9194.908050919405, 9332.860007099764, 9421.481818500048, 9678.85481717789, 6916.481263905328, 7382.52013619113, 7424.96287518559, 7448.664810083451, 7559.244075592616, 8219.917800821915, 8238.382121341043, 8261.339092872677, 8264.669413223644, 8272.875906861282, 7148.64256787169, 7427.925720742724, 7444.441666874898, 7533.54798712079, 7550.924490755022, 7278.163011253773, 7372.631368431665, 7384.298491643285, 7391.704331826667, 7393.186749457663, 6808.080909077211, 6866.519343645897, 6888.758893438706, 6931.757388491378, 6940.13248343957, 4873.634477414279, 4879.170541008109, 4899.191633380452, 4928.186849169991, 4986.700797952134, 4822.734749588806, 4835.637327200544, 4840.95159048405, 4864.075825593126, 4903.485134061015], "value": 4429.266896653669, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1754582865694, 350.53028941218764, 351.4675266970539, 356.98348951360975, 358.6951091572164, 6552.934470655292, 6569.44159746421, 6578.243501997272, 6593.439557637595, 6598.5710928789595, 6496.902546461807, 6524.836879078025, 6531.771388001421, 6537.411632953033, 6567.244766851813, 4609.769511524427, 4754.358161648185, 4842.636802239828, 4861.562459378655, 4863.27050942358, 4839.0, 4865.026994601077, 4866.197077482228, 4866.829660961867, 4878.146324393235, 4815.3258543803895, 4838.516148385151, 4870.780814863339, 4873.415190177166, 4891.021795640868, 4887.975560122194, 4894.804207831682, 4895.510448955094, 4898.387701537308, 4903.436104847917, 4243.469566304212, 4255.5957184067465, 4259.190753756808, 4261.573842615745, 4265.87202383929, 6213.0, 6223.236940624022, 6327.746890124389, 6331.873362532723, 6333.271673757531, 5626.859328516779, 5653.575981801381, 5682.545396368322, 5685.658860468385, 5690.345610254791, 6854.074699915497, 6862.4853136015, 6863.450923926074, 6868.7252509899545, 6869.4847886408215, 4689.1793936061395, 4699.483056863743, 4701.247800351927, 4701.670883038189, 4704.411948506437, 7169.211386747454, 7201.3158749918675, 7208.279172082802, 7208.459365547553, 7215.062041934515, 4545.272756358967, 4695.131400690815, 4717.150912835654, 4760.262159365304, 4829.830955916526, 4809.663323567317, 4837.032593481318, 4839.104765618372, 4846.709197448165, 4856.150173719585, 5649.971750141223, 5654.434556544313, 5656.236408084856, 5657.32112146545, 5666.801661941812, 6892.965535172392, 6940.583564986117, 6969.0, 6971.79084627462, 6978.825529361807, 1673.4477622384827, 1698.8980661160122, 1699.3287651377884, 1700.6173610937687, 1702.2254874032285, 1053.4679986606868, 1089.6894385100209, 1098.791229666377, 1100.2023532938715, 1100.8899110089087, 6719.630420326929, 6748.156480439945, 6776.288489708608, 6787.117674702257, 6791.864162716817, 7150.606716630531, 7152.606606636685, 7154.499185056996, 7176.1388633363285, 7192.496525243183, 6884.345987131214, 6891.862162756817, 6895.275996020446, 6901.033855260268, 6914.343137401939, 3907.238088572758, 3924.646781789653, 3928.7428023032357, 3928.941065884014, 3939.094008378032, 7607.65765540552, 7610.505317154478, 7615.885761713579, 7643.923560764321, 7644.655990480442, 7342.4493163012985, 7346.412287017026, 7494.40044796415, 7497.962510187414, 7508.774736757906, 7500.437467189982, 7537.133229678548, 7554.508956917783, 7575.659095340613, 7578.052743407075, 7232.204457509775, 7248.601326926859, 7275.236100209402, 7275.563466192046, 7278.8891221545155, 7102.573845569283, 7138.214796372498, 7155.749548765768, 7164.749233776793, 7181.461390395846, 7424.96287518559, 7599.050118735158, 7606.885896711665, 7607.771766847003, 7617.0, 4731.574158325767, 4732.2428411454, 4762.76186190696, 4764.356811830358, 4770.570648641639, 7204.063471748848, 7232.89150662751, 7242.529235599669, 7250.057492526149, 7283.672234749343, 7035.613041282779, 7059.894101588377, 7060.117485314336, 7061.964690176516, 7062.611556364449, 6842.349976752201, 6940.826479338057, 6992.965035174791, 6999.30006999296, 7013.0, 6852.657367131524, 6879.7248110077035, 6892.758753443806, 6896.7586134485055, 6908.930910690829, 7037.7184912602925, 7041.3310735480045, 7051.612161331176, 7054.8236294091, 7089.361957423856, 6848.1097457330225, 6851.623160726208, 6866.34769696878, 6893.482988775962, 6899.862002760017], "value": 5203.250245220249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.6039761312184, 854.1885209051403, 897.076011707941, 897.9146981036799, 913.2283220678524, 15331.54005379839, 15426.074435533876, 15437.382504699799, 15502.844971550281, 15567.143807090619, 12760.36198190089, 14051.367688454018, 14104.294785260721, 14108.717825643482, 14138.57584272471, 851.8637018077109, 864.4553931023446, 865.0786911938796, 869.4218344800731, 871.9607617657189, 851.7529916324289, 857.4555157474986, 857.9356548258905, 858.1547176031604, 861.8621020636699, 894.6108442827358, 895.3956079646246, 895.4985208283349, 896.7937374403891, 897.7441429192681, 879.8416285068685, 889.0975659705405, 889.4218757807412, 889.4307643108416, 891.9375643704943, 653.5163978655808, 654.5385503220266, 654.6726636681659, 655.1646650520577, 656.2092678322609, 14468.0, 14528.491502797351, 14576.635584110376, 14597.197154156516, 14645.487407940778, 13362.265075420848, 14593.927030364886, 15212.695746085126, 15354.0, 15390.384384624602, 11704.0, 11780.0, 11896.940515297454, 12044.457999390048, 12151.513939442411, 4030.738002029888, 4049.866037509502, 4062.2078694654556, 4115.691323150776, 4123.0, 54342.99999999961, 54373.184402234, 54601.180982285296, 54899.72550137264, 55049.0, 11229.550817967352, 11531.654050378502, 11674.0, 11815.763684726257, 11819.409029548488, 20462.079206435745, 20531.076101575465, 20557.69163462549, 20570.074346654437, 20642.483937901674, 8129.593520324079, 8222.38332125093, 8320.500769953822, 8326.292265157408, 8424.873626895602, 4712.387389639325, 4772.427308722906, 4801.4718380978065, 4833.516648335209, 4910.189818679949, 3461.79229246241, 3500.5274287971306, 3500.7024402925526, 3503.0366649171174, 3519.5424594803026, 716.8709632266242, 735.0260904301822, 737.1854101218184, 738.6823665823747, 738.7119023580808, 556.5964675610151, 581.3488892440494, 638.9840253993688, 665.6372277108987, 699.8635266123057, 8751.606177722018, 9033.77415564603, 9063.81872362549, 9183.0, 9473.905260947302, 617.675720246874, 727.3017902813252, 730.1695957777146, 749.4042236422058, 760.5930827007525, 4219.346001369792, 4321.632661223831, 4364.10535840152, 4381.846635367747, 4388.012697143117, 60684.513589242146, 61649.69175154096, 61830.381696183365, 62226.68886655538, 62564.0, 55170.72414637901, 55857.0, 56413.0, 56522.0, 56664.43335566674, 49114.0, 49717.502824971285, 49813.750931245115, 50118.0, 50254.49745502571, 8639.222469977733, 8749.606267717842, 8845.24815390699, 8866.955665221632, 8927.375083744075, 37662.623373767005, 38019.619803802714, 38040.619593803705, 39486.0, 39578.60421395749, 45041.0, 46021.0, 48894.26658600195, 48971.265431019274, 49099.75450122727, 10475.16198704117, 10689.984451477098, 11144.832827507757, 11198.832017519906, 11221.66335009951, 11973.700657483632, 12284.692882678004, 12456.564020259248, 12633.620991370273, 12875.35623218854, 11498.482568284615, 11840.1711880171, 11897.107716921093, 11951.641450756491, 12232.633021009384, 11464.484098215768, 11694.70763230926, 11772.823407649063, 11847.229930054518, 12203.14577979533, 10823.67528974132, 11243.887561124284, 11251.606193783178, 11366.090712743126, 11541.769164616828, 8802.647894084164, 9128.45229286245, 9375.85936210971, 9395.483248421402, 9440.433573985583, 9039.412438191497, 9414.764630884009, 9457.10157535033, 9555.18780903631, 9561.426314421156], "value": 6802.342311194149, "unit": "score"}], "name": "dromaeo_css", "value": 7355.9577352936385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 106.0, 110.0, 114.0, 111.0, 101.0, 110.0, 112.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 160.0, 176.0, 128.0, 164.0, 155.0, 129.0, 189.0, 131.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 162.0, 160.0, 160.0, 160.0, 163.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 175.0, 76.0, 77.0, 76.0, 76.0, 162.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 92.0, 92.0, 92.0, 147.0, 93.0, 92.0, 140.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 121.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 145.0, 149.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 62.0, 59.0, 57.0, 56.0, 73.0, 56.0, 65.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 56.0, 56.0, 58.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 73.0, 75.0, 74.0, 74.0, 76.0, 75.0, 77.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 116.0, 119.0, 122.0, 123.0, 120.0, 117.0, 129.0, 143.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 164.0, 177.0, 160.0, 160.0, 159.0, 158.0, 160.0, 159.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 75.0, 66.0, 66.0, 68.0, 71.0, 65.0, 66.0, 66.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1528.5, "alertThreshold": 2.0}]} 20:23:57 INFO - Return code: 0 20:23:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:23:57 ERROR - # TBPL SUCCESS # 20:23:57 INFO - Running post-action listener: _resource_record_post_action 20:23:57 INFO - Running post-run listener: _resource_record_post_run 20:23:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 3620864; Write bytes: 262475776; Read time: 516; Write time: 181820 20:23:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13373440; Read time: 0; Write time: 3708 20:23:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 3620864; Write bytes: 245305344; Read time: 516; Write time: 173152 20:23:58 INFO - Running post-run listener: _upload_blobber_files 20:23:58 INFO - Blob upload gear active. 20:23:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:23:58 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 20:23:58 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'] 20:23:58 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 20:23:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:23:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:23:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:23:59 INFO - (blobuploader) - INFO - Done attempting. 20:23:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:23:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:23:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:24:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:00 INFO - (blobuploader) - INFO - Done attempting. 20:24:00 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:00 INFO - Return code: 0 20:24:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977d875bcb1051f2e2b77f60403438298509f07dfc6c019f1ec47cf4ef93b1750c1932c4528e5224572519bc235a7067eb2460a8addfec479c043ed13bef9e61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7d6135027d8334d63c52c9bf3fd427b0649cec63b5a60e220bf2ab7c01b39e0a2dca356feea8a54a3b891d166d30224400f30de003c3d65790d19eeb2706bf"} 20:24:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:00 INFO - Contents: 20:24:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977d875bcb1051f2e2b77f60403438298509f07dfc6c019f1ec47cf4ef93b1750c1932c4528e5224572519bc235a7067eb2460a8addfec479c043ed13bef9e61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7d6135027d8334d63c52c9bf3fd427b0649cec63b5a60e220bf2ab7c01b39e0a2dca356feea8a54a3b891d166d30224400f30de003c3d65790d19eeb2706bf"} 20:24:00 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:00 INFO - Copying logs to upload dir... 20:24:00 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.307572 ========= master_lag: 0.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-05-23 20:24:01.213811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:24:01.216928) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 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/977d875bcb1051f2e2b77f60403438298509f07dfc6c019f1ec47cf4ef93b1750c1932c4528e5224572519bc235a7067eb2460a8addfec479c043ed13bef9e61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7d6135027d8334d63c52c9bf3fd427b0649cec63b5a60e220bf2ab7c01b39e0a2dca356feea8a54a3b891d166d30224400f30de003c3d65790d19eeb2706bf"} build_url:https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011817 build_url: 'https://queue.taskcluster.net/v1/task/dnqrQu9CSVyaeH1FugZp7A/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/977d875bcb1051f2e2b77f60403438298509f07dfc6c019f1ec47cf4ef93b1750c1932c4528e5224572519bc235a7067eb2460a8addfec479c043ed13bef9e61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba7d6135027d8334d63c52c9bf3fd427b0649cec63b5a60e220bf2ab7c01b39e0a2dca356feea8a54a3b891d166d30224400f30de003c3d65790d19eeb2706bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 20:24:01.247509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:24:01.248026) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464059013.695399-924057761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:24:01.496925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:24:01.497239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 20:24:01.500454) ========= ========= Total master_lag: 1.15 =========