builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1468623239.9 results: success (0) buildid: 20160715132252 builduid: 84ab1f9197a146c584cba5f3afaf3b77 revision: 6893a8d54639abb5d331896858af8a305584c1b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 15:53:59.900829) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 15:53:59.901261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 15:53:59.901555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 15:53:59.915948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:53:59.916213) ========= 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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 15:54:00-- 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% 66.4M=0s 2016-07-15 15:54:00 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.024767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.025102) ========= 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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.076558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.076989) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6893a8d54639abb5d331896858af8a305584c1b6 --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 6893a8d54639abb5d331896858af8a305584c1b6 --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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 15:54:00,401 truncating revision to first 12 chars 2016-07-15 15:54:00,401 Setting DEBUG logging. 2016-07-15 15:54:00,401 attempt 1/10 2016-07-15 15:54:00,401 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6893a8d54639?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 15:54:00,703 unpacking tar archive at: mozilla-aurora-6893a8d54639/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.703904) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.704234) ========= script_repo_revision: 6893a8d54639abb5d331896858af8a305584c1b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.704659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.704939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 15:54:00.714543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-15 15:54:00.714850) ========= /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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:01 INFO - MultiFileLogger online at 20160715 15:54:01 in /builds/slave/test 15:54:01 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 15:54:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:01 INFO - {'append_to_log': False, 15:54:01 INFO - 'base_work_dir': '/builds/slave/test', 15:54:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:54:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:01 INFO - 'branch': 'Mozilla-Aurora', 15:54:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:01 INFO - 'config_files': ('talos/linux_config.py',), 15:54:01 INFO - 'default_actions': ('clobber', 15:54:01 INFO - 'read-buildbot-config', 15:54:01 INFO - 'download-and-extract', 15:54:01 INFO - 'populate-webroot', 15:54:01 INFO - 'create-virtualenv', 15:54:01 INFO - 'install', 15:54:01 INFO - 'run-tests'), 15:54:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:01 INFO - 'download_minidump_stackwalk': True, 15:54:01 INFO - 'download_symbols': 'ondemand', 15:54:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:01 INFO - 'installer_path': 'installer.exe', 15:54:01 INFO - 'log_level': 'info', 15:54:01 INFO - 'log_name': 'talos', 15:54:01 INFO - 'log_to_console': True, 15:54:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:01 INFO - 'opt_config_files': (), 15:54:01 INFO - 'pip_index': False, 15:54:01 INFO - 'sps_profile': False, 15:54:01 INFO - 'sps_profile_interval': 0, 15:54:01 INFO - 'suite': 'dromaeojs-e10s', 15:54:01 INFO - 'system_bits': '32', 15:54:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:01 INFO - 'title': 'talos-linux64-ix-018', 15:54:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:01 INFO - 'use_talos_json': True, 15:54:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:01 INFO - 'work_dir': 'build'} 15:54:01 INFO - ##### 15:54:01 INFO - ##### Running clobber step. 15:54:01 INFO - ##### 15:54:01 INFO - Running pre-action listener: _resource_record_pre_action 15:54:01 INFO - Running main action method: clobber 15:54:01 INFO - rmtree: /builds/slave/test/build 15:54:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:01 INFO - Running post-action listener: _resource_record_post_action 15:54:01 INFO - ##### 15:54:01 INFO - ##### Finished clobber step (success) 15:54:01 INFO - ##### 15:54:01 INFO - ##### 15:54:01 INFO - ##### Running read-buildbot-config step. 15:54:01 INFO - ##### 15:54:01 INFO - Running pre-action listener: _resource_record_pre_action 15:54:01 INFO - Running main action method: read_buildbot_config 15:54:01 INFO - Using buildbot properties: 15:54:01 INFO - { 15:54:01 INFO - "project": "", 15:54:01 INFO - "product": "firefox", 15:54:01 INFO - "script_repo_revision": "production", 15:54:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:54:01 INFO - "repository": "", 15:54:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:54:01 INFO - "buildid": "20160715132252", 15:54:01 INFO - "pgo_build": "True", 15:54:01 INFO - "basedir": "/builds/slave/test", 15:54:01 INFO - "buildnumber": 446, 15:54:01 INFO - "slavename": "talos-linux64-ix-018", 15:54:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:54:01 INFO - "platform": "ubuntu64_hw", 15:54:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:54:01 INFO - "branch": "mozilla-aurora", 15:54:01 INFO - "repo_path": "releases/mozilla-aurora", 15:54:01 INFO - "revision": "6893a8d54639abb5d331896858af8a305584c1b6", 15:54:01 INFO - "stage_platform": "linux64-pgo", 15:54:01 INFO - "builduid": "84ab1f9197a146c584cba5f3afaf3b77", 15:54:01 INFO - "slavebuilddir": "test" 15:54:01 INFO - } 15:54:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:54:01 INFO - Running post-action listener: _resource_record_post_action 15:54:01 INFO - ##### 15:54:01 INFO - ##### Finished read-buildbot-config step (success) 15:54:01 INFO - ##### 15:54:01 INFO - ##### 15:54:01 INFO - ##### Running download-and-extract step. 15:54:01 INFO - ##### 15:54:01 INFO - Running pre-action listener: _resource_record_pre_action 15:54:01 INFO - Running main action method: download_and_extract 15:54:01 INFO - mkdir: /builds/slave/test/build/tests 15:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:01 INFO - https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:54:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:54:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:54:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:54:04 INFO - Downloaded 1361 bytes. 15:54:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:54:04 INFO - Using the following test package requirements: 15:54:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:54:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:54:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'jsshell-linux-x86_64.zip'], 15:54:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:54:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:54:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:54:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54: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')]} 15:54:04 INFO - https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:05 INFO - Downloaded 24491019 bytes. 15:54:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:54:06 INFO - Return code: 0 15:54:06 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:54: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')]} 15:54:06 INFO - https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:08 INFO - Downloaded 24491019 bytes. 15:54:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:54:09 INFO - Return code: 0 15:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:09 INFO - https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:12 INFO - Downloaded 10833369 bytes. 15:54:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:54:12 INFO - Return code: 0 15:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:12 INFO - https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:54:13 INFO - Downloaded 63639808 bytes. 15:54:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:54:13 INFO - mkdir: /builds/slave/test/properties 15:54:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:13 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:13 INFO - Contents: 15:54:13 INFO - build_url:https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:54:14 INFO - Running post-action listener: _resource_record_post_action 15:54:14 INFO - Running post-action listener: set_extra_try_arguments 15:54:14 INFO - ##### 15:54:14 INFO - ##### Finished download-and-extract step (success) 15:54:14 INFO - ##### 15:54:14 INFO - ##### 15:54:14 INFO - ##### Running populate-webroot step. 15:54:14 INFO - ##### 15:54:14 INFO - Running pre-action listener: _resource_record_pre_action 15:54:14 INFO - Running main action method: populate_webroot 15:54:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:14 INFO - '--tppagecycles', 15:54:14 INFO - '7'], 15:54:14 INFO - 'tests': ['tsvgm']}}, 15:54:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['damp', 'tps']}, 15:54:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'tests': ['damp', 'tps']}, 15:54:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['dromaeo_dom']}, 15:54:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['a11yr', 15:54:14 INFO - 'ts_paint', 15:54:14 INFO - 'tpaint', 15:54:14 INFO - 'sessionrestore', 15:54:14 INFO - 'sessionrestore_no_auto_restore', 15:54:14 INFO - 'tabpaint']}, 15:54:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['tsvgx', 15:54:14 INFO - 'tsvgr_opacity', 15:54:14 INFO - 'tart', 15:54:14 INFO - 'tscrollx', 15:54:14 INFO - 'cart']}, 15:54:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:14 INFO - 'tsvgr_opacity', 15:54:14 INFO - 'tart', 15:54:14 INFO - 'tscrollx', 15:54:14 INFO - 'cart']}, 15:54:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'talos_options': ['--disable-e10s'], 15:54:14 INFO - 'tests': ['tp5o']}, 15:54:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'tests': ['tp5o']}, 15:54:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'talos_options': ['--disable-e10s', 15:54:14 INFO - '--xperf_path', 15:54:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:14 INFO - 'tests': ['tp5n']}, 15:54:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:14 INFO - 'talos_options': ['--xperf_path', 15:54:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:14 INFO - 'tests': ['tp5n']}}, 15:54:14 INFO - 'talos.zip': {'path': '', 15:54:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:14 INFO - Running post-action listener: _resource_record_post_action 15:54:14 INFO - ##### 15:54:14 INFO - ##### Finished populate-webroot step (success) 15:54:14 INFO - ##### 15:54:14 INFO - ##### 15:54:14 INFO - ##### Running create-virtualenv step. 15:54:14 INFO - ##### 15:54:14 INFO - Running pre-action listener: _resource_record_pre_action 15:54:14 INFO - Running main action method: create_virtualenv 15:54:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:14 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 15:54:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:14 INFO - Using real prefix '/usr' 15:54:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:15 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:17 INFO - Installing pip.................done. 15:54:17 INFO - Return code: 0 15:54:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:54:17 INFO - Using env: {'DISPLAY': ':0', 15:54:17 INFO - 'HOME': '/home/cltbld', 15:54:17 INFO - 'LANG': 'en_US.UTF-8', 15:54:17 INFO - 'LANGUAGE': 'en_US:en', 15:54:17 INFO - 'LOGNAME': 'cltbld', 15:54:17 INFO - 'MAIL': '/var/mail/cltbld', 15:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:17 INFO - 'MOZ_NO_REMOTE': '1', 15:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:17 INFO - 'NO_EM_RESTART': '1', 15:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:17 INFO - 'PWD': '/builds/slave/test', 15:54:17 INFO - 'SHELL': '/bin/bash', 15:54:17 INFO - 'SHLVL': '1', 15:54:17 INFO - 'TERM': 'linux', 15:54:17 INFO - 'TMOUT': '86400', 15:54:17 INFO - 'USER': 'cltbld', 15:54:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:17 INFO - '_': '/tools/buildbot/bin/python'} 15:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:17 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 15:54:17 INFO - Cleaning up... 15:54:17 INFO - Return code: 0 15:54:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:54:17 INFO - Using env: {'DISPLAY': ':0', 15:54:17 INFO - 'HOME': '/home/cltbld', 15:54:17 INFO - 'LANG': 'en_US.UTF-8', 15:54:17 INFO - 'LANGUAGE': 'en_US:en', 15:54:17 INFO - 'LOGNAME': 'cltbld', 15:54:17 INFO - 'MAIL': '/var/mail/cltbld', 15:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:17 INFO - 'MOZ_NO_REMOTE': '1', 15:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:17 INFO - 'NO_EM_RESTART': '1', 15:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:17 INFO - 'PWD': '/builds/slave/test', 15:54:17 INFO - 'SHELL': '/bin/bash', 15:54:17 INFO - 'SHLVL': '1', 15:54:17 INFO - 'TERM': 'linux', 15:54:17 INFO - 'TMOUT': '86400', 15:54:17 INFO - 'USER': 'cltbld', 15:54:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:17 INFO - '_': '/tools/buildbot/bin/python'} 15:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:17 INFO - Downloading/unpacking psutil>=3.1.1 15:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:19 INFO - Installing collected packages: psutil 15:54:19 INFO - Running setup.py install for psutil 15:54:19 INFO - building 'psutil._psutil_linux' extension 15:54:19 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 15:54:19 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 15:54:19 INFO - building 'psutil._psutil_posix' extension 15:54:19 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 15:54:19 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 15:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:19 INFO - Successfully installed psutil 15:54:19 INFO - Cleaning up... 15:54:20 INFO - Return code: 0 15:54:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:20 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:20 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.3'] in /builds/slave/test/build 15:54:20 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.3 15:54:20 INFO - Using env: {'DISPLAY': ':0', 15:54:20 INFO - 'HOME': '/home/cltbld', 15:54:20 INFO - 'LANG': 'en_US.UTF-8', 15:54:20 INFO - 'LANGUAGE': 'en_US:en', 15:54:20 INFO - 'LOGNAME': 'cltbld', 15:54:20 INFO - 'MAIL': '/var/mail/cltbld', 15:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:20 INFO - 'MOZ_NO_REMOTE': '1', 15:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:20 INFO - 'NO_EM_RESTART': '1', 15:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:20 INFO - 'PWD': '/builds/slave/test', 15:54:20 INFO - 'SHELL': '/bin/bash', 15:54:20 INFO - 'SHLVL': '1', 15:54:20 INFO - 'TERM': 'linux', 15:54:20 INFO - 'TMOUT': '86400', 15:54:20 INFO - 'USER': 'cltbld', 15:54:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:20 INFO - '_': '/tools/buildbot/bin/python'} 15:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:22 INFO - Installing collected packages: mozsystemmonitor 15:54:22 INFO - Running setup.py install for mozsystemmonitor 15:54:22 INFO - Successfully installed mozsystemmonitor 15:54:22 INFO - Cleaning up... 15:54:22 INFO - Return code: 0 15:54:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:54:22 INFO - Using env: {'DISPLAY': ':0', 15:54:22 INFO - 'HOME': '/home/cltbld', 15:54:22 INFO - 'LANG': 'en_US.UTF-8', 15:54:22 INFO - 'LANGUAGE': 'en_US:en', 15:54:22 INFO - 'LOGNAME': 'cltbld', 15:54:22 INFO - 'MAIL': '/var/mail/cltbld', 15:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:22 INFO - 'MOZ_NO_REMOTE': '1', 15:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:22 INFO - 'NO_EM_RESTART': '1', 15:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:22 INFO - 'PWD': '/builds/slave/test', 15:54:22 INFO - 'SHELL': '/bin/bash', 15:54:22 INFO - 'SHLVL': '1', 15:54:22 INFO - 'TERM': 'linux', 15:54:22 INFO - 'TMOUT': '86400', 15:54:22 INFO - 'USER': 'cltbld', 15:54:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:22 INFO - '_': '/tools/buildbot/bin/python'} 15:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:24 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:24 INFO - warning: no files found matching '*.txt' 15:54:24 INFO - no previously-included directories found matching 'build' 15:54:24 INFO - no previously-included directories found matching 'dist' 15:54:24 INFO - no previously-included directories found matching '.git*' 15:54:24 INFO - Installing collected packages: jsonschema, functools32 15:54:24 INFO - Running setup.py install for functools32 15:54:24 INFO - warning: no files found matching '*.txt' 15:54:24 INFO - no previously-included directories found matching 'build' 15:54:24 INFO - no previously-included directories found matching 'dist' 15:54:24 INFO - no previously-included directories found matching '.git*' 15:54:24 INFO - Successfully installed jsonschema functools32 15:54:24 INFO - Cleaning up... 15:54:24 INFO - Return code: 0 15:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:24 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:24 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 15:54:24 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 15:54:24 INFO - Using env: {'DISPLAY': ':0', 15:54:24 INFO - 'HOME': '/home/cltbld', 15:54:24 INFO - 'LANG': 'en_US.UTF-8', 15:54:24 INFO - 'LANGUAGE': 'en_US:en', 15:54:24 INFO - 'LOGNAME': 'cltbld', 15:54:24 INFO - 'MAIL': '/var/mail/cltbld', 15:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:24 INFO - 'MOZ_NO_REMOTE': '1', 15:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:24 INFO - 'NO_EM_RESTART': '1', 15:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:24 INFO - 'PWD': '/builds/slave/test', 15:54:24 INFO - 'SHELL': '/bin/bash', 15:54:24 INFO - 'SHLVL': '1', 15:54:24 INFO - 'TERM': 'linux', 15:54:24 INFO - 'TMOUT': '86400', 15:54:24 INFO - 'USER': 'cltbld', 15:54:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:24 INFO - '_': '/tools/buildbot/bin/python'} 15:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:27 INFO - Downloading docopt-0.6.1.tar.gz 15:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:27 INFO - Running setup.py install for blobuploader 15:54:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:27 INFO - Running setup.py install for requests 15:54:28 INFO - Running setup.py install for docopt 15:54:28 INFO - Successfully installed blobuploader requests docopt 15:54:28 INFO - Cleaning up... 15:54:28 INFO - Return code: 0 15:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:28 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:28 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 15:54:28 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 15:54:28 INFO - Using env: {'DISPLAY': ':0', 15:54:28 INFO - 'HOME': '/home/cltbld', 15:54:28 INFO - 'LANG': 'en_US.UTF-8', 15:54:28 INFO - 'LANGUAGE': 'en_US:en', 15:54:28 INFO - 'LOGNAME': 'cltbld', 15:54:28 INFO - 'MAIL': '/var/mail/cltbld', 15:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:28 INFO - 'MOZ_NO_REMOTE': '1', 15:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:28 INFO - 'NO_EM_RESTART': '1', 15:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:28 INFO - 'PWD': '/builds/slave/test', 15:54:28 INFO - 'SHELL': '/bin/bash', 15:54:28 INFO - 'SHLVL': '1', 15:54:28 INFO - 'TERM': 'linux', 15:54:28 INFO - 'TMOUT': '86400', 15:54:28 INFO - 'USER': 'cltbld', 15:54:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:28 INFO - '_': '/tools/buildbot/bin/python'} 15:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:28 INFO - Running setup.py (path:/tmp/pip-hs2WdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:28 INFO - Running setup.py (path:/tmp/pip-QibLMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:28 INFO - Running setup.py (path:/tmp/pip-16MaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:28 INFO - Running setup.py (path:/tmp/pip-Q09J7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:29 INFO - Running setup.py (path:/tmp/pip-w0Bx32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:29 INFO - Running setup.py (path:/tmp/pip-MC65yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:29 INFO - Running setup.py (path:/tmp/pip-5PYZqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:29 INFO - Running setup.py (path:/tmp/pip-6B_miZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:29 INFO - Running setup.py (path:/tmp/pip-9OYS5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:29 INFO - Running setup.py (path:/tmp/pip-46i1yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:29 INFO - Running setup.py (path:/tmp/pip-nHqfI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:29 INFO - Running setup.py (path:/tmp/pip-yb2YhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:29 INFO - Running setup.py (path:/tmp/pip-9KHiKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:29 INFO - Running setup.py (path:/tmp/pip-BgZeuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:29 INFO - Running setup.py (path:/tmp/pip-c3vrql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:29 INFO - Running setup.py (path:/tmp/pip-vFzJjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:29 INFO - Running setup.py (path:/tmp/pip-ByeBPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:29 INFO - Running setup.py install for manifestparser 15:54:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for mozcrash 15:54:30 INFO - Running setup.py install for mozdebug 15:54:30 INFO - Running setup.py install for mozdevice 15:54:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for mozfile 15:54:30 INFO - Running setup.py install for mozhttpd 15:54:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for mozinfo 15:54:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for mozInstall 15:54:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for mozleak 15:54:30 INFO - Running setup.py install for mozlog 15:54:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:30 INFO - Running setup.py install for moznetwork 15:54:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Running setup.py install for mozprocess 15:54:31 INFO - Running setup.py install for mozprofile 15:54:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Running setup.py install for mozrunner 15:54:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Running setup.py install for mozscreenshot 15:54:31 INFO - Running setup.py install for moztest 15:54:31 INFO - Running setup.py install for mozversion 15:54:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:31 INFO - Cleaning up... 15:54:31 INFO - Return code: 0 15:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:31 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')]} 15:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:31 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')]} 15:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:31 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:31 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 15:54:31 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 15:54:31 INFO - Using env: {'DISPLAY': ':0', 15:54:31 INFO - 'HOME': '/home/cltbld', 15:54:31 INFO - 'LANG': 'en_US.UTF-8', 15:54:31 INFO - 'LANGUAGE': 'en_US:en', 15:54:31 INFO - 'LOGNAME': 'cltbld', 15:54:31 INFO - 'MAIL': '/var/mail/cltbld', 15:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:31 INFO - 'MOZ_NO_REMOTE': '1', 15:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:31 INFO - 'NO_EM_RESTART': '1', 15:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:31 INFO - 'PWD': '/builds/slave/test', 15:54:31 INFO - 'SHELL': '/bin/bash', 15:54:31 INFO - 'SHLVL': '1', 15:54:31 INFO - 'TERM': 'linux', 15:54:31 INFO - 'TMOUT': '86400', 15:54:31 INFO - 'USER': 'cltbld', 15:54:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:31 INFO - '_': '/tools/buildbot/bin/python'} 15:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:31 INFO - Running setup.py (path:/tmp/pip-3x70OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:31 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)) 15:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:32 INFO - Running setup.py (path:/tmp/pip-no8pFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:32 INFO - Running setup.py (path:/tmp/pip-RnnqzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:32 INFO - Running setup.py (path:/tmp/pip-hbnYFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:32 INFO - Running setup.py (path:/tmp/pip-FvV2UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:32 INFO - Running setup.py (path:/tmp/pip-agU79U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:32 INFO - Running setup.py (path:/tmp/pip-2ejiaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:32 INFO - Running setup.py (path:/tmp/pip-7jQwuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:32 INFO - Running setup.py (path:/tmp/pip-qF4JXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:32 INFO - Running setup.py (path:/tmp/pip-9UTWnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:32 INFO - Running setup.py (path:/tmp/pip-eBQlzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:32 INFO - Running setup.py (path:/tmp/pip-RHnfgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:32 INFO - Running setup.py (path:/tmp/pip-Ybas_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:32 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:32 INFO - Running setup.py (path:/tmp/pip-wwmxWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:32 INFO - Running setup.py (path:/tmp/pip-hunApo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:33 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)) 15:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:33 INFO - Running setup.py (path:/tmp/pip-Me7wpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:33 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)) 15:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:33 INFO - Running setup.py (path:/tmp/pip-x7Yowx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:33 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)) 15:54:33 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)) 15:54:33 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)) 15:54:33 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)) 15:54:33 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)) 15:54:33 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)) 15:54:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:35 INFO - Downloading blessings-1.6.tar.gz 15:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:35 INFO - Installing collected packages: blessings 15:54:35 INFO - Running setup.py install for blessings 15:54:35 INFO - Successfully installed blessings 15:54:35 INFO - Cleaning up... 15:54:35 INFO - Return code: 0 15:54:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:35 INFO - Reading from file tmpfile_stdout 15:54:35 INFO - Current package versions: 15:54:35 INFO - argparse == 1.2.1 15:54:35 INFO - blessings == 1.6 15:54:35 INFO - blobuploader == 1.2.4 15:54:35 INFO - docopt == 0.6.1 15:54:35 INFO - functools32 == 3.2.3-2 15:54:35 INFO - jsonschema == 2.5.1 15:54:35 INFO - manifestparser == 1.1 15:54:35 INFO - mozInstall == 1.12 15:54:35 INFO - mozcrash == 0.17 15:54:35 INFO - mozdebug == 0.1 15:54:35 INFO - mozdevice == 0.48 15:54:35 INFO - mozfile == 1.2 15:54:35 INFO - mozhttpd == 0.7 15:54:35 INFO - mozinfo == 0.9 15:54:35 INFO - mozleak == 0.1 15:54:35 INFO - mozlog == 3.2 15:54:35 INFO - moznetwork == 0.27 15:54:35 INFO - mozprocess == 0.23 15:54:35 INFO - mozprofile == 0.28 15:54:35 INFO - mozrunner == 6.12 15:54:35 INFO - mozscreenshot == 0.1 15:54:35 INFO - mozsystemmonitor == 0.3 15:54:35 INFO - moztest == 0.7 15:54:35 INFO - mozversion == 1.4 15:54:35 INFO - psutil == 3.1.1 15:54:35 INFO - requests == 1.2.3 15:54:35 INFO - wsgiref == 0.1.2 15:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:35 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 15:54:35 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 15:54:35 INFO - Using env: {'DISPLAY': ':0', 15:54:35 INFO - 'HOME': '/home/cltbld', 15:54:35 INFO - 'LANG': 'en_US.UTF-8', 15:54:35 INFO - 'LANGUAGE': 'en_US:en', 15:54:35 INFO - 'LOGNAME': 'cltbld', 15:54:35 INFO - 'MAIL': '/var/mail/cltbld', 15:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:35 INFO - 'MOZ_NO_REMOTE': '1', 15:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:35 INFO - 'NO_EM_RESTART': '1', 15:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:35 INFO - 'PWD': '/builds/slave/test', 15:54:35 INFO - 'SHELL': '/bin/bash', 15:54:35 INFO - 'SHLVL': '1', 15:54:35 INFO - 'TERM': 'linux', 15:54:35 INFO - 'TMOUT': '86400', 15:54:35 INFO - 'USER': 'cltbld', 15:54:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:35 INFO - '_': '/tools/buildbot/bin/python'} 15:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 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)) 15:54:35 INFO - Cleaning up... 15:54:35 INFO - Return code: 0 15:54:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:35 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 15:54:35 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 15:54:35 INFO - Using env: {'DISPLAY': ':0', 15:54:35 INFO - 'HOME': '/home/cltbld', 15:54:35 INFO - 'LANG': 'en_US.UTF-8', 15:54:35 INFO - 'LANGUAGE': 'en_US:en', 15:54:35 INFO - 'LOGNAME': 'cltbld', 15:54:35 INFO - 'MAIL': '/var/mail/cltbld', 15:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:35 INFO - 'MOZ_NO_REMOTE': '1', 15:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:35 INFO - 'NO_EM_RESTART': '1', 15:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:35 INFO - 'PWD': '/builds/slave/test', 15:54:35 INFO - 'SHELL': '/bin/bash', 15:54:35 INFO - 'SHLVL': '1', 15:54:35 INFO - 'TERM': 'linux', 15:54:35 INFO - 'TMOUT': '86400', 15:54:35 INFO - 'USER': 'cltbld', 15:54:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:35 INFO - '_': '/tools/buildbot/bin/python'} 15:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:35 INFO - Cleaning up... 15:54:35 INFO - Return code: 0 15:54:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:35 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 0x7f5635334f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, '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': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', '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 15:54:35 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 15:54:35 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 15:54:35 INFO - Using env: {'DISPLAY': ':0', 15:54:35 INFO - 'HOME': '/home/cltbld', 15:54:35 INFO - 'LANG': 'en_US.UTF-8', 15:54:35 INFO - 'LANGUAGE': 'en_US:en', 15:54:35 INFO - 'LOGNAME': 'cltbld', 15:54:35 INFO - 'MAIL': '/var/mail/cltbld', 15:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:35 INFO - 'MOZ_NO_REMOTE': '1', 15:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:35 INFO - 'NO_EM_RESTART': '1', 15:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:35 INFO - 'PWD': '/builds/slave/test', 15:54:35 INFO - 'SHELL': '/bin/bash', 15:54:35 INFO - 'SHLVL': '1', 15:54:35 INFO - 'TERM': 'linux', 15:54:35 INFO - 'TMOUT': '86400', 15:54:35 INFO - 'USER': 'cltbld', 15:54:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:35 INFO - '_': '/tools/buildbot/bin/python'} 15:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:36 INFO - Downloading/unpacking flake8 15:54:36 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 15:54:36 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 15:54:36 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 15:54:36 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 15:54:36 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 15:54:36 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 15:54:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:54:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:54:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 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 15:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:38 INFO - no previously-included directories found matching 'docs/_build' 15:54:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:54:38 INFO - Running setup.py install for pep8 15:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:38 INFO - no previously-included directories found matching 'docs/_build' 15:54:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:54:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:54:38 INFO - Cleaning up... 15:54:39 INFO - Return code: 0 15:54:39 INFO - Running post-action listener: _resource_record_post_action 15:54:39 INFO - Running post-action listener: _start_resource_monitoring 15:54:39 INFO - Starting resource monitoring. 15:54:39 INFO - ##### 15:54:39 INFO - ##### Finished create-virtualenv step (success) 15:54:39 INFO - ##### 15:54:39 INFO - ##### 15:54:39 INFO - ##### Running install step. 15:54:39 INFO - ##### 15:54:39 INFO - Running pre-action listener: _resource_record_pre_action 15:54:39 INFO - Running main action method: install 15:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:39 INFO - Reading from file tmpfile_stdout 15:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:39 INFO - Reading from file tmpfile_stdout 15:54:39 INFO - Output received: 15:54:39 INFO - Usage: mozinstall [options] installer 15:54:39 INFO - Options: 15:54:39 INFO - -h, --help show this help message and exit 15:54:39 INFO - -d DEST, --destination=DEST 15:54:39 INFO - Directory to install application into. [default: 15:54:39 INFO - "/builds/slave/test"] 15:54:39 INFO - --app=APP Application being installed. [default: firefox] 15:54:39 INFO - mkdir: /builds/slave/test/build/application 15:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:54:55 INFO - Reading from file tmpfile_stdout 15:54:55 INFO - Output received: 15:54:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:55 INFO - Running post-action listener: _resource_record_post_action 15:54:55 INFO - ##### 15:54:55 INFO - ##### Finished install step (success) 15:54:55 INFO - ##### 15:54:55 INFO - ##### 15:54:55 INFO - ##### Running run-tests step. 15:54:55 INFO - ##### 15:54:55 INFO - Running pre-action listener: _resource_record_pre_action 15:54:55 INFO - Running main action method: run_tests 15:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:55 INFO - Python 2.7.3 15:54:55 INFO - Return code: 0 15:54:55 INFO - grabbing minidump binary from tooltool 15:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:55 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71c0>, '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 0x10c80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:55 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 15:54:55 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 15:54:55 INFO - Calling ['/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'] with output_timeout 600 15:54:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:55 INFO - Return code: 0 15:54:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:54:56 INFO - Return code: 0 15:54:56 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/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 15:54:56 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/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:56 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/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 15:54:56 INFO - mozversion application_buildid: 20160715132252 15:54:56 INFO - mozversion application_changeset: 6893a8d54639abb5d331896858af8a305584c1b6 15:54:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:56 INFO - mozversion application_name: Firefox 15:54:56 INFO - mozversion application_remotingname: firefox-dev 15:54:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:56 INFO - mozversion application_vendor: Mozilla 15:54:56 INFO - mozversion application_version: 49.0a2 15:54:56 INFO - mozversion platform_buildid: 20160715132252 15:54:56 INFO - mozversion platform_changeset: 6893a8d54639abb5d331896858af8a305584c1b6 15:54:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:56 INFO - mozversion platform_version: 49.0a2 15:54:56 INFO - using testdate: 1468623296 15:54:56 INFO - actual date: 1468623296 15:54:56 INFO - starting webserver on 'localhost:37431' 15:54:56 INFO - SUITE-START | Running 2 tests 15:54:56 INFO - TEST-START | dromaeo_css 15:54:56 INFO - operating with platform_type : linux_ 15:54:56 INFO - Initialising browser for dromaeo_css test... 15:54:56 INFO - TEST-INFO | started process 27237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQZOP8/profile http://localhost:37431/getInfo.html) 15:55:00 INFO - PROCESS | 27237 | __metrics Screen width/height:1600/1200 15:55:00 INFO - PROCESS | 27237 | colorDepth:24 15:55:00 INFO - PROCESS | 27237 | Browser inner width/height: 1024/697 15:55:00 INFO - PROCESS | 27237 | __metrics 15:55:01 ERROR - PROCESS | 27237 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:55:02 INFO - TEST-INFO | 27237: exit 0 15:55:02 INFO - Browser initialized. 15:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:02 INFO - TEST-INFO | started process 27367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQZOP8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:13 INFO - PROCESS | 27367 | RSS: Main: 156377088 15:55:13 INFO - PROCESS | 27367 | 15:56:03 INFO - PROCESS | 27367 | 1468623363437 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] 15:58:11 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37431/tests/dromaeo/cssquery-ext.html) 15:58:12 INFO - PROCESS | 27367 | RSS: Main: 160493568 15:58:12 INFO - PROCESS | 27367 | 16:01:14 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-ext.html (next: http://localhost:37431/tests/dromaeo/cssquery-jquery.html) 16:01:15 INFO - PROCESS | 27367 | RSS: Main: 157822976 16:01:15 INFO - PROCESS | 27367 | 16:04:17 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37431/tests/dromaeo/cssquery-mootools.html) 16:04:17 INFO - PROCESS | 27367 | RSS: Main: 157716480 16:04:17 INFO - PROCESS | 27367 | 16:07:19 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37431/tests/dromaeo/cssquery-prototype.html) 16:07:20 INFO - PROCESS | 27367 | RSS: Main: 157163520 16:07:20 INFO - PROCESS | 27367 | 16:10:22 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37431/tests/dromaeo/cssquery-yui.html) 16:10:23 INFO - PROCESS | 27367 | RSS: Main: 159064064 16:10:23 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | Cycle 1(1): loaded http://localhost:37431/tests/dromaeo/cssquery-yui.html (next: http://localhost:37431/tests/dromaeo/cssquery-dojo.html) 16:13:25 INFO - PROCESS | 27367 | RSS: Main: 159064064 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | __start_tp_report 16:13:25 INFO - PROCESS | 27367 | _x_x_mozilla_page_load 16:13:25 INFO - PROCESS | 27367 | _x_x_mozilla_page_load_details 16:13:25 INFO - PROCESS | 27367 | |i|pagename|runs| 16:13:25 INFO - PROCESS | 27367 | |0;dojo.html;3387.2548039431326;3417.6582341765825;3421.349943510731;3434.8797792077276;3437.295354452336;5638.7180640967945;5681.914771278429;5702.657840529566;5724.34170070442;5745.540356771458;5665.490105890469;5743.885122297552;5746.367899531048;5753.856153596163;5788.942110578893;5186.1442861927835;5217.478252174771;5233.73831308435;5301.390340110898;5313.017091838003;5139.640225184238;5140.485951404867;5257.395399529046;5258.789648414059;5273.235380869772;5219.608529360295;5234.37187537496;5238.188080847474;5244;5296.602754793406;5242.2136679498;5256.92114618281;5289.418164001957;5308.92036619451;5311.601629877736;5050.393952725696;5164.8967020659375;5203.843884683465;5281.419043905167;5282.339707536558;5467.45325467454;5500.6424582402415;5533.916991245094;5559.861003474905;5572.442755724435;6024.337322894478;6054.606450580743;6067.848303792396;6079.361667024988;6095.756169753205;5955.970220148914;6128.533679014772;6134.079888016833;6137.9079313810325;6151.569390142692;5763.308402991626;5847.824565263007;5849.181114643953;5850.473457388855;5884.0585506318785;6348.111264422984;6387.169667943138;6389.361063893666;6394.776182833579;6409.583377080568;5885.793997210077;5930.169776231331;5964;6047.973893924141;6121.173641558422;6125.41859352575;6142;6146.754129834846;6160.9383906160365;6162.476189523851;6059.575829691879;6075.756969721162;6095.869220251668;6104.4200800923845;6110.175126357974;5927.8221653350465;6048.6673232971725;6063.120847477091;6081.2094427725;6081.8479538011015;4666.300054991779;4669.929951050737;4676.719396836201;4690.507496712796;4702.694324868872;4163.208990291835;4182.477190351206;4189.350650649093;4217.62041416274;4222.59885310895;5692.459216374438;5738.483536481736;5831.241938547962;5859.267591551056;5914.940850591525;6134.436587033385;6152.230971128609;6198.690065496708;6286.057091436322;6287.748490060347;5724.112762521816;5933.3769954154195;5937.851553711192;5956.374580669054;5987.700614969234;5142.382914050263;5163.457836927144;5203.427622961472;5229.241759944863;5242.344706911636;6424.646644434601;6438.645874476855;6458.354164583504;6480.449161821298;6481.449076828428;6019.51843852482;6067.302260239952;6151.5386346025125;6170.136180934583;6181.660008699475;6275.623462592259;6455;6462.967685161544;6474.384933431316;6475.417212450902;6044.335123136363;6061;6071.5446341523675;6071.787487437919;6098.26820781509;5980.641161530322;6124.991279909952;6144.15675297418;6183.288921774054;6188.628682278898;6121.361519882508;6131.453899293208;6132.715802922644;6133.095051491898;6144;6116.092308610808;6116.707414839581;6127.617148554337;6127.922628246602;6131.289237556246;5780.710964451845;5832.154337621106;5870.295564532284;5892.086726557391;6061.181740465157;5994.3705910878725;6033.155358249936;6033.276006879202;6074.787382441594;6074.969625152023;5925.851853703692;5936.554758393051;5939.881202376015;5940.61386009908;5942.10868369748 16:13:25 INFO - PROCESS | 27367 | |1;ext.html;609.8444896551382;670.9700609564318;674.0428591400212;677.3497442455242;691.6783695581554;46560.53439465608;48307.27539086917;48539.75730121353;48603.51396486034;51826;49153;49651;49682;49765;49881.75059124708;9083.227925626314;9197.540122993856;9230.492322922237;9250;9272.953635231814;9066.682666106688;9188.632454701803;9195.172434480895;9204.447733136;9222.631094756236;9179.49512776797;9195.632174713004;9197;9238.76903077425;9247.398919070272;9181.678641247558;9194.310426718022;9220.953895230548;9260.351775375726;9270.49012304323;9053.90946090544;9172.816543669156;9184.586693598803;9197.724068277963;9225.077492250788;46491;46860.297095543596;46882.06235875298;46936;46956.76521617404;3886.689064874803;3979.621935916083;4011.3782363733667;4162.979185104085;4609.3777340059;33619.32761344784;34241;34724.13189670253;34793.82603086994;34986.825065874764;4671.88320291992;4792.113459010059;4823.5658790709;4825.831095911662;4852.660313778037;406603;406752.99999999703;407411;409527;410537;39822.60177398247;65232.347676523576;65277.673611632585;65788;65844.34155658478;40935.38596921049;40987.180256394706;41080.794596026826;41106.38340424896;41123.588764112574;17501.47495575135;17748.55628609269;17762;17770.111494425226;17783.28866845312;15047;15118.395264189308;15130.319135638923;15136.924315378574;15166.393344266105;9052.683156089506;9184.12750788674;9190.58642361082;9248.861267081;9259.398139120936;3502.141975216088;3532.876349327761;3566.4293713005795;3589.9820500897326;3593.838277277529;1085.6091806949491;1182.1665725663559;1184.3959580613948;1186.525389844052;1230.9322987235787;32954;33497;34182.31635367279;34402.827985860415;34745.30509389798;1184.6090790039266;1190.381001879018;1201.3572738584814;1221.4930803716359;1248.5879659712455;17488.475345739647;17649.38227162043;17885.28458861657;18060.458186254433;18138.09309534518;641856;642825;650174;651952;652044;65653.671731642;65900.34099659038;65997.34002659912;66029.33970660328;66277.33722662808;1427.2578259305103;1443.3996095150749;1454.425501926733;1504.8946573739734;1511.1008949674926;33370.4994425079;33389.16527086842;33860.32279354448;33880.15299617529;34585.65414345825;66955.66522167358;68309.3169068303;68465;68744;74508;540983;556808;557126;557645;559235;50828.74585627196;52066.219006715684;52261.73869130782;52323;52785;55208.72395637996;55243.72378138245;55388.44611553833;55467.167992479335;55728.442715572324;48511.75744121257;48609.756951216434;48970;49691.75154124206;50340;47490.76254618705;47995.28007079827;48028.75985620049;48413.5158648409;48736.75631621819;40189.397159042055;46867.531324686315;47546.762266188445;47887.28169077397;48572.757136214095;39572.604273956895;41161;41873.37189942093;42667.78666106649;42773;30190.69809301879;31439.21401964969;31732.524012139376;31988.520172197903;32222.677773221967 16:13:25 INFO - PROCESS | 27367 | |2;jquery.html;414.63926384045885;415.7900260368514;421.67952356209275;422.93233082706763;426.1285670803207;18830.623387532258;19588;20401.387958361236;20556.07497662605;20598.691019634716;12512.499500019989;17219.91390043051;17757.467275981708;17854.196561154746;18457.813558646536;5349.839504814852;5542.501174894259;5545.833624991256;5556.083246264382;5591.832245032656;5480.232767412565;5515.117581187011;5522.116461366182;6007.609505382136;6019.5485338599565;5973;5978.910316345258;5993.250843644544;5995.340512543638;6015.669138197398;5707.857303567403;5882.941170588282;5913.615614985012;5931.080682494198;5991.221141251631;5369.838904832861;5376.40859505458;5381.919271210935;5386.973065134688;5411.864703382447;14682.412703491955;14712.55862324132;14722.631934201623;14766.335514901855;15142.394304227817;2296.7358753743365;2373.8813059346962;2468.1978357034036;2680.5711086226306;2763.350612606036;10748.838767418494;11089.112870970303;11130.05394541465;12771.805430382447;15026.098434093989;1988.413418041681;2077.096463038583;2086.634838903201;2107.3677896630948;2117.301290574107;74202.25797742007;77231;77377.99999999943;83619;86395.56802216012;11691.240069395632;11832.935035846644;11978.640640780617;12026.4588093536;12032.435783348108;16871.662566748597;16872.493825185265;16890.915545422195;16999.91500042492;17044.403445879336;7240.710371585077;8566.271866891384;8856.557172141496;8991.235744961752;9283;9051.366404351633;9074.230525047553;9081.318901082444;9188.081191880758;9203.723888283363;5007.424146223231;5101.69389836611;5179.352580927384;5218.6868787872845;5300.257963885059;2094.937151885446;2122.7771084035953;2135.55153417784;2157.568486302746;2193.6819161221533;1029.2332212501585;1072.051234657334;1074.7689246811817;1090.1769164280918;1099.9505022274018;18823.435296941112;19601.901990489958;19935.24537413516;21432.357029289145;21442.463938401666;1008.9798204035878;1046.4872212615915;1050.9579616815395;1138.9772204556027;1143.982840257397;11163.776724465466;11438.771224575461;11457.770844583061;11579.594714184963;11637.941810290895;556232;561277;571780;571984;574945;99811;99924.50037749765;101058;101782.49108754408;102524;1122.5453691255054;1135.6479491357707;1138.2942575603179;1138.4194061028934;1146.5471138900089;17934.5516362092;18153.727694084337;18278.360257390927;18493.445196644123;18546;38335.23329533338;44080.77959610181;44605.88485287894;44766.55233447624;45203.095938081715;55041;55569;55733.44266557445;59991.70004149951;60624.696876515336;8767.649294028168;8841.911580884109;8923.866142008004;9032.322575806973;9318.72043838686;12099.395030248628;12808.743825123633;13646.454141834216;13785.586432407044;13862;12012.819807702717;12173.330466824409;12465.439055242354;12651.93674031624;12686.175398599062;12237.75524489523;12456.937715311366;12602.936985315382;12682.682932926751;12968.35158242103;12356.938215308866;12374.62876113718;12403.25580465175;12447.813282800946;12579.119461637598;8876.201141897001;9253.213476854542;9341.626334946526;9360.719178424659;9442.905570944202;9753.804923901624;12839.807402889151;12873;13027.08810383264;13044.086913915935 16:13:25 INFO - PROCESS | 27367 | |3;mootools.html;1561.1023661394702;1610;1772.450540332497;1879.2201236486858;1910.1881700277388;8625.353098517606;9256.259499240054;9294.256459483242;9935.304528682995;9942.304038717293;9333.113354231336;9664.323497355188;9674.177694895925;9735.51322433879;9805.36265142767;2426.6360045993065;2464.8151388645833;2475.3811547113223;2476.789472894797;2484.7515248475097;2442.4748679034005;2534.5057713745828;2534.7845433138204;2539.3778524261584;2544.694636643596;2505.235903049569;2517.5342561626067;2523.3565440812567;2530.936726581841;2531.190019193859;2479.665245191903;2490.576601977677;2494.1395218649536;2496.700395952479;2524.469861329123;2399.3161948844495;2422.2369953464604;2452.043702955849;2455.373879660675;2460.729319774823;9646.035396460367;9678.56446459911;9743.269254805919;9755.268354873413;9772.706818795448;5593.804216852391;5739.053056245714;5745.368009518949;5793.304803423616;5805.912911306334;3557.8932632021083;3580.8720253120446;3621.2214373909737;3848.9230215395814;3860.613938606145;1197.6107764976418;1213.9757204855853;1218.878112188783;1223.6512593910693;1238.8265642810013;13599.728005439836;13693.315334233248;13719.519816806463;13775.793363099561;13776.10455320401;4988.8752781180765;5035.723035233024;5098.617603679739;5181.5077567631015;5224.399194092652;11459.713507162387;11500.367479788692;11515.078793696484;11517.251378660529;11571.074314054855;5861.3552509223955;5881.235439392852;5895.764169433261;5915.733791979371;5927.436893495111;4797.064572408347;5285.233641122016;5403.2705584746345;5469.453054694499;5478.342598888079;4436.0906014267;4445.066536027471;4540.432445944257;4546.795394207203;4555.453345598549;1355.6475316417802;1394.219237227156;1419.1059632431502;1427.557457188275;1427.8857691384665;1027.0294571629738;1092.8633920759905;1116.4864162485349;1122.6800361896983;1148.17905197784;6794.898076528856;6839.794806155824;6900.896486552706;6935.930640693528;6995.755148569776;495.68276303166004;504.55094965480754;505.59804955060815;513.4480433533965;522.4357693690805;4782.187028205213;4789.161896668139;4789.664723469324;4820.590249828804;4861.392325959255;11877.22798018126;12172.878271217174;12263.754724905451;12276.938615306866;12277.631671049883;11907.702307442383;12335.568255111028;12340;12365.38173091342;12462.314572698408;8910.465372077697;9090.681826136053;9153.67962121336;9161.450312981242;9181.403208791407;6837.3162683731225;7018;7067.6819543119655;7114.750983715545;7119.85760284781;11218.887811121784;11310.886891131313;11450.599229026944;11459.140564457866;11576.073914087021;11474.827877582009;11483.712907177387;11641.126915481542;11694.70763230926;11823.82264266054;7840.607969601383;8402;8627.784305392164;8831.337649676172;8931.285497160341;9604.711858644252;9644.083812037845;9665.661701840683;9680.709578712649;9735.513224338896;8255.752327430188;8464.661413543636;8707.608157633049;8805.075467076122;8830.470171789713;8002.83994320122;8006.599670016592;8028.759137225892;8101.8379632408205;8140.715074972348;7570.280823321776;7707.460477766503;7719.228077192236;7767.456278060482;7773.222677732181;5678.630888992202;5819.679917604403;5880.353161152356;5908.084246941731;5923.822285331447;5795.217645617788;5816;5827.621204621686;5831.096180092092;5854.765809367577 16:13:25 INFO - PROCESS | 27367 | |4;prototype.html;351.9841607127679;353.99292014159715;358.9389803733367;361.3694103788887;362.7587654209951;5722.885542289152;5763.711814409273;5765.45228203321;5797.739101740426;5828.417158284169;5687.658740475575;5692.6299790513585;5707.4577915098;5756.510696590784;5765.884682306351;4302.698811083225;4470.770538102015;4482.453553524046;4490.259107247317;4499.955000449986;4446.465514656647;4481.288820263742;4485.439320084989;4487.237169681162;4523.213330734358;4458.643308535309;4495.258282383403;4511.819527218908;4512.819487220508;4522.6155776759015;4412.779361031951;4429.9778501107285;4434.268345722936;4437.245668236375;4441.9111617767785;3842.3083844907906;3856.1709232515145;3874.9806250968563;3902.043999220181;3946.782926939017;5594.636348637367;5604.887902241973;5606.271184745998;5620.4660557247;5678.176664383683;4907.484714105003;5093.465186155475;5097.668651537638;5112.539871411591;5131.153359695646;6078.665673387962;6083.48290395317;6101.359357267467;6103.6032657877095;6141.877162456771;4351.760653164075;4359.520452750195;4362.432883725127;4385.495667998157;4388.912221755547;5912.580980564633;6026.397360263983;6187.845303867394;6190.628562286277;6284.560080794392;4370.606645401929;4402.691811573159;4402.867913962522;4405.559444055633;4439.334099884978;4470.061287129739;4472.217361961643;4479.260921947907;4486.5962063414445;4487.977560112178;4887.682300650446;5104.2088476286235;5146.588272938156;5161.535461808456;5186.559142472856;6017.518598512109;6043.546733994968;6047.969760151171;6064;6072.419221830704;1528.312259483237;1545.65995480994;1549.2486144220045;1556.3229994952005;1558.6648870492897;948.7912659214961;965.2278177458146;982;991.3308516751164;1001.3191030099603;5203.869903252449;5230.92153617696;5234.398044224887;5255.29203009016;5273.868153296198;5507.7246137692955;5525.723713814293;5532.478568393643;5544.972275138599;5553.527950124204;4983.878627308826;5270.472952704698;5276.366835979707;5324;5343.557239545301;2961.570572267009;2967.866446009935;2974.4199881023424;2995.415893900712;3000.534917087855;5686.601937864392;5774.94225057744;5837.7664893404635;5857.736401861926;5871.500922421642;5892.7642894283745;6373.235211774617;6383.616982981036;6402.295747467775;6421.165248517663;6456.580322279036;6523.934760652332;6526.967365163144;6544.658345039351;6558.950567909112;6035;6243.250809902841;6269.96865015672;6277.12120303167;6282.2147231596055;5907.40925907423;6149.2313460817395;6184.381561843959;6194.535409844189;6205.596636218631;6480.282725077764;6497.935020649922;6555.672216389257;6563.245226798788;6572.521182733846;4528.592426681483;4544.681872269041;4565.223911935045;4570.817167313403;4582.633389328912;6104.7485265521345;6221.44463884029;6263.96868015657;6269.592476489013;6320;6065.029595264737;6078.629334559614;6078.969605151946;6079.969600151971;6119.3268740437625;5812.692144267506;5988.610740301867;6027.57806953509;6028.969855150872;6074.969625151846;5896.292444906467;5931;5954.46409823118;5954.707437636454;5999.310079340931;6048.153258543719;6055.2733671957885;6059.787907423219;6063;6084.969575152096;5741.971290143522;5914.378990205966;5952.035828176778;5961.225040744675;5976.970115149396 16:13:25 INFO - PROCESS | 27367 | |5;yui.html;796.3987189671797;826.6445428465757;880.4321212817732;896.2247655777754;906.1844340093915;14819.703605927874;16119.91940040301;16213.946093503928;16273.593160171002;16369.754453683205;15032.398704051851;15119.924400377982;15203.315850786714;15293.2353382331;15335.769963450557;849.8895143631335;853.117023880284;859.8323326951247;859.8366310401035;860.2816648098845;827.2596026556258;879.0198928195049;883.9204471597554;885.420049867338;888.076400543434;917.7567944494714;920.484528663947;924.1543987251657;926.874871892296;927.420362273579;911.6262332443732;919.0992827029515;923.8798956135727;924.1405492891608;924.505389616552;672.2135101930753;674.2280089297726;677.0284641539407;677.9694913728845;680.4420375292262;16774.161291935354;16824;16843.915780421143;16848.24182911772;16892.746608800877;14547.563573092824;14859.851401485956;15084;15131.773023404548;15817.841821581753;13854.653633659138;13962.162270263816;14398;14691.338889749986;15001;4792.089502994455;4798.688085274446;4813.061453016663;4855.514448555152;4888.70667759932;78365;79564.99999999942;80572;81107.5944620279;81433.37133257302;12134.332611706264;12376.319302438453;12397;12398.75202495945;12651.114421990373;21544.89227553852;21561.89219053926;21576.784232157792;21635.891820540797;21651.24220652301;8623.784405389915;8660.610272537624;8726.25826804716;8924.955375223211;9131.086891310815;4944.406671199479;5021.824236151717;5023.171176755867;5169.3796744390165;5194.740262986911;3476.37425263455;3560.839762210707;3578.4274516077303;3581.033121057352;3584.301061293075;655.5116438253532;671.392389887153;674.3627272227698;674.4199988010307;700.250731717068;746.9551826890296;751.7669522447949;753.7399597138979;753.9962300188464;777.7122464688101;9652.27607929408;9692.32153749245;9906.257030722725;9972.152367048882;10067.5469603868;651.0837313558947;671.4796033074309;679.5481005131631;740.870347689163;761.4859969520552;4530.139273538017;4563.703359281636;4593.805142110893;4608.861734147914;4613.0773845230415;119737;119952.40023799826;123238;125392.37303813423;126192;66457.33542664608;94671.52664236772;102653.48673256586;102946;104099.479502602;90711.54644226737;90744;91493.54253228825;92940.53529732308;94350;9347.392419492711;9405.764855878384;9442.960796892805;9620.855687164558;9642.228621710387;55305.17042244289;55341;56030.43969560252;56198;57660.13509797272;70533.64733176302;72303.63848180725;82480.17519824725;82894;83409;11750.883666051712;11969.760604788029;11997.76004479923;12009.39953002329;12106.878931210575;13081.738365232832;13172.47310107585;13206.80189797173;13569.389377477839;13907.37416816266;12578.811317830057;12695;12716.173448725804;12824.487020519075;13059.869401305865;12628.368581571069;12781.552645657357;12836.486540538648;12855.550055748005;12898.097133200587;12250.142490025613;12335.259884406963;12380.690482738004;12384.75230495367;12419.254844709347;10357.689269321932;10524.52639631203;10596.947015265183;10665.8933410668;10685.679429617125;10351.689449316533;10398.076196911315;10826.188035897181;10897.291676041032;10906.127509799355 16:13:25 INFO - PROCESS | 27367 | __end_tp_report 16:13:25 INFO - PROCESS | 27367 | __start_cc_report 16:13:25 INFO - PROCESS | 27367 | _x_x_mozilla_cycle_collect,357 16:13:25 INFO - PROCESS | 27367 | __end_cc_report 16:13:25 INFO - PROCESS | 27367 | __startTimestamp1468624405362__endTimestamp 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | ------- Summary: start ------- 16:13:25 INFO - PROCESS | 27367 | Number of tests: 6 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#0] dojo.html Cycles:165 Average:5713.68 Median:5939.88 stddev:647.77 (10.9%) stddev-sans-first:623.52 16:13:25 INFO - PROCESS | 27367 | Values: 3387.3 3417.7 3421.3 3434.9 3437.3 5638.7 5681.9 5702.7 5724.3 5745.5 5665.5 5743.9 5746.4 5753.9 5788.9 5186.1 5217.5 5233.7 5301.4 5313.0 5139.6 5140.5 5257.4 5258.8 5273.2 5219.6 5234.4 5238.2 5244.0 5296.6 5242.2 5256.9 5289.4 5308.9 5311.6 5050.4 5164.9 5203.8 5281.4 5282.3 5467.5 5500.6 5533.9 5559.9 5572.4 6024.3 6054.6 6067.8 6079.4 6095.8 5956.0 6128.5 6134.1 6137.9 6151.6 5763.3 5847.8 5849.2 5850.5 5884.1 6348.1 6387.2 6389.4 6394.8 6409.6 5885.8 5930.2 5964.0 6048.0 6121.2 6125.4 6142.0 6146.8 6160.9 6162.5 6059.6 6075.8 6095.9 6104.4 6110.2 5927.8 6048.7 6063.1 6081.2 6081.8 4666.3 4669.9 4676.7 4690.5 4702.7 4163.2 4182.5 4189.4 4217.6 4222.6 5692.5 5738.5 5831.2 5859.3 5914.9 6134.4 6152.2 6198.7 6286.1 6287.7 5724.1 5933.4 5937.9 5956.4 5987.7 5142.4 5163.5 5203.4 5229.2 5242.3 6424.6 6438.6 6458.4 6480.4 6481.4 6019.5 6067.3 6151.5 6170.1 6181.7 6275.6 6455.0 6463.0 6474.4 6475.4 6044.3 6061.0 6071.5 6071.8 6098.3 5980.6 6125.0 6144.2 6183.3 6188.6 6121.4 6131.5 6132.7 6133.1 6144.0 6116.1 6116.7 6127.6 6127.9 6131.3 5780.7 5832.2 5870.3 5892.1 6061.2 5994.4 6033.2 6033.3 6074.8 6075.0 5925.9 5936.6 5939.9 5940.6 5942.1 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#1] ext.html Cycles:180 Average:70599.20 Median:26426.16 stddev:145328.50 (549.9%) stddev-sans-first:145641.18 16:13:25 INFO - PROCESS | 27367 | Values: 609.8 671.0 674.0 677.3 691.7 46560.5 48307.3 48539.8 48603.5 51826.0 49153.0 49651.0 49682.0 49765.0 49881.8 9083.2 9197.5 9230.5 9250.0 9273.0 9066.7 9188.6 9195.2 9204.4 9222.6 9179.5 9195.6 9197.0 9238.8 9247.4 9181.7 9194.3 9221.0 9260.4 9270.5 9053.9 9172.8 9184.6 9197.7 9225.1 46491.0 46860.3 46882.1 46936.0 46956.8 3886.7 3979.6 4011.4 4163.0 4609.4 33619.3 34241.0 34724.1 34793.8 34986.8 4671.9 4792.1 4823.6 4825.8 4852.7 406603.0 406753.0 407411.0 409527.0 410537.0 39822.6 65232.3 65277.7 65788.0 65844.3 40935.4 40987.2 41080.8 41106.4 41123.6 17501.5 17748.6 17762.0 17770.1 17783.3 15047.0 15118.4 15130.3 15136.9 15166.4 9052.7 9184.1 9190.6 9248.9 9259.4 3502.1 3532.9 3566.4 3590.0 3593.8 1085.6 1182.2 1184.4 1186.5 1230.9 32954.0 33497.0 34182.3 34402.8 34745.3 1184.6 1190.4 1201.4 1221.5 1248.6 17488.5 17649.4 17885.3 18060.5 18138.1 641856.0 642825.0 650174.0 651952.0 652044.0 65653.7 65900.3 65997.3 66029.3 66277.3 1427.3 1443.4 1454.4 1504.9 1511.1 33370.5 33389.2 33860.3 33880.2 34585.7 66955.7 68309.3 68465.0 68744.0 74508.0 540983.0 556808.0 557126.0 557645.0 559235.0 50828.7 52066.2 52261.7 52323.0 52785.0 55208.7 55243.7 55388.4 55467.2 55728.4 48511.8 48609.8 48970.0 49691.8 50340.0 47490.8 47995.3 48028.8 48413.5 48736.8 40189.4 46867.5 47546.8 47887.3 48572.8 39572.6 41161.0 41873.4 42667.8 42773.0 30190.7 31439.2 31732.5 31988.5 32222.7 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#2] jquery.html Cycles:180 Average:31510.06 Median:2120.04 stddev:93285.82 (4400.2%) stddev-sans-first:93518.29 16:13:25 INFO - PROCESS | 27367 | Values: 414.6 415.8 421.7 422.9 426.1 18830.6 19588.0 20401.4 20556.1 20598.7 12512.5 17219.9 17757.5 17854.2 18457.8 5349.8 5542.5 5545.8 5556.1 5591.8 5480.2 5515.1 5522.1 6007.6 6019.5 5973.0 5978.9 5993.3 5995.3 6015.7 5707.9 5882.9 5913.6 5931.1 5991.2 5369.8 5376.4 5381.9 5387.0 5411.9 14682.4 14712.6 14722.6 14766.3 15142.4 2296.7 2373.9 2468.2 2680.6 2763.4 10748.8 11089.1 11130.1 12771.8 15026.1 1988.4 2077.1 2086.6 2107.4 2117.3 74202.3 77231.0 77378.0 83619.0 86395.6 11691.2 11832.9 11978.6 12026.5 12032.4 16871.7 16872.5 16890.9 16999.9 17044.4 7240.7 8566.3 8856.6 8991.2 9283.0 9051.4 9074.2 9081.3 9188.1 9203.7 5007.4 5101.7 5179.4 5218.7 5300.3 2094.9 2122.8 2135.6 2157.6 2193.7 1029.2 1072.1 1074.8 1090.2 1100.0 18823.4 19601.9 19935.2 21432.4 21442.5 1009.0 1046.5 1051.0 1139.0 1144.0 11163.8 11438.8 11457.8 11579.6 11637.9 556232.0 561277.0 571780.0 571984.0 574945.0 99811.0 99924.5 101058.0 101782.5 102524.0 1122.5 1135.6 1138.3 1138.4 1146.5 17934.6 18153.7 18278.4 18493.4 18546.0 38335.2 44080.8 44605.9 44766.6 45203.1 55041.0 55569.0 55733.4 59991.7 60624.7 8767.6 8841.9 8923.9 9032.3 9318.7 12099.4 12808.7 13646.5 13785.6 13862.0 12012.8 12173.3 12465.4 12651.9 12686.2 12237.8 12456.9 12602.9 12682.7 12968.4 12356.9 12374.6 12403.3 12447.8 12579.1 8876.2 9253.2 9341.6 9360.7 9442.9 9753.8 12839.8 12873.0 13027.1 13044.1 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#3] mootools.html Cycles:180 Average:6449.84 Median:2678.54 stddev:3714.81 (138.7%) stddev-sans-first:3707.07 16:13:25 INFO - PROCESS | 27367 | Values: 1561.1 1610.0 1772.5 1879.2 1910.2 8625.4 9256.3 9294.3 9935.3 9942.3 9333.1 9664.3 9674.2 9735.5 9805.4 2426.6 2464.8 2475.4 2476.8 2484.8 2442.5 2534.5 2534.8 2539.4 2544.7 2505.2 2517.5 2523.4 2530.9 2531.2 2479.7 2490.6 2494.1 2496.7 2524.5 2399.3 2422.2 2452.0 2455.4 2460.7 9646.0 9678.6 9743.3 9755.3 9772.7 5593.8 5739.1 5745.4 5793.3 5805.9 3557.9 3580.9 3621.2 3848.9 3860.6 1197.6 1214.0 1218.9 1223.7 1238.8 13599.7 13693.3 13719.5 13775.8 13776.1 4988.9 5035.7 5098.6 5181.5 5224.4 11459.7 11500.4 11515.1 11517.3 11571.1 5861.4 5881.2 5895.8 5915.7 5927.4 4797.1 5285.2 5403.3 5469.5 5478.3 4436.1 4445.1 4540.4 4546.8 4555.5 1355.6 1394.2 1419.1 1427.6 1427.9 1027.0 1092.9 1116.5 1122.7 1148.2 6794.9 6839.8 6900.9 6935.9 6995.8 495.7 504.6 505.6 513.4 522.4 4782.2 4789.2 4789.7 4820.6 4861.4 11877.2 12172.9 12263.8 12276.9 12277.6 11907.7 12335.6 12340.0 12365.4 12462.3 8910.5 9090.7 9153.7 9161.5 9181.4 6837.3 7018.0 7067.7 7114.8 7119.9 11218.9 11310.9 11450.6 11459.1 11576.1 11474.8 11483.7 11641.1 11694.7 11823.8 7840.6 8402.0 8627.8 8831.3 8931.3 9604.7 9644.1 9665.7 9680.7 9735.5 8255.8 8464.7 8707.6 8805.1 8830.5 8002.8 8006.6 8028.8 8101.8 8140.7 7570.3 7707.5 7719.2 7767.5 7773.2 5678.6 5819.7 5880.4 5908.1 5923.8 5795.2 5816.0 5827.6 5831.1 5854.8 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#4] prototype.html Cycles:180 Average:5020.11 Median:5682.39 stddev:1487.93 (26.2%) stddev-sans-first:1450.27 16:13:25 INFO - PROCESS | 27367 | Values: 352.0 354.0 358.9 361.4 362.8 5722.9 5763.7 5765.5 5797.7 5828.4 5687.7 5692.6 5707.5 5756.5 5765.9 4302.7 4470.8 4482.5 4490.3 4500.0 4446.5 4481.3 4485.4 4487.2 4523.2 4458.6 4495.3 4511.8 4512.8 4522.6 4412.8 4430.0 4434.3 4437.2 4441.9 3842.3 3856.2 3875.0 3902.0 3946.8 5594.6 5604.9 5606.3 5620.5 5678.2 4907.5 5093.5 5097.7 5112.5 5131.2 6078.7 6083.5 6101.4 6103.6 6141.9 4351.8 4359.5 4362.4 4385.5 4388.9 5912.6 6026.4 6187.8 6190.6 6284.6 4370.6 4402.7 4402.9 4405.6 4439.3 4470.1 4472.2 4479.3 4486.6 4488.0 4887.7 5104.2 5146.6 5161.5 5186.6 6017.5 6043.5 6048.0 6064.0 6072.4 1528.3 1545.7 1549.2 1556.3 1558.7 948.8 965.2 982.0 991.3 1001.3 5203.9 5230.9 5234.4 5255.3 5273.9 5507.7 5525.7 5532.5 5545.0 5553.5 4983.9 5270.5 5276.4 5324.0 5343.6 2961.6 2967.9 2974.4 2995.4 3000.5 5686.6 5774.9 5837.8 5857.7 5871.5 5892.8 6373.2 6383.6 6402.3 6421.2 6456.6 6523.9 6527.0 6544.7 6559.0 6035.0 6243.3 6270.0 6277.1 6282.2 5907.4 6149.2 6184.4 6194.5 6205.6 6480.3 6497.9 6555.7 6563.2 6572.5 4528.6 4544.7 4565.2 4570.8 4582.6 6104.7 6221.4 6264.0 6269.6 6320.0 6065.0 6078.6 6079.0 6080.0 6119.3 5812.7 5988.6 6027.6 6029.0 6075.0 5896.3 5931.0 5954.5 5954.7 5999.3 6048.2 6055.3 6059.8 6063.0 6085.0 5742.0 5914.4 5952.0 5961.2 5977.0 16:13:25 INFO - PROCESS | 27367 | 16:13:25 INFO - PROCESS | 27367 | [#5] yui.html Cycles:180 Average:21477.07 Median:4805.87 stddev:31270.92 (650.7%) stddev-sans-first:31320.09 16:13:25 INFO - PROCESS | 27367 | Values: 796.4 826.6 880.4 896.2 906.2 14819.7 16119.9 16213.9 16273.6 16369.8 15032.4 15119.9 15203.3 15293.2 15335.8 849.9 853.1 859.8 859.8 860.3 827.3 879.0 883.9 885.4 888.1 917.8 920.5 924.2 926.9 927.4 911.6 919.1 923.9 924.1 924.5 672.2 674.2 677.0 678.0 680.4 16774.2 16824.0 16843.9 16848.2 16892.7 14547.6 14859.9 15084.0 15131.8 15817.8 13854.7 13962.2 14398.0 14691.3 15001.0 4792.1 4798.7 4813.1 4855.5 4888.7 78365.0 79565.0 80572.0 81107.6 81433.4 12134.3 12376.3 12397.0 12398.8 12651.1 21544.9 21561.9 21576.8 21635.9 21651.2 8623.8 8660.6 8726.3 8925.0 9131.1 4944.4 5021.8 5023.2 5169.4 5194.7 3476.4 3560.8 3578.4 3581.0 3584.3 655.5 671.4 674.4 674.4 700.3 747.0 751.8 753.7 754.0 777.7 9652.3 9692.3 9906.3 9972.2 10067.5 651.1 671.5 679.5 740.9 761.5 4530.1 4563.7 4593.8 4608.9 4613.1 119737.0 119952.4 123238.0 125392.4 126192.0 66457.3 94671.5 102653.5 102946.0 104099.5 90711.5 90744.0 91493.5 92940.5 94350.0 9347.4 9405.8 9443.0 9620.9 9642.2 55305.2 55341.0 56030.4 56198.0 57660.1 70533.6 72303.6 82480.2 82894.0 83409.0 11750.9 11969.8 11997.8 12009.4 12106.9 13081.7 13172.5 13206.8 13569.4 13907.4 12578.8 12695.0 12716.2 12824.5 13059.9 12628.4 12781.6 12836.5 12855.6 12898.1 12250.1 12335.3 12380.7 12384.8 12419.3 10357.7 10524.5 10596.9 10665.9 10685.7 10351.7 10398.1 10826.2 10897.3 10906.1 16:13:25 INFO - PROCESS | 27367 | -------- Summary: end -------- 16:13:25 INFO - PROCESS | 27367 | 16:13:26 INFO - TEST-INFO | 27367: exit 0 16:13:26 INFO - TEST-OK | dromaeo_css | took 1109697ms 16:13:26 INFO - TEST-START | kraken 16:13:26 INFO - operating with platform_type : linux_ 16:13:26 INFO - Initialising browser for kraken test... 16:13:26 INFO - TEST-INFO | started process 27613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGdLB_/profile http://localhost:37431/getInfo.html) 16:13:30 INFO - PROCESS | 27613 | __metrics Screen width/height:1600/1200 16:13:30 INFO - PROCESS | 27613 | colorDepth:24 16:13:30 INFO - PROCESS | 27613 | Browser inner width/height: 1024/697 16:13:30 INFO - PROCESS | 27613 | __metrics 16:13:30 ERROR - PROCESS | 27613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:13:31 INFO - TEST-INFO | 27613: exit 0 16:13:31 INFO - Browser initialized. 16:13:31 INFO - Running cycle 1/1 for kraken test... 16:13:31 INFO - TEST-INFO | started process 27740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGdLB_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:43 INFO - PROCESS | 27740 | RSS: Main: 156114944 16:13:43 INFO - PROCESS | 27740 | 16:13:46 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37431/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:46 INFO - PROCESS | 27740 | RSS: Main: 161394688 16:13:46 INFO - PROCESS | 27740 | 16:13:49 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37431/tests/kraken/driver.html?testName=audio-dft) 16:13:50 INFO - PROCESS | 27740 | RSS: Main: 161046528 16:13:50 INFO - PROCESS | 27740 | 16:13:53 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37431/tests/kraken/driver.html?testName=audio-fft) 16:13:53 INFO - PROCESS | 27740 | RSS: Main: 161542144 16:13:53 INFO - PROCESS | 27740 | 16:13:55 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37431/tests/kraken/driver.html?testName=audio-oscillator) 16:13:56 INFO - PROCESS | 27740 | RSS: Main: 161476608 16:13:56 INFO - PROCESS | 27740 | 16:13:58 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:59 INFO - PROCESS | 27740 | RSS: Main: 161165312 16:13:59 INFO - PROCESS | 27740 | 16:14:02 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37431/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:02 INFO - PROCESS | 27740 | RSS: Main: 160628736 16:14:02 INFO - PROCESS | 27740 | 16:14:06 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37431/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:06 INFO - PROCESS | 27740 | RSS: Main: 161574912 16:14:06 INFO - PROCESS | 27740 | 16:14:09 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37431/tests/kraken/driver.html?testName=json-parse-financial) 16:14:10 INFO - PROCESS | 27740 | RSS: Main: 161247232 16:14:10 INFO - PROCESS | 27740 | 16:14:11 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:12 INFO - PROCESS | 27740 | RSS: Main: 160595968 16:14:12 INFO - PROCESS | 27740 | 16:14:14 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:14 INFO - PROCESS | 27740 | RSS: Main: 160604160 16:14:14 INFO - PROCESS | 27740 | 16:14:16 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:17 INFO - PROCESS | 27740 | RSS: Main: 161202176 16:14:17 INFO - PROCESS | 27740 | 16:14:20 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:20 INFO - PROCESS | 27740 | RSS: Main: 161435648 16:14:20 INFO - PROCESS | 27740 | 16:14:23 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:23 INFO - PROCESS | 27740 | RSS: Main: 161533952 16:14:23 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | Cycle 1(1): loaded http://localhost:37431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37431/tests/kraken/driver.html?testName=ai-astar) 16:14:25 INFO - PROCESS | 27740 | RSS: Main: 161976320 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | __start_tp_report 16:14:25 INFO - PROCESS | 27740 | _x_x_mozilla_page_load 16:14:25 INFO - PROCESS | 27740 | _x_x_mozilla_page_load_details 16:14:25 INFO - PROCESS | 27740 | |i|pagename|runs| 16:14:25 INFO - PROCESS | 27740 | |0;ai-astar;114;104;110;110;113;111;111;111;110;110 16:14:25 INFO - PROCESS | 27740 | |1;audio-beat-detection;162;126;153;185;125;147;148;126;177;132 16:14:25 INFO - PROCESS | 27740 | |2;audio-dft;163;161;162;163;163;162;160;161;162;160 16:14:25 INFO - PROCESS | 27740 | |3;audio-fft;77;76;74;171;77;76;75;78;181;75 16:14:25 INFO - PROCESS | 27740 | |4;audio-oscillator;85;83;151;86;86;89;143;84;84;145 16:14:25 INFO - PROCESS | 27740 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;118;117;117 16:14:25 INFO - PROCESS | 27740 | |6;imaging-darkroom;148;147;147;147;146;147;147;147;147;147 16:14:25 INFO - PROCESS | 27740 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:14:25 INFO - PROCESS | 27740 | |8;json-parse-financial;50;50;52;53;51;53;51;51;50;56 16:14:25 INFO - PROCESS | 27740 | |9;json-stringify-tinderbox;59;59;61;60;60;59;60;60;59;59 16:14:25 INFO - PROCESS | 27740 | |10;stanford-crypto-aes;77;83;75;81;81;80;76;76;111;77 16:14:25 INFO - PROCESS | 27740 | |11;stanford-crypto-ccm;129;127;127;118;117;119;119;121;128;120 16:14:25 INFO - PROCESS | 27740 | |12;stanford-crypto-pbkdf2;157;161;155;151;157;160;156;154;152;154 16:14:25 INFO - PROCESS | 27740 | |13;stanford-crypto-sha256-iterative;62;61;61;63;61;60;60;62;60;60 16:14:25 INFO - PROCESS | 27740 | __end_tp_report 16:14:25 INFO - PROCESS | 27740 | __start_cc_report 16:14:25 INFO - PROCESS | 27740 | _x_x_mozilla_cycle_collect,889 16:14:25 INFO - PROCESS | 27740 | __end_cc_report 16:14:25 INFO - PROCESS | 27740 | __startTimestamp1468624465851__endTimestamp 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | ------- Summary: start ------- 16:14:25 INFO - PROCESS | 27740 | Number of tests: 14 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.45 16:14:25 INFO - PROCESS | 27740 | Values: 114.0 104.0 110.0 110.0 113.0 111.0 111.0 111.0 110.0 110.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:150.50 stddev:21.56 (14.3%) stddev-sans-first:22.28 16:14:25 INFO - PROCESS | 27740 | Values: 162.0 126.0 153.0 185.0 125.0 147.0 148.0 126.0 177.0 132.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.13 16:14:25 INFO - PROCESS | 27740 | Values: 163.0 161.0 162.0 163.0 163.0 162.0 160.0 161.0 162.0 160.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:42.25 (55.6%) stddev-sans-first:44.24 16:14:25 INFO - PROCESS | 27740 | Values: 77.0 76.0 74.0 171.0 77.0 76.0 75.0 78.0 181.0 75.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.50 stddev:29.60 (35.0%) stddev-sans-first:30.62 16:14:25 INFO - PROCESS | 27740 | Values: 85.0 83.0 151.0 86.0 86.0 89.0 143.0 84.0 84.0 145.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:14:25 INFO - PROCESS | 27740 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 16:14:25 INFO - PROCESS | 27740 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:14:25 INFO - PROCESS | 27740 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.50 stddev:1.89 (3.7%) stddev-sans-first:1.90 16:14:25 INFO - PROCESS | 27740 | Values: 50.0 50.0 52.0 53.0 51.0 53.0 51.0 51.0 50.0 56.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 16:14:25 INFO - PROCESS | 27740 | Values: 59.0 59.0 61.0 60.0 60.0 59.0 60.0 60.0 59.0 59.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:78.50 stddev:10.64 (13.5%) stddev-sans-first:11.14 16:14:25 INFO - PROCESS | 27740 | Values: 77.0 83.0 75.0 81.0 81.0 80.0 76.0 76.0 111.0 77.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:124.00 stddev:4.67 (3.8%) stddev-sans-first:4.32 16:14:25 INFO - PROCESS | 27740 | Values: 129.0 127.0 127.0 118.0 117.0 119.0 119.0 121.0 128.0 120.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:156.50 stddev:3.20 (2.0%) stddev-sans-first:3.36 16:14:25 INFO - PROCESS | 27740 | Values: 157.0 161.0 155.0 151.0 157.0 160.0 156.0 154.0 152.0 154.0 16:14:25 INFO - PROCESS | 27740 | 16:14:25 INFO - PROCESS | 27740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:1.05 (1.7%) stddev-sans-first:1.05 16:14:25 INFO - PROCESS | 27740 | Values: 62.0 61.0 61.0 63.0 61.0 60.0 60.0 62.0 60.0 60.0 16:14:25 INFO - PROCESS | 27740 | -------- Summary: end -------- 16:14:25 INFO - PROCESS | 27740 | 16:14:26 INFO - TEST-INFO | 27740: exit 0 16:14:26 INFO - TEST-OK | kraken | took 60666ms 16:14:26 INFO - SUITE-END | took 1170s 16:14:27 INFO - Completed test suite (00:19:30) 16:14:27 INFO - javascript benchmark 16:14:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7709.021373477398, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.2548039431326, 3417.6582341765825, 3421.349943510731, 3434.8797792077276, 3437.295354452336, 5638.7180640967945, 5681.914771278429, 5702.657840529566, 5724.34170070442, 5745.540356771458, 5665.490105890469, 5743.885122297552, 5746.367899531048, 5753.856153596163, 5788.942110578893, 5186.1442861927835, 5217.478252174771, 5233.73831308435, 5301.390340110898, 5313.017091838003, 5139.640225184238, 5140.485951404867, 5257.395399529046, 5258.789648414059, 5273.235380869772, 5219.608529360295, 5234.37187537496, 5238.188080847474, 5244.0, 5296.602754793406, 5242.2136679498, 5256.92114618281, 5289.418164001957, 5308.92036619451, 5311.601629877736, 5050.393952725696, 5164.8967020659375, 5203.843884683465, 5281.419043905167, 5282.339707536558, 5467.45325467454, 5500.6424582402415, 5533.916991245094, 5559.861003474905, 5572.442755724435, 6024.337322894478, 6054.606450580743, 6067.848303792396, 6079.361667024988, 6095.756169753205, 5955.970220148914, 6128.533679014772, 6134.079888016833, 6137.9079313810325, 6151.569390142692, 5763.308402991626, 5847.824565263007, 5849.181114643953, 5850.473457388855, 5884.0585506318785, 6348.111264422984, 6387.169667943138, 6389.361063893666, 6394.776182833579, 6409.583377080568, 5885.793997210077, 5930.169776231331, 5964.0, 6047.973893924141, 6121.173641558422, 6125.41859352575, 6142.0, 6146.754129834846, 6160.9383906160365, 6162.476189523851, 6059.575829691879, 6075.756969721162, 6095.869220251668, 6104.4200800923845, 6110.175126357974, 5927.8221653350465, 6048.6673232971725, 6063.120847477091, 6081.2094427725, 6081.8479538011015, 4666.300054991779, 4669.929951050737, 4676.719396836201, 4690.507496712796, 4702.694324868872, 4163.208990291835, 4182.477190351206, 4189.350650649093, 4217.62041416274, 4222.59885310895, 5692.459216374438, 5738.483536481736, 5831.241938547962, 5859.267591551056, 5914.940850591525, 6134.436587033385, 6152.230971128609, 6198.690065496708, 6286.057091436322, 6287.748490060347, 5724.112762521816, 5933.3769954154195, 5937.851553711192, 5956.374580669054, 5987.700614969234, 5142.382914050263, 5163.457836927144, 5203.427622961472, 5229.241759944863, 5242.344706911636, 6424.646644434601, 6438.645874476855, 6458.354164583504, 6480.449161821298, 6481.449076828428, 6019.51843852482, 6067.302260239952, 6151.5386346025125, 6170.136180934583, 6181.660008699475, 6275.623462592259, 6455.0, 6462.967685161544, 6474.384933431316, 6475.417212450902, 6044.335123136363, 6061.0, 6071.5446341523675, 6071.787487437919, 6098.26820781509, 5980.641161530322, 6124.991279909952, 6144.15675297418, 6183.288921774054, 6188.628682278898, 6121.361519882508, 6131.453899293208, 6132.715802922644, 6133.095051491898, 6144.0, 6116.092308610808, 6116.707414839581, 6127.617148554337, 6127.922628246602, 6131.289237556246, 5780.710964451845, 5832.154337621106, 5870.295564532284, 5892.086726557391, 6061.181740465157, 5994.3705910878725, 6033.155358249936, 6033.276006879202, 6074.787382441594, 6074.969625152023, 5925.851853703692, 5936.554758393051, 5939.881202376015, 5940.61386009908, 5942.10868369748], "value": 5670.735166978037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.8444896551382, 670.9700609564318, 674.0428591400212, 677.3497442455242, 691.6783695581554, 46560.53439465608, 48307.27539086917, 48539.75730121353, 48603.51396486034, 51826.0, 49153.0, 49651.0, 49682.0, 49765.0, 49881.75059124708, 9083.227925626314, 9197.540122993856, 9230.492322922237, 9250.0, 9272.953635231814, 9066.682666106688, 9188.632454701803, 9195.172434480895, 9204.447733136, 9222.631094756236, 9179.49512776797, 9195.632174713004, 9197.0, 9238.76903077425, 9247.398919070272, 9181.678641247558, 9194.310426718022, 9220.953895230548, 9260.351775375726, 9270.49012304323, 9053.90946090544, 9172.816543669156, 9184.586693598803, 9197.724068277963, 9225.077492250788, 46491.0, 46860.297095543596, 46882.06235875298, 46936.0, 46956.76521617404, 3886.689064874803, 3979.621935916083, 4011.3782363733667, 4162.979185104085, 4609.3777340059, 33619.32761344784, 34241.0, 34724.13189670253, 34793.82603086994, 34986.825065874764, 4671.88320291992, 4792.113459010059, 4823.5658790709, 4825.831095911662, 4852.660313778037, 406603.0, 406752.99999999703, 407411.0, 409527.0, 410537.0, 39822.60177398247, 65232.347676523576, 65277.673611632585, 65788.0, 65844.34155658478, 40935.38596921049, 40987.180256394706, 41080.794596026826, 41106.38340424896, 41123.588764112574, 17501.47495575135, 17748.55628609269, 17762.0, 17770.111494425226, 17783.28866845312, 15047.0, 15118.395264189308, 15130.319135638923, 15136.924315378574, 15166.393344266105, 9052.683156089506, 9184.12750788674, 9190.58642361082, 9248.861267081, 9259.398139120936, 3502.141975216088, 3532.876349327761, 3566.4293713005795, 3589.9820500897326, 3593.838277277529, 1085.6091806949491, 1182.1665725663559, 1184.3959580613948, 1186.525389844052, 1230.9322987235787, 32954.0, 33497.0, 34182.31635367279, 34402.827985860415, 34745.30509389798, 1184.6090790039266, 1190.381001879018, 1201.3572738584814, 1221.4930803716359, 1248.5879659712455, 17488.475345739647, 17649.38227162043, 17885.28458861657, 18060.458186254433, 18138.09309534518, 641856.0, 642825.0, 650174.0, 651952.0, 652044.0, 65653.671731642, 65900.34099659038, 65997.34002659912, 66029.33970660328, 66277.33722662808, 1427.2578259305103, 1443.3996095150749, 1454.425501926733, 1504.8946573739734, 1511.1008949674926, 33370.4994425079, 33389.16527086842, 33860.32279354448, 33880.15299617529, 34585.65414345825, 66955.66522167358, 68309.3169068303, 68465.0, 68744.0, 74508.0, 540983.0, 556808.0, 557126.0, 557645.0, 559235.0, 50828.74585627196, 52066.219006715684, 52261.73869130782, 52323.0, 52785.0, 55208.72395637996, 55243.72378138245, 55388.44611553833, 55467.167992479335, 55728.442715572324, 48511.75744121257, 48609.756951216434, 48970.0, 49691.75154124206, 50340.0, 47490.76254618705, 47995.28007079827, 48028.75985620049, 48413.5158648409, 48736.75631621819, 40189.397159042055, 46867.531324686315, 47546.762266188445, 47887.28169077397, 48572.757136214095, 39572.604273956895, 41161.0, 41873.37189942093, 42667.78666106649, 42773.0, 30190.69809301879, 31439.21401964969, 31732.524012139376, 31988.520172197903, 32222.677773221967], "value": 21464.410693760194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.63926384045885, 415.7900260368514, 421.67952356209275, 422.93233082706763, 426.1285670803207, 18830.623387532258, 19588.0, 20401.387958361236, 20556.07497662605, 20598.691019634716, 12512.499500019989, 17219.91390043051, 17757.467275981708, 17854.196561154746, 18457.813558646536, 5349.839504814852, 5542.501174894259, 5545.833624991256, 5556.083246264382, 5591.832245032656, 5480.232767412565, 5515.117581187011, 5522.116461366182, 6007.609505382136, 6019.5485338599565, 5973.0, 5978.910316345258, 5993.250843644544, 5995.340512543638, 6015.669138197398, 5707.857303567403, 5882.941170588282, 5913.615614985012, 5931.080682494198, 5991.221141251631, 5369.838904832861, 5376.40859505458, 5381.919271210935, 5386.973065134688, 5411.864703382447, 14682.412703491955, 14712.55862324132, 14722.631934201623, 14766.335514901855, 15142.394304227817, 2296.7358753743365, 2373.8813059346962, 2468.1978357034036, 2680.5711086226306, 2763.350612606036, 10748.838767418494, 11089.112870970303, 11130.05394541465, 12771.805430382447, 15026.098434093989, 1988.413418041681, 2077.096463038583, 2086.634838903201, 2107.3677896630948, 2117.301290574107, 74202.25797742007, 77231.0, 77377.99999999943, 83619.0, 86395.56802216012, 11691.240069395632, 11832.935035846644, 11978.640640780617, 12026.4588093536, 12032.435783348108, 16871.662566748597, 16872.493825185265, 16890.915545422195, 16999.91500042492, 17044.403445879336, 7240.710371585077, 8566.271866891384, 8856.557172141496, 8991.235744961752, 9283.0, 9051.366404351633, 9074.230525047553, 9081.318901082444, 9188.081191880758, 9203.723888283363, 5007.424146223231, 5101.69389836611, 5179.352580927384, 5218.6868787872845, 5300.257963885059, 2094.937151885446, 2122.7771084035953, 2135.55153417784, 2157.568486302746, 2193.6819161221533, 1029.2332212501585, 1072.051234657334, 1074.7689246811817, 1090.1769164280918, 1099.9505022274018, 18823.435296941112, 19601.901990489958, 19935.24537413516, 21432.357029289145, 21442.463938401666, 1008.9798204035878, 1046.4872212615915, 1050.9579616815395, 1138.9772204556027, 1143.982840257397, 11163.776724465466, 11438.771224575461, 11457.770844583061, 11579.594714184963, 11637.941810290895, 556232.0, 561277.0, 571780.0, 571984.0, 574945.0, 99811.0, 99924.50037749765, 101058.0, 101782.49108754408, 102524.0, 1122.5453691255054, 1135.6479491357707, 1138.2942575603179, 1138.4194061028934, 1146.5471138900089, 17934.5516362092, 18153.727694084337, 18278.360257390927, 18493.445196644123, 18546.0, 38335.23329533338, 44080.77959610181, 44605.88485287894, 44766.55233447624, 45203.095938081715, 55041.0, 55569.0, 55733.44266557445, 59991.70004149951, 60624.696876515336, 8767.649294028168, 8841.911580884109, 8923.866142008004, 9032.322575806973, 9318.72043838686, 12099.395030248628, 12808.743825123633, 13646.454141834216, 13785.586432407044, 13862.0, 12012.819807702717, 12173.330466824409, 12465.439055242354, 12651.93674031624, 12686.175398599062, 12237.75524489523, 12456.937715311366, 12602.936985315382, 12682.682932926751, 12968.35158242103, 12356.938215308866, 12374.62876113718, 12403.25580465175, 12447.813282800946, 12579.119461637598, 8876.201141897001, 9253.213476854542, 9341.626334946526, 9360.719178424659, 9442.905570944202, 9753.804923901624, 12839.807402889151, 12873.0, 13027.08810383264, 13044.086913915935], "value": 9601.833952946008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.1023661394702, 1610.0, 1772.450540332497, 1879.2201236486858, 1910.1881700277388, 8625.353098517606, 9256.259499240054, 9294.256459483242, 9935.304528682995, 9942.304038717293, 9333.113354231336, 9664.323497355188, 9674.177694895925, 9735.51322433879, 9805.36265142767, 2426.6360045993065, 2464.8151388645833, 2475.3811547113223, 2476.789472894797, 2484.7515248475097, 2442.4748679034005, 2534.5057713745828, 2534.7845433138204, 2539.3778524261584, 2544.694636643596, 2505.235903049569, 2517.5342561626067, 2523.3565440812567, 2530.936726581841, 2531.190019193859, 2479.665245191903, 2490.576601977677, 2494.1395218649536, 2496.700395952479, 2524.469861329123, 2399.3161948844495, 2422.2369953464604, 2452.043702955849, 2455.373879660675, 2460.729319774823, 9646.035396460367, 9678.56446459911, 9743.269254805919, 9755.268354873413, 9772.706818795448, 5593.804216852391, 5739.053056245714, 5745.368009518949, 5793.304803423616, 5805.912911306334, 3557.8932632021083, 3580.8720253120446, 3621.2214373909737, 3848.9230215395814, 3860.613938606145, 1197.6107764976418, 1213.9757204855853, 1218.878112188783, 1223.6512593910693, 1238.8265642810013, 13599.728005439836, 13693.315334233248, 13719.519816806463, 13775.793363099561, 13776.10455320401, 4988.8752781180765, 5035.723035233024, 5098.617603679739, 5181.5077567631015, 5224.399194092652, 11459.713507162387, 11500.367479788692, 11515.078793696484, 11517.251378660529, 11571.074314054855, 5861.3552509223955, 5881.235439392852, 5895.764169433261, 5915.733791979371, 5927.436893495111, 4797.064572408347, 5285.233641122016, 5403.2705584746345, 5469.453054694499, 5478.342598888079, 4436.0906014267, 4445.066536027471, 4540.432445944257, 4546.795394207203, 4555.453345598549, 1355.6475316417802, 1394.219237227156, 1419.1059632431502, 1427.557457188275, 1427.8857691384665, 1027.0294571629738, 1092.8633920759905, 1116.4864162485349, 1122.6800361896983, 1148.17905197784, 6794.898076528856, 6839.794806155824, 6900.896486552706, 6935.930640693528, 6995.755148569776, 495.68276303166004, 504.55094965480754, 505.59804955060815, 513.4480433533965, 522.4357693690805, 4782.187028205213, 4789.161896668139, 4789.664723469324, 4820.590249828804, 4861.392325959255, 11877.22798018126, 12172.878271217174, 12263.754724905451, 12276.938615306866, 12277.631671049883, 11907.702307442383, 12335.568255111028, 12340.0, 12365.38173091342, 12462.314572698408, 8910.465372077697, 9090.681826136053, 9153.67962121336, 9161.450312981242, 9181.403208791407, 6837.3162683731225, 7018.0, 7067.6819543119655, 7114.750983715545, 7119.85760284781, 11218.887811121784, 11310.886891131313, 11450.599229026944, 11459.140564457866, 11576.073914087021, 11474.827877582009, 11483.712907177387, 11641.126915481542, 11694.70763230926, 11823.82264266054, 7840.607969601383, 8402.0, 8627.784305392164, 8831.337649676172, 8931.285497160341, 9604.711858644252, 9644.083812037845, 9665.661701840683, 9680.709578712649, 9735.513224338896, 8255.752327430188, 8464.661413543636, 8707.608157633049, 8805.075467076122, 8830.470171789713, 8002.83994320122, 8006.599670016592, 8028.759137225892, 8101.8379632408205, 8140.715074972348, 7570.280823321776, 7707.460477766503, 7719.228077192236, 7767.456278060482, 7773.222677732181, 5678.630888992202, 5819.679917604403, 5880.353161152356, 5908.084246941731, 5923.822285331447, 5795.217645617788, 5816.0, 5827.621204621686, 5831.096180092092, 5854.765809367577], "value": 5053.5911200092805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9841607127679, 353.99292014159715, 358.9389803733367, 361.3694103788887, 362.7587654209951, 5722.885542289152, 5763.711814409273, 5765.45228203321, 5797.739101740426, 5828.417158284169, 5687.658740475575, 5692.6299790513585, 5707.4577915098, 5756.510696590784, 5765.884682306351, 4302.698811083225, 4470.770538102015, 4482.453553524046, 4490.259107247317, 4499.955000449986, 4446.465514656647, 4481.288820263742, 4485.439320084989, 4487.237169681162, 4523.213330734358, 4458.643308535309, 4495.258282383403, 4511.819527218908, 4512.819487220508, 4522.6155776759015, 4412.779361031951, 4429.9778501107285, 4434.268345722936, 4437.245668236375, 4441.9111617767785, 3842.3083844907906, 3856.1709232515145, 3874.9806250968563, 3902.043999220181, 3946.782926939017, 5594.636348637367, 5604.887902241973, 5606.271184745998, 5620.4660557247, 5678.176664383683, 4907.484714105003, 5093.465186155475, 5097.668651537638, 5112.539871411591, 5131.153359695646, 6078.665673387962, 6083.48290395317, 6101.359357267467, 6103.6032657877095, 6141.877162456771, 4351.760653164075, 4359.520452750195, 4362.432883725127, 4385.495667998157, 4388.912221755547, 5912.580980564633, 6026.397360263983, 6187.845303867394, 6190.628562286277, 6284.560080794392, 4370.606645401929, 4402.691811573159, 4402.867913962522, 4405.559444055633, 4439.334099884978, 4470.061287129739, 4472.217361961643, 4479.260921947907, 4486.5962063414445, 4487.977560112178, 4887.682300650446, 5104.2088476286235, 5146.588272938156, 5161.535461808456, 5186.559142472856, 6017.518598512109, 6043.546733994968, 6047.969760151171, 6064.0, 6072.419221830704, 1528.312259483237, 1545.65995480994, 1549.2486144220045, 1556.3229994952005, 1558.6648870492897, 948.7912659214961, 965.2278177458146, 982.0, 991.3308516751164, 1001.3191030099603, 5203.869903252449, 5230.92153617696, 5234.398044224887, 5255.29203009016, 5273.868153296198, 5507.7246137692955, 5525.723713814293, 5532.478568393643, 5544.972275138599, 5553.527950124204, 4983.878627308826, 5270.472952704698, 5276.366835979707, 5324.0, 5343.557239545301, 2961.570572267009, 2967.866446009935, 2974.4199881023424, 2995.415893900712, 3000.534917087855, 5686.601937864392, 5774.94225057744, 5837.7664893404635, 5857.736401861926, 5871.500922421642, 5892.7642894283745, 6373.235211774617, 6383.616982981036, 6402.295747467775, 6421.165248517663, 6456.580322279036, 6523.934760652332, 6526.967365163144, 6544.658345039351, 6558.950567909112, 6035.0, 6243.250809902841, 6269.96865015672, 6277.12120303167, 6282.2147231596055, 5907.40925907423, 6149.2313460817395, 6184.381561843959, 6194.535409844189, 6205.596636218631, 6480.282725077764, 6497.935020649922, 6555.672216389257, 6563.245226798788, 6572.521182733846, 4528.592426681483, 4544.681872269041, 4565.223911935045, 4570.817167313403, 4582.633389328912, 6104.7485265521345, 6221.44463884029, 6263.96868015657, 6269.592476489013, 6320.0, 6065.029595264737, 6078.629334559614, 6078.969605151946, 6079.969600151971, 6119.3268740437625, 5812.692144267506, 5988.610740301867, 6027.57806953509, 6028.969855150872, 6074.969625151846, 5896.292444906467, 5931.0, 5954.46409823118, 5954.707437636454, 5999.310079340931, 6048.153258543719, 6055.2733671957885, 6059.787907423219, 6063.0, 6084.969575152096, 5741.971290143522, 5914.378990205966, 5952.035828176778, 5961.225040744675, 5976.970115149396], "value": 4543.915892992546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.3987189671797, 826.6445428465757, 880.4321212817732, 896.2247655777754, 906.1844340093915, 14819.703605927874, 16119.91940040301, 16213.946093503928, 16273.593160171002, 16369.754453683205, 15032.398704051851, 15119.924400377982, 15203.315850786714, 15293.2353382331, 15335.769963450557, 849.8895143631335, 853.117023880284, 859.8323326951247, 859.8366310401035, 860.2816648098845, 827.2596026556258, 879.0198928195049, 883.9204471597554, 885.420049867338, 888.076400543434, 917.7567944494714, 920.484528663947, 924.1543987251657, 926.874871892296, 927.420362273579, 911.6262332443732, 919.0992827029515, 923.8798956135727, 924.1405492891608, 924.505389616552, 672.2135101930753, 674.2280089297726, 677.0284641539407, 677.9694913728845, 680.4420375292262, 16774.161291935354, 16824.0, 16843.915780421143, 16848.24182911772, 16892.746608800877, 14547.563573092824, 14859.851401485956, 15084.0, 15131.773023404548, 15817.841821581753, 13854.653633659138, 13962.162270263816, 14398.0, 14691.338889749986, 15001.0, 4792.089502994455, 4798.688085274446, 4813.061453016663, 4855.514448555152, 4888.70667759932, 78365.0, 79564.99999999942, 80572.0, 81107.5944620279, 81433.37133257302, 12134.332611706264, 12376.319302438453, 12397.0, 12398.75202495945, 12651.114421990373, 21544.89227553852, 21561.89219053926, 21576.784232157792, 21635.891820540797, 21651.24220652301, 8623.784405389915, 8660.610272537624, 8726.25826804716, 8924.955375223211, 9131.086891310815, 4944.406671199479, 5021.824236151717, 5023.171176755867, 5169.3796744390165, 5194.740262986911, 3476.37425263455, 3560.839762210707, 3578.4274516077303, 3581.033121057352, 3584.301061293075, 655.5116438253532, 671.392389887153, 674.3627272227698, 674.4199988010307, 700.250731717068, 746.9551826890296, 751.7669522447949, 753.7399597138979, 753.9962300188464, 777.7122464688101, 9652.27607929408, 9692.32153749245, 9906.257030722725, 9972.152367048882, 10067.5469603868, 651.0837313558947, 671.4796033074309, 679.5481005131631, 740.870347689163, 761.4859969520552, 4530.139273538017, 4563.703359281636, 4593.805142110893, 4608.861734147914, 4613.0773845230415, 119737.0, 119952.40023799826, 123238.0, 125392.37303813423, 126192.0, 66457.33542664608, 94671.52664236772, 102653.48673256586, 102946.0, 104099.479502602, 90711.54644226737, 90744.0, 91493.54253228825, 92940.53529732308, 94350.0, 9347.392419492711, 9405.764855878384, 9442.960796892805, 9620.855687164558, 9642.228621710387, 55305.17042244289, 55341.0, 56030.43969560252, 56198.0, 57660.13509797272, 70533.64733176302, 72303.63848180725, 82480.17519824725, 82894.0, 83409.0, 11750.883666051712, 11969.760604788029, 11997.76004479923, 12009.39953002329, 12106.878931210575, 13081.738365232832, 13172.47310107585, 13206.80189797173, 13569.389377477839, 13907.37416816266, 12578.811317830057, 12695.0, 12716.173448725804, 12824.487020519075, 13059.869401305865, 12628.368581571069, 12781.552645657357, 12836.486540538648, 12855.550055748005, 12898.097133200587, 12250.142490025613, 12335.259884406963, 12380.690482738004, 12384.75230495367, 12419.254844709347, 10357.689269321932, 10524.52639631203, 10596.947015265183, 10665.8933410668, 10685.679429617125, 10351.689449316533, 10398.076196911315, 10826.188035897181, 10897.291676041032, 10906.127509799355], "value": 7820.085718510193, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 104.0, 110.0, 110.0, 113.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 153.0, 185.0, 125.0, 147.0, 148.0, 126.0, 177.0, 132.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 163.0, 162.0, 160.0, 161.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 171.0, 77.0, 76.0, 75.0, 78.0, 181.0, 75.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 151.0, 86.0, 86.0, 89.0, 143.0, 84.0, 84.0, 145.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 52.0, 53.0, 51.0, 53.0, 51.0, 51.0, 50.0, 56.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 75.0, 81.0, 81.0, 80.0, 76.0, 76.0, 111.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 127.0, 118.0, 117.0, 119.0, 119.0, 121.0, 128.0, 120.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 155.0, 151.0, 157.0, 160.0, 156.0, 154.0, 152.0, 154.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 61.0, 60.0, 60.0, 62.0, 60.0, 60.0], "value": 61.0, "unit": "score"}]}]} 16:14:27 INFO - Return code: 0 16:14:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:27 ERROR - # TBPL SUCCESS # 16:14:27 INFO - Running post-action listener: _resource_record_post_action 16:14:27 INFO - ##### 16:14:27 INFO - ##### Finished run-tests step (success) 16:14:27 INFO - ##### 16:14:27 INFO - Running post-run listener: _resource_record_post_run 16:14:27 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 270336; Write bytes: 515350528; Read time: 200; Write time: 459644 16:14:27 INFO - TinderboxPrint: CPU usage
13.4% 16:14:27 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 200 16:14:27 INFO - TinderboxPrint: I/O write bytes / time
515,350,528 / 459,644 16:14:27 INFO - TinderboxPrint: CPU idle
8,210.9 (86.6%) 16:14:27 INFO - TinderboxPrint: CPU user
1,212.3 (12.8%) 16:14:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 261771264; Read time: 176; Write time: 272456 16:14:27 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253399040; Read time: 24; Write time: 187156 16:14:27 INFO - Running post-run listener: _upload_blobber_files 16:14:27 INFO - Blob upload gear active. 16:14:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:27 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 16:14:27 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'] 16:14:27 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 16:14:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:29 INFO - (blobuploader) - INFO - Done attempting. 16:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:14:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:29 INFO - (blobuploader) - INFO - Done attempting. 16:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:35 INFO - (blobuploader) - INFO - Done attempting. 16:14:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:35 INFO - Return code: 0 16:14:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67bba284a7238aefe9560aeead5856f53a0a5e9c4e59cf695728243c34ea2cf53bf508be09dd415197f162d52f3fbd4221b2864c47552ea5178b0ccbae6bbbb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06437a677076819cefbb888432dafbd54451de0d03957855be48b56c43d6fc8e4105d283764a7cd6117ed76d20e37c00e219f9d8c48dd0b287c8434326084a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/427640042f070bdba3f49dd258d9b8e9a7c89a57506efd575fbabcdefe342298524c5570848123c7fc8525a6b574a51f4208c95edc3f2a7490a18c21bd06666c"} 16:14:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:35 INFO - Contents: 16:14:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67bba284a7238aefe9560aeead5856f53a0a5e9c4e59cf695728243c34ea2cf53bf508be09dd415197f162d52f3fbd4221b2864c47552ea5178b0ccbae6bbbb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06437a677076819cefbb888432dafbd54451de0d03957855be48b56c43d6fc8e4105d283764a7cd6117ed76d20e37c00e219f9d8c48dd0b287c8434326084a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/427640042f070bdba3f49dd258d9b8e9a7c89a57506efd575fbabcdefe342298524c5570848123c7fc8525a6b574a51f4208c95edc3f2a7490a18c21bd06666c"} 16:14:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:35 INFO - Copying logs to upload dir... 16:14:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.244067 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-15 16:14:34.976471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 16:14:34.979756) ========= 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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 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/67bba284a7238aefe9560aeead5856f53a0a5e9c4e59cf695728243c34ea2cf53bf508be09dd415197f162d52f3fbd4221b2864c47552ea5178b0ccbae6bbbb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06437a677076819cefbb888432dafbd54451de0d03957855be48b56c43d6fc8e4105d283764a7cd6117ed76d20e37c00e219f9d8c48dd0b287c8434326084a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/427640042f070bdba3f49dd258d9b8e9a7c89a57506efd575fbabcdefe342298524c5570848123c7fc8525a6b574a51f4208c95edc3f2a7490a18c21bd06666c"} build_url:https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/aEPUvBaXRr2NGYGcrD2QvQ/artifacts/public/build/firefox-49.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/67bba284a7238aefe9560aeead5856f53a0a5e9c4e59cf695728243c34ea2cf53bf508be09dd415197f162d52f3fbd4221b2864c47552ea5178b0ccbae6bbbb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06437a677076819cefbb888432dafbd54451de0d03957855be48b56c43d6fc8e4105d283764a7cd6117ed76d20e37c00e219f9d8c48dd0b287c8434326084a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/427640042f070bdba3f49dd258d9b8e9a7c89a57506efd575fbabcdefe342298524c5570848123c7fc8525a6b574a51f4208c95edc3f2a7490a18c21bd06666c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 16:14:35.004607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 16:14:35.004922) ========= 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=62c568580acbfdaac3eec7be000001dc-1468621803.849764-1297831514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 16:14:35.088021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 16:14:35.088324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 16:14:35.088626) ========= ========= Total master_lag: 0.17 =========