builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1466539359.39 results: success (0) buildid: 20160621103055 builduid: fb2ce4740fb04e6d9ddfd9f8c071170b revision: 5ac2f675c083d59ef6329d164cf92733ab344557 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.390723) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.391268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.391593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.450242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.450633) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 13:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-06-21 13:02:39 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088614 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.558653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.558979) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016026 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.612538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 13:02:39.612931) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ac2f675c083d59ef6329d164cf92733ab344557 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5ac2f675c083d59ef6329d164cf92733ab344557 --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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 13:02:39,915 truncating revision to first 12 chars 2016-06-21 13:02:39,915 Setting DEBUG logging. 2016-06-21 13:02:39,915 attempt 1/10 2016-06-21 13:02:39,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5ac2f675c083?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 13:02:40,917 unpacking tar archive at: mozilla-inbound-5ac2f675c083/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366887 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 13:02:41.027097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:41.027449) ========= script_repo_revision: 5ac2f675c083d59ef6329d164cf92733ab344557 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:41.027919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:41.028309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:41.039678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-21 13:02:41.039985) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:02:41 INFO - MultiFileLogger online at 20160621 13:02:41 in /builds/slave/test 13:02:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:02:41 INFO - {'append_to_log': False, 13:02:41 INFO - 'base_work_dir': '/builds/slave/test', 13:02:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:02:41 INFO - 'branch': 'Mozilla-Inbound', 13:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 13:02:41 INFO - 'config_files': ('talos/linux_config.py',), 13:02:41 INFO - 'default_actions': ('clobber', 13:02:41 INFO - 'read-buildbot-config', 13:02:41 INFO - 'download-and-extract', 13:02:41 INFO - 'populate-webroot', 13:02:41 INFO - 'create-virtualenv', 13:02:41 INFO - 'install', 13:02:41 INFO - 'run-tests'), 13:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:02:41 INFO - 'download_minidump_stackwalk': True, 13:02:41 INFO - 'download_symbols': 'ondemand', 13:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 13:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 13:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:02:41 INFO - 'installer_path': 'installer.exe', 13:02:41 INFO - 'log_level': 'info', 13:02:41 INFO - 'log_name': 'talos', 13:02:41 INFO - 'log_to_console': True, 13:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:02:41 INFO - 'opt_config_files': (), 13:02:41 INFO - 'pip_index': False, 13:02:41 INFO - 'sps_profile': False, 13:02:41 INFO - 'sps_profile_interval': 0, 13:02:41 INFO - 'suite': 'dromaeojs-e10s', 13:02:41 INFO - 'system_bits': '32', 13:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:41 INFO - 'title': 'talos-linux64-ix-002', 13:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:02:41 INFO - 'use_talos_json': True, 13:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:02:41 INFO - 'work_dir': 'build'} 13:02:41 INFO - ##### 13:02:41 INFO - ##### Running clobber step. 13:02:41 INFO - ##### 13:02:41 INFO - Running pre-action listener: _resource_record_pre_action 13:02:41 INFO - Running main action method: clobber 13:02:41 INFO - rmtree: /builds/slave/test/build 13:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:02:41 INFO - Running post-action listener: _resource_record_post_action 13:02:41 INFO - ##### 13:02:41 INFO - ##### Finished clobber step (success) 13:02:41 INFO - ##### 13:02:41 INFO - ##### 13:02:41 INFO - ##### Running read-buildbot-config step. 13:02:41 INFO - ##### 13:02:41 INFO - Running pre-action listener: _resource_record_pre_action 13:02:41 INFO - Running main action method: read_buildbot_config 13:02:41 INFO - Using buildbot properties: 13:02:41 INFO - { 13:02:41 INFO - "project": "", 13:02:41 INFO - "product": "firefox", 13:02:41 INFO - "script_repo_revision": "production", 13:02:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:02:41 INFO - "repository": "", 13:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:02:41 INFO - "buildid": "20160621103055", 13:02:41 INFO - "pgo_build": "True", 13:02:41 INFO - "basedir": "/builds/slave/test", 13:02:41 INFO - "buildnumber": 1187, 13:02:41 INFO - "slavename": "talos-linux64-ix-002", 13:02:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:02:41 INFO - "platform": "ubuntu64_hw", 13:02:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:02:41 INFO - "branch": "mozilla-inbound", 13:02:41 INFO - "repo_path": "integration/mozilla-inbound", 13:02:41 INFO - "revision": "5ac2f675c083d59ef6329d164cf92733ab344557", 13:02:41 INFO - "stage_platform": "linux64-pgo", 13:02:41 INFO - "builduid": "fb2ce4740fb04e6d9ddfd9f8c071170b", 13:02:41 INFO - "slavebuilddir": "test" 13:02:41 INFO - } 13:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:02:41 INFO - Running post-action listener: _resource_record_post_action 13:02:41 INFO - ##### 13:02:41 INFO - ##### Finished read-buildbot-config step (success) 13:02:41 INFO - ##### 13:02:41 INFO - ##### 13:02:41 INFO - ##### Running download-and-extract step. 13:02:41 INFO - ##### 13:02:41 INFO - Running pre-action listener: _resource_record_pre_action 13:02:41 INFO - Running main action method: download_and_extract 13:02:41 INFO - mkdir: /builds/slave/test/build/tests 13:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:41 INFO - https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:02:46 INFO - Downloaded 1361 bytes. 13:02:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:46 INFO - Using the following test package requirements: 13:02:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:02:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:02:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'jsshell-linux-x86_64.zip'], 13:02:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:02:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:02:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:02:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:02:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:02:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:46 INFO - https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:02:59 INFO - Downloaded 24226042 bytes. 13:02:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:02:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:03:00 INFO - Return code: 0 13:03:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:00 INFO - https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:03:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:03:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:03:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:03:02 INFO - Downloaded 24226042 bytes. 13:03:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:03:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:03:04 INFO - Return code: 0 13:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:04 INFO - https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:03:15 INFO - Downloaded 14405384 bytes. 13:03:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:03:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:03:15 INFO - Return code: 0 13:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:15 INFO - https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:03:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:03:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:03:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:03:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:03:17 INFO - Downloaded 60120933 bytes. 13:03:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:03:17 INFO - mkdir: /builds/slave/test/properties 13:03:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:03:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:03:17 INFO - Contents: 13:03:17 INFO - build_url:https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:03:18 INFO - Running post-action listener: _resource_record_post_action 13:03:18 INFO - Running post-action listener: set_extra_try_arguments 13:03:18 INFO - ##### 13:03:18 INFO - ##### Finished download-and-extract step (success) 13:03:18 INFO - ##### 13:03:18 INFO - ##### 13:03:18 INFO - ##### Running populate-webroot step. 13:03:18 INFO - ##### 13:03:18 INFO - Running pre-action listener: _resource_record_pre_action 13:03:18 INFO - Running main action method: populate_webroot 13:03:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:03:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:03:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:03:18 INFO - '--tppagecycles', 13:03:18 INFO - '7'], 13:03:18 INFO - 'tests': ['tsvgm']}}, 13:03:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:03:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:03:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:03:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:03:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:03:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['damp', 'tps']}, 13:03:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'tests': ['damp', 'tps']}, 13:03:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['dromaeo_dom']}, 13:03:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:03:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['basic_compositor_video']}, 13:03:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:03:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'other-e10s': {'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['a11yr', 13:03:18 INFO - 'ts_paint', 13:03:18 INFO - 'tpaint', 13:03:18 INFO - 'sessionrestore', 13:03:18 INFO - 'sessionrestore_no_auto_restore', 13:03:18 INFO - 'tabpaint']}, 13:03:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['tsvgx', 13:03:18 INFO - 'tsvgr_opacity', 13:03:18 INFO - 'tart', 13:03:18 INFO - 'tscrollx', 13:03:18 INFO - 'cart']}, 13:03:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:03:18 INFO - 'tsvgr_opacity', 13:03:18 INFO - 'tart', 13:03:18 INFO - 'tscrollx', 13:03:18 INFO - 'cart']}, 13:03:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'talos_options': ['--disable-e10s'], 13:03:18 INFO - 'tests': ['tp5o']}, 13:03:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'tests': ['tp5o']}, 13:03:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'talos_options': ['--disable-e10s', 13:03:18 INFO - '--xperf_path', 13:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:18 INFO - 'tests': ['tp5n']}, 13:03:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:03:18 INFO - 'talos_options': ['--xperf_path', 13:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:03:18 INFO - 'tests': ['tp5n']}}, 13:03:18 INFO - 'talos.zip': {'path': '', 13:03:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:03:18 INFO - Running post-action listener: _resource_record_post_action 13:03:18 INFO - ##### 13:03:18 INFO - ##### Finished populate-webroot step (success) 13:03:18 INFO - ##### 13:03:18 INFO - ##### 13:03:18 INFO - ##### Running create-virtualenv step. 13:03:18 INFO - ##### 13:03:18 INFO - Running pre-action listener: _resource_record_pre_action 13:03:18 INFO - Running main action method: create_virtualenv 13:03:18 INFO - Creating virtualenv /builds/slave/test/build/venv 13:03:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:03:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:03:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:03:18 INFO - Using real prefix '/usr' 13:03:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:03:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:03:20 INFO - Installing pip.................done. 13:03:20 INFO - Return code: 0 13:03:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:03: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')]} 13:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03: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')]} 13:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03: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', 'pip>=1.5'] in /builds/slave/test/build 13:03: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 pip>=1.5 13:03:20 INFO - Using env: {'DISPLAY': ':0', 13:03:20 INFO - 'HOME': '/home/cltbld', 13:03:20 INFO - 'LANG': 'en_US.UTF-8', 13:03:20 INFO - 'LANGUAGE': 'en_US:en', 13:03:20 INFO - 'LOGNAME': 'cltbld', 13:03:20 INFO - 'MAIL': '/var/mail/cltbld', 13:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:20 INFO - 'MOZ_NO_REMOTE': '1', 13:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:20 INFO - 'NO_EM_RESTART': '1', 13:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:20 INFO - 'PWD': '/builds/slave/test', 13:03:20 INFO - 'SHELL': '/bin/bash', 13:03:20 INFO - 'SHLVL': '1', 13:03:20 INFO - 'TERM': 'linux', 13:03:20 INFO - 'TMOUT': '86400', 13:03:20 INFO - 'USER': 'cltbld', 13:03:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:20 INFO - '_': '/tools/buildbot/bin/python'} 13:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:03:21 INFO - Cleaning up... 13:03:21 INFO - Return code: 0 13:03:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:21 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:21 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 13:03:21 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 13:03:21 INFO - Using env: {'DISPLAY': ':0', 13:03:21 INFO - 'HOME': '/home/cltbld', 13:03:21 INFO - 'LANG': 'en_US.UTF-8', 13:03:21 INFO - 'LANGUAGE': 'en_US:en', 13:03:21 INFO - 'LOGNAME': 'cltbld', 13:03:21 INFO - 'MAIL': '/var/mail/cltbld', 13:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:21 INFO - 'MOZ_NO_REMOTE': '1', 13:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:21 INFO - 'NO_EM_RESTART': '1', 13:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:21 INFO - 'PWD': '/builds/slave/test', 13:03:21 INFO - 'SHELL': '/bin/bash', 13:03:21 INFO - 'SHLVL': '1', 13:03:21 INFO - 'TERM': 'linux', 13:03:21 INFO - 'TMOUT': '86400', 13:03:21 INFO - 'USER': 'cltbld', 13:03:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:21 INFO - '_': '/tools/buildbot/bin/python'} 13:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:21 INFO - Downloading/unpacking psutil>=3.1.1 13:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:23 INFO - Installing collected packages: psutil 13:03:23 INFO - Running setup.py install for psutil 13:03:23 INFO - building 'psutil._psutil_linux' extension 13:03:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:03:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:03:23 INFO - building 'psutil._psutil_posix' extension 13:03:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:03:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:23 INFO - Successfully installed psutil 13:03:23 INFO - Cleaning up... 13:03:23 INFO - Return code: 0 13:03:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:23 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:23 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 13:03:23 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 13:03:23 INFO - Using env: {'DISPLAY': ':0', 13:03:23 INFO - 'HOME': '/home/cltbld', 13:03:23 INFO - 'LANG': 'en_US.UTF-8', 13:03:23 INFO - 'LANGUAGE': 'en_US:en', 13:03:23 INFO - 'LOGNAME': 'cltbld', 13:03:23 INFO - 'MAIL': '/var/mail/cltbld', 13:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:23 INFO - 'MOZ_NO_REMOTE': '1', 13:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:23 INFO - 'NO_EM_RESTART': '1', 13:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:23 INFO - 'PWD': '/builds/slave/test', 13:03:23 INFO - 'SHELL': '/bin/bash', 13:03:23 INFO - 'SHLVL': '1', 13:03:23 INFO - 'TERM': 'linux', 13:03:23 INFO - 'TMOUT': '86400', 13:03:23 INFO - 'USER': 'cltbld', 13:03:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:23 INFO - '_': '/tools/buildbot/bin/python'} 13:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:03: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 13:03: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 13:03: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 13:03: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 13:03: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 13:03: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 13:03:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:03:26 INFO - Installing collected packages: mozsystemmonitor 13:03:26 INFO - Running setup.py install for mozsystemmonitor 13:03:26 INFO - Successfully installed mozsystemmonitor 13:03:26 INFO - Cleaning up... 13:03:26 INFO - Return code: 0 13:03:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:26 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:26 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 13:03:26 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 13:03:26 INFO - Using env: {'DISPLAY': ':0', 13:03:26 INFO - 'HOME': '/home/cltbld', 13:03:26 INFO - 'LANG': 'en_US.UTF-8', 13:03:26 INFO - 'LANGUAGE': 'en_US:en', 13:03:26 INFO - 'LOGNAME': 'cltbld', 13:03:26 INFO - 'MAIL': '/var/mail/cltbld', 13:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:26 INFO - 'MOZ_NO_REMOTE': '1', 13:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:26 INFO - 'NO_EM_RESTART': '1', 13:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:26 INFO - 'PWD': '/builds/slave/test', 13:03:26 INFO - 'SHELL': '/bin/bash', 13:03:26 INFO - 'SHLVL': '1', 13:03:26 INFO - 'TERM': 'linux', 13:03:26 INFO - 'TMOUT': '86400', 13:03:26 INFO - 'USER': 'cltbld', 13:03:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:26 INFO - '_': '/tools/buildbot/bin/python'} 13:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:26 INFO - Downloading/unpacking jsonschema==2.5.1 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:03:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:28 INFO - Downloading functools32-3.2.3-2.tar.gz 13:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:03:28 INFO - warning: no files found matching '*.txt' 13:03:28 INFO - no previously-included directories found matching 'build' 13:03:28 INFO - no previously-included directories found matching 'dist' 13:03:28 INFO - no previously-included directories found matching '.git*' 13:03:28 INFO - Installing collected packages: jsonschema, functools32 13:03:28 INFO - Running setup.py install for functools32 13:03:28 INFO - warning: no files found matching '*.txt' 13:03:28 INFO - no previously-included directories found matching 'build' 13:03:28 INFO - no previously-included directories found matching 'dist' 13:03:28 INFO - no previously-included directories found matching '.git*' 13:03:28 INFO - Successfully installed jsonschema functools32 13:03:28 INFO - Cleaning up... 13:03:28 INFO - Return code: 0 13:03:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:03: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')]} 13:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03: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')]} 13:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:03:28 INFO - Using env: {'DISPLAY': ':0', 13:03:28 INFO - 'HOME': '/home/cltbld', 13:03:28 INFO - 'LANG': 'en_US.UTF-8', 13:03:28 INFO - 'LANGUAGE': 'en_US:en', 13:03:28 INFO - 'LOGNAME': 'cltbld', 13:03:28 INFO - 'MAIL': '/var/mail/cltbld', 13:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:28 INFO - 'MOZ_NO_REMOTE': '1', 13:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:28 INFO - 'NO_EM_RESTART': '1', 13:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:28 INFO - 'PWD': '/builds/slave/test', 13:03:28 INFO - 'SHELL': '/bin/bash', 13:03:28 INFO - 'SHLVL': '1', 13:03:28 INFO - 'TERM': 'linux', 13:03:28 INFO - 'TMOUT': '86400', 13:03:28 INFO - 'USER': 'cltbld', 13:03:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:28 INFO - '_': '/tools/buildbot/bin/python'} 13:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:28 INFO - Downloading/unpacking blobuploader==1.2.4 13:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:30 INFO - Downloading blobuploader-1.2.4.tar.gz 13:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:03:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:03:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:31 INFO - Downloading docopt-0.6.1.tar.gz 13:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:03:31 INFO - Installing collected packages: blobuploader, requests, docopt 13:03:31 INFO - Running setup.py install for blobuploader 13:03:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:03:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:03:31 INFO - Running setup.py install for requests 13:03:32 INFO - Running setup.py install for docopt 13:03:32 INFO - Successfully installed blobuploader requests docopt 13:03:32 INFO - Cleaning up... 13:03:32 INFO - Return code: 0 13:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:32 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:03:32 INFO - Using env: {'DISPLAY': ':0', 13:03:32 INFO - 'HOME': '/home/cltbld', 13:03:32 INFO - 'LANG': 'en_US.UTF-8', 13:03:32 INFO - 'LANGUAGE': 'en_US:en', 13:03:32 INFO - 'LOGNAME': 'cltbld', 13:03:32 INFO - 'MAIL': '/var/mail/cltbld', 13:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:32 INFO - 'MOZ_NO_REMOTE': '1', 13:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:32 INFO - 'NO_EM_RESTART': '1', 13:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:32 INFO - 'PWD': '/builds/slave/test', 13:03:32 INFO - 'SHELL': '/bin/bash', 13:03:32 INFO - 'SHLVL': '1', 13:03:32 INFO - 'TERM': 'linux', 13:03:32 INFO - 'TMOUT': '86400', 13:03:32 INFO - 'USER': 'cltbld', 13:03:32 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:32 INFO - '_': '/tools/buildbot/bin/python'} 13:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:32 INFO - Running setup.py (path:/tmp/pip-psfsPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:32 INFO - Running setup.py (path:/tmp/pip-iuuIW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:32 INFO - Running setup.py (path:/tmp/pip-P1U8Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:32 INFO - Running setup.py (path:/tmp/pip-jc_Qhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:32 INFO - Running setup.py (path:/tmp/pip-ncrqJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:32 INFO - Running setup.py (path:/tmp/pip-UUU2LO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:32 INFO - Running setup.py (path:/tmp/pip-fx6l3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:32 INFO - Running setup.py (path:/tmp/pip-2b2KPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:33 INFO - Running setup.py (path:/tmp/pip-gAz26P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:33 INFO - Running setup.py (path:/tmp/pip-PFQdoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:33 INFO - Running setup.py (path:/tmp/pip-jW8zwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:33 INFO - Running setup.py (path:/tmp/pip-5NmTGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:33 INFO - Running setup.py (path:/tmp/pip-_WcX8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:33 INFO - Running setup.py (path:/tmp/pip-gVAlx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:33 INFO - Running setup.py (path:/tmp/pip-dk8xdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:33 INFO - Running setup.py (path:/tmp/pip-El4ADE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:33 INFO - Running setup.py (path:/tmp/pip-3nsybw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:03:33 INFO - Running setup.py install for manifestparser 13:03:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:03:33 INFO - Running setup.py install for mozcrash 13:03:33 INFO - Running setup.py install for mozdebug 13:03:33 INFO - Running setup.py install for mozdevice 13:03:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for mozfile 13:03:34 INFO - Running setup.py install for mozhttpd 13:03:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for mozinfo 13:03:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for mozInstall 13:03:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for mozleak 13:03:34 INFO - Running setup.py install for mozlog 13:03:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for moznetwork 13:03:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:03:34 INFO - Running setup.py install for mozprocess 13:03:34 INFO - Running setup.py install for mozprofile 13:03:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:03:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:03:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:03:35 INFO - Running setup.py install for mozrunner 13:03:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:03:35 INFO - Running setup.py install for mozscreenshot 13:03:35 INFO - Running setup.py install for moztest 13:03:35 INFO - Running setup.py install for mozversion 13:03:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:03:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:03:35 INFO - Cleaning up... 13:03:35 INFO - Return code: 0 13:03:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:35 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:03:35 INFO - Using env: {'DISPLAY': ':0', 13:03:35 INFO - 'HOME': '/home/cltbld', 13:03:35 INFO - 'LANG': 'en_US.UTF-8', 13:03:35 INFO - 'LANGUAGE': 'en_US:en', 13:03:35 INFO - 'LOGNAME': 'cltbld', 13:03:35 INFO - 'MAIL': '/var/mail/cltbld', 13:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:35 INFO - 'MOZ_NO_REMOTE': '1', 13:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:35 INFO - 'NO_EM_RESTART': '1', 13:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:35 INFO - 'PWD': '/builds/slave/test', 13:03:35 INFO - 'SHELL': '/bin/bash', 13:03:35 INFO - 'SHLVL': '1', 13:03:35 INFO - 'TERM': 'linux', 13:03:35 INFO - 'TMOUT': '86400', 13:03:35 INFO - 'USER': 'cltbld', 13:03:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:35 INFO - '_': '/tools/buildbot/bin/python'} 13:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:35 INFO - Running setup.py (path:/tmp/pip-SkLQBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:35 INFO - Running setup.py (path:/tmp/pip-UyVD2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:35 INFO - Running setup.py (path:/tmp/pip-JUGVPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:35 INFO - Running setup.py (path:/tmp/pip-yIBRrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:35 INFO - Running setup.py (path:/tmp/pip-uES4Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:36 INFO - Running setup.py (path:/tmp/pip-pQZx4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:36 INFO - Running setup.py (path:/tmp/pip-KWniHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:36 INFO - Running setup.py (path:/tmp/pip-TAiPJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:36 INFO - Running setup.py (path:/tmp/pip-YnVgsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:36 INFO - Running setup.py (path:/tmp/pip-PJ_O5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:36 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)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:36 INFO - Running setup.py (path:/tmp/pip-ea9Kcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:36 INFO - Running setup.py (path:/tmp/pip-hpkeCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:36 INFO - Running setup.py (path:/tmp/pip-lbhSrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:36 INFO - Running setup.py (path:/tmp/pip-IoBsXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:36 INFO - Running setup.py (path:/tmp/pip-UhToxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:36 INFO - Running setup.py (path:/tmp/pip-PUzpgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:36 INFO - Running setup.py (path:/tmp/pip-J4hhyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:03:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:03: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 13:03: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 13:03: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 13:03: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 13:03: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 13:03: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 13:03:38 INFO - Downloading blessings-1.6.tar.gz 13:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:03:38 INFO - Installing collected packages: blessings 13:03:38 INFO - Running setup.py install for blessings 13:03:39 INFO - Successfully installed blessings 13:03:39 INFO - Cleaning up... 13:03:39 INFO - Return code: 0 13:03:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:39 INFO - Reading from file tmpfile_stdout 13:03:39 INFO - Current package versions: 13:03:39 INFO - argparse == 1.2.1 13:03:39 INFO - blessings == 1.6 13:03:39 INFO - blobuploader == 1.2.4 13:03:39 INFO - docopt == 0.6.1 13:03:39 INFO - functools32 == 3.2.3-2 13:03:39 INFO - jsonschema == 2.5.1 13:03:39 INFO - manifestparser == 1.1 13:03:39 INFO - mozInstall == 1.12 13:03:39 INFO - mozcrash == 0.17 13:03:39 INFO - mozdebug == 0.1 13:03:39 INFO - mozdevice == 0.48 13:03:39 INFO - mozfile == 1.2 13:03:39 INFO - mozhttpd == 0.7 13:03:39 INFO - mozinfo == 0.9 13:03:39 INFO - mozleak == 0.1 13:03:39 INFO - mozlog == 3.2 13:03:39 INFO - moznetwork == 0.27 13:03:39 INFO - mozprocess == 0.22 13:03:39 INFO - mozprofile == 0.28 13:03:39 INFO - mozrunner == 6.11 13:03:39 INFO - mozscreenshot == 0.1 13:03:39 INFO - mozsystemmonitor == 0.3 13:03:39 INFO - moztest == 0.7 13:03:39 INFO - mozversion == 1.4 13:03:39 INFO - psutil == 3.1.1 13:03:39 INFO - requests == 1.2.3 13:03:39 INFO - wsgiref == 0.1.2 13:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:03:39 INFO - Using env: {'DISPLAY': ':0', 13:03:39 INFO - 'HOME': '/home/cltbld', 13:03:39 INFO - 'LANG': 'en_US.UTF-8', 13:03:39 INFO - 'LANGUAGE': 'en_US:en', 13:03:39 INFO - 'LOGNAME': 'cltbld', 13:03:39 INFO - 'MAIL': '/var/mail/cltbld', 13:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:39 INFO - 'MOZ_NO_REMOTE': '1', 13:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:39 INFO - 'NO_EM_RESTART': '1', 13:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:39 INFO - 'PWD': '/builds/slave/test', 13:03:39 INFO - 'SHELL': '/bin/bash', 13:03:39 INFO - 'SHLVL': '1', 13:03:39 INFO - 'TERM': 'linux', 13:03:39 INFO - 'TMOUT': '86400', 13:03:39 INFO - 'USER': 'cltbld', 13:03:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:39 INFO - '_': '/tools/buildbot/bin/python'} 13:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:03:39 INFO - Cleaning up... 13:03:39 INFO - Return code: 0 13:03:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:03:39 INFO - Using env: {'DISPLAY': ':0', 13:03:39 INFO - 'HOME': '/home/cltbld', 13:03:39 INFO - 'LANG': 'en_US.UTF-8', 13:03:39 INFO - 'LANGUAGE': 'en_US:en', 13:03:39 INFO - 'LOGNAME': 'cltbld', 13:03:39 INFO - 'MAIL': '/var/mail/cltbld', 13:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:39 INFO - 'MOZ_NO_REMOTE': '1', 13:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:39 INFO - 'NO_EM_RESTART': '1', 13:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:39 INFO - 'PWD': '/builds/slave/test', 13:03:39 INFO - 'SHELL': '/bin/bash', 13:03:39 INFO - 'SHLVL': '1', 13:03:39 INFO - 'TERM': 'linux', 13:03:39 INFO - 'TMOUT': '86400', 13:03:39 INFO - 'USER': 'cltbld', 13:03:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:39 INFO - '_': '/tools/buildbot/bin/python'} 13:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:03:39 INFO - Cleaning up... 13:03:39 INFO - Return code: 0 13:03:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:39 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 0x7f458aba9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1616350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:03:39 INFO - Using env: {'DISPLAY': ':0', 13:03:39 INFO - 'HOME': '/home/cltbld', 13:03:39 INFO - 'LANG': 'en_US.UTF-8', 13:03:39 INFO - 'LANGUAGE': 'en_US:en', 13:03:39 INFO - 'LOGNAME': 'cltbld', 13:03:39 INFO - 'MAIL': '/var/mail/cltbld', 13:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:39 INFO - 'MOZ_NO_REMOTE': '1', 13:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:39 INFO - 'NO_EM_RESTART': '1', 13:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:39 INFO - 'PWD': '/builds/slave/test', 13:03:39 INFO - 'SHELL': '/bin/bash', 13:03:39 INFO - 'SHLVL': '1', 13:03:39 INFO - 'TERM': 'linux', 13:03:39 INFO - 'TMOUT': '86400', 13:03:39 INFO - 'USER': 'cltbld', 13:03:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:39 INFO - '_': '/tools/buildbot/bin/python'} 13:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:39 INFO - Downloading/unpacking flake8 13:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:03:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:03:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:03:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:03:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:03:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:03:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:03:42 INFO - no previously-included directories found matching 'docs/_build' 13:03:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:03:42 INFO - Running setup.py install for pep8 13:03:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:03:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:03:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:03:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:03:42 INFO - no previously-included directories found matching 'docs/_build' 13:03:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:03:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:03:42 INFO - Cleaning up... 13:03:42 INFO - Return code: 0 13:03:42 INFO - Running post-action listener: _resource_record_post_action 13:03:42 INFO - Running post-action listener: _start_resource_monitoring 13:03:42 INFO - Starting resource monitoring. 13:03:42 INFO - ##### 13:03:42 INFO - ##### Finished create-virtualenv step (success) 13:03:42 INFO - ##### 13:03:42 INFO - ##### 13:03:42 INFO - ##### Running install step. 13:03:42 INFO - ##### 13:03:42 INFO - Running pre-action listener: _resource_record_pre_action 13:03:42 INFO - Running main action method: install 13:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:43 INFO - Reading from file tmpfile_stdout 13:03:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:03:43 INFO - Reading from file tmpfile_stdout 13:03:43 INFO - Output received: 13:03:43 INFO - Usage: mozinstall [options] installer 13:03:43 INFO - Options: 13:03:43 INFO - -h, --help show this help message and exit 13:03:43 INFO - -d DEST, --destination=DEST 13:03:43 INFO - Directory to install application into. [default: 13:03:43 INFO - "/builds/slave/test"] 13:03:43 INFO - --app=APP Application being installed. [default: firefox] 13:03:43 INFO - mkdir: /builds/slave/test/build/application 13:03:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:04:00 INFO - Reading from file tmpfile_stdout 13:04:00 INFO - Output received: 13:04:00 INFO - /builds/slave/test/build/application/firefox/firefox 13:04:00 INFO - Running post-action listener: _resource_record_post_action 13:04:00 INFO - ##### 13:04:00 INFO - ##### Finished install step (success) 13:04:00 INFO - ##### 13:04:00 INFO - ##### 13:04:00 INFO - ##### Running run-tests step. 13:04:00 INFO - ##### 13:04:00 INFO - Running pre-action listener: _resource_record_pre_action 13:04:00 INFO - Running main action method: run_tests 13:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:04:00 INFO - Python 2.7.3 13:04:00 INFO - Return code: 0 13:04:00 INFO - grabbing minidump binary from tooltool 13:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:00 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 0x16a51c0>, '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 0x16a60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:04:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:04:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:04:00 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 13:04:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:04:00 INFO - Return code: 0 13:04:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:04:01 INFO - Return code: 0 13:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:04:01 INFO - Using env: {'DISPLAY': ':0', 13:04:01 INFO - 'HOME': '/home/cltbld', 13:04:01 INFO - 'LANG': 'en_US.UTF-8', 13:04:01 INFO - 'LANGUAGE': 'en_US:en', 13:04:01 INFO - 'LOGNAME': 'cltbld', 13:04:01 INFO - 'MAIL': '/var/mail/cltbld', 13:04:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:04:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:01 INFO - 'MOZ_NO_REMOTE': '1', 13:04:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:01 INFO - 'NO_EM_RESTART': '1', 13:04:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:01 INFO - 'PWD': '/builds/slave/test', 13:04:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:04:01 INFO - 'SHELL': '/bin/bash', 13:04:01 INFO - 'SHLVL': '1', 13:04:01 INFO - 'TERM': 'linux', 13:04:01 INFO - 'TMOUT': '86400', 13:04:01 INFO - 'USER': 'cltbld', 13:04:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249', 13:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:01 INFO - '_': '/tools/buildbot/bin/python'} 13:04:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:04:01 INFO - mozversion application_buildid: 20160621103055 13:04:01 INFO - mozversion application_changeset: 5ac2f675c083d59ef6329d164cf92733ab344557 13:04:01 INFO - mozversion application_display_name: Nightly 13:04:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:04:01 INFO - mozversion application_name: Firefox 13:04:01 INFO - mozversion application_remotingname: firefox 13:04:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:04:01 INFO - mozversion application_vendor: Mozilla 13:04:01 INFO - mozversion application_version: 50.0a1 13:04:01 INFO - mozversion platform_buildid: 20160621103055 13:04:01 INFO - mozversion platform_changeset: 5ac2f675c083d59ef6329d164cf92733ab344557 13:04:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:04:01 INFO - mozversion platform_version: 50.0a1 13:04:01 INFO - using testdate: 1466539441 13:04:01 INFO - actual date: 1466539441 13:04:01 INFO - starting webserver on 'localhost:60554' 13:04:01 INFO - SUITE-START | Running 2 tests 13:04:01 INFO - TEST-START | dromaeo_css 13:04:01 INFO - operating with platform_type : linux_ 13:04:01 INFO - Initialising browser for dromaeo_css test... 13:04:01 INFO - TEST-INFO | started process 17297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAYxJM/profile http://localhost:60554/getInfo.html) 13:04:06 INFO - PROCESS | 17297 | __metrics Screen width/height:1600/1200 13:04:06 INFO - PROCESS | 17297 | colorDepth:24 13:04:06 INFO - PROCESS | 17297 | Browser inner width/height: 1024/697 13:04:06 INFO - PROCESS | 17297 | __metrics 13:04:07 ERROR - PROCESS | 17297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:04:08 INFO - TEST-INFO | 17297: exit 0 13:04:08 INFO - Browser initialized. 13:04:08 INFO - Running cycle 1/1 for dromaeo_css test... 13:04:08 INFO - TEST-INFO | started process 17415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaAYxJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:20 INFO - PROCESS | 17415 | RSS: Main: 185245696 13:04:20 INFO - PROCESS | 17415 | 13:05:09 INFO - PROCESS | 17415 | 1466539509668 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:07:17 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60554/tests/dromaeo/cssquery-ext.html) 13:07:18 INFO - PROCESS | 17415 | RSS: Main: 189030400 13:07:18 INFO - PROCESS | 17415 | 13:10:20 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-ext.html (next: http://localhost:60554/tests/dromaeo/cssquery-jquery.html) 13:10:21 INFO - PROCESS | 17415 | RSS: Main: 187633664 13:10:21 INFO - PROCESS | 17415 | 13:13:22 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60554/tests/dromaeo/cssquery-mootools.html) 13:13:23 INFO - PROCESS | 17415 | RSS: Main: 189870080 13:13:23 INFO - PROCESS | 17415 | 13:16:25 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60554/tests/dromaeo/cssquery-prototype.html) 13:16:25 INFO - PROCESS | 17415 | RSS: Main: 187154432 13:16:25 INFO - PROCESS | 17415 | 13:19:28 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60554/tests/dromaeo/cssquery-yui.html) 13:19:28 INFO - PROCESS | 17415 | RSS: Main: 188325888 13:19:28 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | Cycle 1(1): loaded http://localhost:60554/tests/dromaeo/cssquery-yui.html (next: http://localhost:60554/tests/dromaeo/cssquery-dojo.html) 13:22:31 INFO - PROCESS | 17415 | RSS: Main: 189841408 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | __start_tp_report 13:22:31 INFO - PROCESS | 17415 | _x_x_mozilla_page_load 13:22:31 INFO - PROCESS | 17415 | _x_x_mozilla_page_load_details 13:22:31 INFO - PROCESS | 17415 | |i|pagename|runs| 13:22:31 INFO - PROCESS | 17415 | |0;dojo.html;3154.4637411640024;3169.255225022118;3182.9204269893257;3191.6967888050626;3195.3130077033447;5373.032854086263;5416.133418653017;5505.394406615274;5525.640833345829;5530.5852061095375;5394.32570928634;5443.129099344106;5451.2640793492865;5509.614326997112;5530.778768849251;4948.505149485059;4972.105021096201;5073.289739436464;5113.693178409308;5157.742112894341;571.682071592889;4899.216125419934;4900.0689868924965;4918.36061312029;4931.841017360917;4961.9751901240625;4980.978899325648;4985.351904252442;4986.252062190682;5015.59875209986;5023.472535383805;5036.949630503685;5055;5056.494350564914;5068.113080210986;4902.7058376497525;4929.2359684248995;4963.255511673242;4988.326575912241;4992.525710057539;5392.083345831218;5492.231087647732;5501.037318469252;5503.347032893826;5515;5665.8583535411535;5817.418258174191;5847.619904706181;5887.35239123696;5901.203337549418;5870.647761134345;5897.7935772247765;5911.763529458816;5970.611910225822;5979.043353063489;5525.0883604205255;5539.889202215933;5543.390227074979;5543.473370029841;5545.694986775726;5878.323992740804;5988.520918326523;6070.150178974947;6073.757049717962;6074.058520929263;5809.331926828384;5839.503642190376;5846.883062338729;5859.5019423349495;5897.616654917417;5916.171735956969;5923.940760592425;5938.287405511366;5942.732577034044;5946.732397042144;5727.8854422912145;5819.098039803837;5847.532197424196;5877.294724633071;5906.468417842329;5833.125031245348;5901.439363260483;5902.970485147547;5905.379935106838;5933.317668468095;4438.955610443854;4482.103579284091;4499.685022048425;4501.279795232813;4501.527339629291;3940.9802950985636;3945.822437990297;3948;3951.05174758056;4002.0195052212393;5681.147827825776;5683.8863222736145;5701.173329867146;5716.256886604715;5717.371089180187;5956;5982.4914882234625;5985.670788106696;5988.9401105989255;6006.5495087868585;5502.752376143083;5649.067903795828;5697.7151142443545;5737.483626473554;5750.798722044792;5125.256837758504;5140.228965655182;5140.897182056338;5146.76839542214;5151.793928242903;5970.104484327298;6171.56799024073;6178.104174894705;6179.104029915727;6195.659238741822;5894.911576326359;5912.793052243151;5932.673702946379;5957.582969192288;5972.13404056418;6094.238220222473;6152.200213972155;6152.384761523812;6153.077038444269;6158.938410615837;5665.178549110274;5737.5983681141915;5785.479306862402;5805.564582656402;5817.069268916953;5858.2677165354335;5963.880722385615;5970.432808883149;5983.910241346471;5986.970065149646;5716.971415143064;5809.041508151107;5835.270591176103;5838.32859221178;5853.531717462678;5680.375158732453;5781.537477001746;5796.362400135898;5802.796902108406;5829.3296270927685;5704.657720536781;5741.8564535886935;5776.046952252831;5778.219940308005;5804.854878628068;5854;5867.853303667443;5874.794382196774;5910.379410161871;5920.171176035445;5543.833684989457;5605.80379686709;5704.857378565403;5718.199452076629;5777.9133313001175 13:22:31 INFO - PROCESS | 17415 | |1;ext.html;562.5246666566752;588.8792797476517;603.4418163199041;624.7657128576784;634.4226753654176;39345.213095738065;42479;43213.56786432143;43312.133757324875;43329;42972.57027429725;43839.3424098638;43847.56152438475;43936;44036.779816100876;8845.778855528615;9028;9048.321375896801;9062.818743625123;9066.048064953151;8892;8973.641054357819;8974.86537701935;8979.326550508706;9008.324375671818;9049.592768325441;9062.229710474585;9067.95466022669;9068.410553314014;9099.63601455941;8989.865152022725;9011.27909767217;9070.727878163632;9092.63629454821;9102.271818254523;8928.598213080428;8951.23914467271;8985.146411090936;9034.683786067457;9036;40553;40616.593834061576;40794.59205407967;40953;40955.795221024004;3569.5538057742783;3671.9265614687824;3691.280200360931;3706.8517259309597;3770.0386401467727;32735.672643273738;32746.6725332746;32783.18042048944;33287.83356083228;34548.65451345479;4285.579402980621;4338.717983331074;4345.826166953318;4395.362672412514;4494.348319493688;320057;320627;321387;322051;323356.38321808475;60790.392096079355;60924.390756092755;61218;61274.387256126865;61336;35920.28159436849;36577.45133822995;36809.44785828215;38322.616773832466;38394.42408363877;16847.241874115694;17198.14009299555;17272.827271727372;17278.13609319529;17310.740338894928;13586.320683965761;13778.311084445939;13798.448062077405;13820.516281930084;13881.167129972235;19598.804011959983;19689.803101969082;19801.900990494956;19968.90015549913;20023.59952800936;7171.318724721144;7226.313500217471;7306.853862922711;7346.302101300368;7450.85098298031;988.2686811759246;1068.4016950507742;1090.5801266512449;1098.8406681031206;1161.959331423413;32748.64862174354;32915;32963;33241.501377479355;33282.16794580155;1077.2405454154803;1094.2121672395863;1112.3492756737398;1141.19545720267;1170.5493385046818;16336.836631633532;16951.49145525636;16974.57563560921;17020.744688829676;17057.573560661083;531997;535619;542382;542703;544862;59105.704471477366;59354;59741.103883441785;59854.10218846721;59899.70050149722;1343.8454577723687;1345.8384993800807;1400.5588239704462;1402.2287741742205;1412.971740565183;30483.847580761954;31180.688193117778;31379.529307060868;31489.685103148677;32236.19409514687;50317.49682503128;50889.23666145085;51127.99999999851;51206.23190652069;51248.48751512437;487411;500541;501007;501673;502154;28679.713202867704;28784.856075719486;28991.710082899746;29051.85474072616;29186.27034324074;47935.520644793105;48959.510404895496;49112;49701.254481182084;50089;41646.58353416427;42111.36832947447;42423.36364954466;42903.57096428996;42958.57041429546;39877.40490380352;40221.798891006525;40303.59696402998;41629.37555936724;42307.7884610575;41077.589224107374;41646;42386.788066059475;42755.786221068694;45437.09125817399;41576.79211603923;43236.783816080715;44990.100197996515;47975.28037079516;48095.27857082077;31587.526187107673;33323.66676333303;34724.82637586796;35088.82455587706;35159.64840351666 13:22:31 INFO - PROCESS | 17415 | |2;jquery.html;385.26246627709025;387.53689341237197;389.63958338536867;396.2728393398114;406.1714103229412;18570;19278.421647350566;19304.131314090864;19314.51713707158;19433;18412;18912.243510259606;19287.132079056442;19547.5113122172;19582.314618988337;5620.662760234379;5758;5760.7695692172265;5764.913526297109;5886.028805247129;5643.435656434365;5717.656940583557;5784.855378615526;5787.594868359217;5800.796972105977;5580.386157522669;5622.578306626999;5674.404187560309;5679.034564124109;5709.543236541088;5659.575531835108;5679.829605111853;5682.744276507547;5698.202251684767;5715.342735585398;4864.854054378375;5161.638685292031;5168.560672342818;5179.974100129513;5241.475852414766;11973.820392694117;12176;20220.898895505576;21477.785222147733;21492;2243.4167116549816;2271.6933214016226;2273.9090436382526;2319.1651005637955;2833;9801.215902727765;9910.55402506889;9912.653057142965;9964.701058968243;10013.749656258578;1831.4414103698366;1873.812618738129;1915.1381878154887;1921.34674210769;1938.8545859060628;67594.66202669004;76319;76425.61787191029;78051;79332.99999999942;10751.946240268748;10788.813230544634;10952.835707464394;11103.25177333233;11219.60731374398;15290.847091528942;15330.386784528717;15389.769153462707;15433.151176685391;15512.689746205238;8200.343972482187;8207.302379297827;8268.297194738394;8405.41162118658;8498.107698691672;7978.6808527659405;8005.559694216874;8069.273765361146;8161.63272652732;8246.793830154294;4634.884127896762;4729.858104256878;4755.619550435957;4849.636277279218;4887.462379138292;1841.3371186372894;1890.5651700109051;1916.8658193926292;1929.4983304340692;1954.4136758972252;896.1262768800367;982.2780256511459;1018.9796204075877;1029.1715169288645;1058.1217589400778;18103.909480452512;19611.11749971226;19812.108455119553;20108;20875.79124208769;914.8627705844177;964.9903500965041;973.6738192705382;1007.1942446043282;1031.5770534080991;10733.765616953993;11360.204785664924;11397.202195846212;11423.314601123793;11430.771384572428;460671;461027;467918;469027;470784;80532.19467805247;81393.18606813856;82051.5897420521;82228;82337.58831205925;1018.9643362482277;1025.6666583360288;1041.109851077318;1049.0296475759892;1056.4612047855649;17158.48524544266;17205.827941720923;17607.29570817153;17632.73550896712;17830.46508604744;28679.139625811258;37883;38096.42855357117;39265.214695705356;39854.60145398509;54188;54845;55907.161392579954;56174.43825561855;57489.53849384302;7415.369693575891;7840.176781437867;8698.956505217433;8766.167214114648;9120;12026.218295810744;12043.277403355827;12162;12559.434825432694;12779.552715654907;5869.853253668522;7559.622018898923;10875.07561857251;11086.944565277123;11091.279066860629;10477.42374169428;10773.946130269298;10863.565457381615;11014.339139651647;11329.206955513364;10810.891891081303;11046.613368532062;11205.215634905479;11356.034737047114;11661.825072623747;7387.7783666490095;7440.218777028334;8026.919730802851;8075.313598344206;8102.351811854919;10736;10794.56821727122;11296.322220666787;11304.717382065513;11539.711507212387 13:22:31 INFO - PROCESS | 17415 | |3;mootools.html;1470.8382077971426;1491.552534239728;1590.7931968844048;1720.5182548886307;1738.9391371302006;7690.269424404687;8490.745277641665;8588.91411085889;9238.907610923889;9280.582373793179;8605.311575073994;8832.425892317011;8882.955585222066;8903.287736981043;8925.598348074336;2360.3155085025364;2397.9640305395433;2401.7838394544488;2403.230966090852;2406.5186962607463;2373.8694371809543;2382.8451150675237;2398.8920498577604;2409.277216834951;2409.795167410772;2339.9883000584973;2356.846804957681;2373.4066483379156;2381.071382160959;2422.2975337152207;2183.268605017321;2184.8798316092607;2199.2632468123197;2206.1065268566176;2286.737025242102;2227.944301392462;2228.3760547046854;2244.461329280977;2247.4156719252946;2312.8959196836013;8993.370464067519;8998.100189981014;9020.233280171193;9023.233025192802;9085.545722713903;5341.866453338659;5452.04589196889;5455.536279416255;5459.3994660587305;5487.341519017704;3126.296583268769;3197.536357228189;3348.598168219805;3381.3237352529345;3393.847276872522;1006.2402885821232;1026.1226651213256;1039.1115596165246;1040.5109598488698;1051.05405135378;12804.103712740112;12808;12862.678433039155;12862.807057894139;12909.741805163938;4754.720751323767;4792.424909010941;4832.540908613676;4879.682820616648;4914.262860570943;10727.570897164182;10728.141748660088;10743.462826858626;10760.3543787373;10762;5439.102548079522;5476.808311709071;5478.534324582375;5483.972580137074;5485.040117979338;4363.759993200404;4742.9762851186215;4938.111139994836;4969.925451118236;4985.925211121836;4015.558288588253;4032.6572241359227;4134.069834287261;4146.398772178018;4172.332426811696;1290.8773666501668;1310.3972172800427;1314.4019471140607;1319.7096638739463;1325.337331334333;951.571792693277;997.4713401897006;1001.2890847498212;1004.1163775877181;1019.9541020654088;6235.812925612239;6236;6263;6339.717701627411;6465.256495502983;438.4169055156698;443.9689221754446;447.4362303497617;448.4864829769895;455.55583306276776;3884.533855937306;3917.5298964124486;3918.8824335269987;3954.62431069048;3956.090099277182;10588.047075763217;10716.464176791129;11155.553777848796;11178.664640060812;11202.495887685074;10692.786144277226;10858.782824343469;10993.560257589766;11042.503087361089;11091.72270693239;8289.461185022954;8349.165083491724;8360.749177524684;8390;8391.076981532027;6124.234470691164;6225.968870155621;6297.433231009231;6302.590331628429;6330.303666596763;9942;9978.800423991333;10119;10201.183905287411;10274.640387586398;10231.181505479693;10331.431771252654;10368.326058806153;10379.532921018723;10407.427591482237;7294.416446684359;7500.624968751432;7751.612419379121;7952.721654742057;8048.476849004796;8798.208161265517;8814;8859.512726800089;8879.644814207359;8892.15524525169;7855.7250496232355;8045.195480452142;8069.87895181561;8095.39284553649;8195.590220489072;7542.773716788505;7603.239676032353;7882;7905.249001344863;8052.597370131352;6757.391834734897;7167.7132914682825;7258.0927384076995;7269.890951635624;7274.127104747464;5465.890682186414;5533.474319939599;5558.44415558441;5621.100623900156;5627.606067575231;5477.917831232455;5487.067198576331;5487.368952570346;5578.525825304894;5672.886542269214 13:22:31 INFO - PROCESS | 17415 | |4;prototype.html;318.99362012759747;333.4098645397646;335.8639750900885;336.4717393691903;343.4933473127139;5450.31871016123;5487.835364939048;5547.944520554794;5628.705397758518;5644.774209031634;5567.4432556744405;5578.135389014699;5589.832305030855;5590.552755779538;5597.272354593897;4356.6514678825615;4366.694331396803;4377.168338015783;4383.495897971734;4418.072204836988;4330.285502892035;4345.587169218935;4373.387725718402;4406.2289099407635;4430.6012458878695;4313.935290970638;4341.565843415665;4351.847685331014;4352.107817897323;4373.584509471611;4173.582641735832;4388.824447022115;4404.163208990281;4412.492563355191;4413.227685155101;3806.8198858354;3841;3854.4218367244857;3877.9224415511812;3878.3019056569806;5437.401885792559;5437.8368648940595;5438.320209973754;5445.373782015079;5466.125419932791;4883.780229889663;4884.780184891689;4940.752962351868;4941.382327209099;4957.752112394402;5767;5808.535317174616;5818.156367326714;5821.15593238978;5842.328132264802;4204.432401625802;4242.596953289432;4250.617444429985;4276.743395396286;4284.700070995032;5832.658488547615;6014.2482189726725;6114.663693496856;6115.327313995457;6137.833811575786;4349.978250108729;4359.629431498295;4374.365716971085;4384.539623339567;4389.978050109729;4420.9115817684105;4438.622717069021;4440.33394990754;4448.644108471314;4448.644108471314;4907.141250281186;4952.316212487772;5022.221555658879;5022.296878437021;5049.974750126225;5620.156976453564;5740.110282906073;5890.352061273256;5893.5579831512805;5894;1516.8483151684743;1531.7625768005978;1536.1167328785994;1536.1474381718253;1548.0943647965842;970.5341436110706;975.317277905469;999.9700008999741;1010.661428421487;1010.8736407949007;4980.352554167935;5069.771860266297;5093.701106217891;5131.692098474104;5150.4334523202415;5259.526642602184;5320.920186197211;5409.161579955114;5417.864553386197;5430.647007944471;4891.413030436371;4947.356843610308;5044.520770526794;5082.771275292621;5090.898182036339;2847.302410909299;2854.9143525694262;2878.7545714342846;2882.135359392174;2884.351021020296;5460.481254280837;5464.644798088111;5473.7263136843;5507.7246137692955;5549.223108764776;5367.765413954812;5669.582604348912;6183.165272688219;6218.6268823869805;6226.626402415779;6221.2845522765465;6288.591241569192;6293.748250070037;6306.716197771111;6339.017452294902;5936;6000.189974353407;6021.458068773832;6074.66589337573;6140;5951.809638072316;5988.790392336247;6001.459868611846;6009.158717779427;6062.363451837494;6089.817305480843;6337.619742815262;6392.4246817786625;6393.520485963664;6408.1349017881985;4235.894102647459;4249.3215180004345;4281.464816897887;4281.807318670605;4303.50509691377;5995.0407934731975;6081.27024757032;6113.663748493876;6184.319724830175;6217.689115544114;5879.559033072451;5895.056790913433;5895.263092113486;5906.468417842415;5933.554983376178;5821.94178058214;5840.970795145997;5884.264466941632;5919.171316015847;5952.464278214981;5583.860403489945;5698.8290351289525;5751.4536119068625;5760.020796464527;5771.249737534094;5876.678711908687;5962.850928726816;5994.160817485468;5996.520278377807;6013.609115407485;5716.514096301861;5828.94171058284;5848.239728835224;5860.267466566679;5862 13:22:31 INFO - PROCESS | 17415 | |5;yui.html;771.8957940678007;808.3613944983462;824.142891392951;824.7855557555034;837.8324335132975;15246.771298430518;15760.921195394036;15853.048817070983;15875.047497150179;15931;13798.517051903185;13960.301984900765;14022.368993395296;14042.92978535106;14756.852431475681;811.4847072109224;812.1229072601606;816.657004058294;816.8447994880984;817.9713710020151;802.1657476224719;805.6656487557657;807;807.4509333653114;814.3770015937812;853.7780177153953;854.974350769478;862.6851199312268;864.360373323739;864.8097418567905;850.4174640371334;850.5449584472277;852.6248450681711;853.684136869356;854.6068808348167;617.5461036138435;626.5520153090562;629.9401556852092;630.9621422714652;631.5011141198494;14612.26938653063;14691;14735.778963315559;14800.925995369955;14971.925140374336;13877.37551810161;14157.362918668581;14257.500987465493;14485.493007744784;14487.753712163734;12409.131360804748;12433.689157771129;12605;12664.81002784959;12689.61931142058;3722.9627703722886;3761.605031471711;3795.962040379616;3805.961940380616;3811.6188381161937;67466.66266668733;80047;81254.18745812585;81594;82103.48430836301;11439.199256052163;11554.711132221593;11613.30320180792;11711.472983715754;11888.28670279786;19825.405237842886;21095.261665841623;21373.78626213749;21377.144914203258;21442.78557214408;8636.438631488933;8752.47485150893;8828.955855220684;8903.465792052368;9095.545222738836;4818.6626936114835;4898.363212782387;4947.777350019186;5021.447640759514;5052.317937078521;3546.2375589247918;3645.744797864177;3652.0687224757517;3662.3407786598136;3672.5042119314085;635.5265327331168;656.4846595422571;660.8347913021745;670.4904272752743;676.1176664452838;620.5935112501319;725.2638571849577;736.3624682474497;739.5858319341079;783.9882401763978;9750.221186961682;9751.317407781387;9774.755631109138;10103.595856165817;10172.779266488069;576.4840467781312;643.250613035808;679.952403331772;692.8337199072187;703.711478293897;4884.535969082932;4922.360093187863;4925.729084900293;4980.900381992412;5063.873403164876;64853;65550.67224663847;66818;66954.66522667356;114195;93654.53172734093;95792;96040;96388.51805741066;96775.51612242035;82628.58685706533;82750.58624706959;84183.5790821042;84476.57761711151;86600.13399866047;10079.13535995843;10542.420166890895;10624.681259562225;10842.457877105955;10848.67453976382;39884.401733973435;41339.7933010333;48699;49048;49655.50344496653;66412.33587664062;67649;72543.27456725365;74446;77681;12324.260544367367;12618.305993170463;13002.349882506027;13167.67080822987;14148.43406263738;14308.427662893784;15951.68096638084;16027.519174424786;16113;16349.509514714578;13375.26436045988;13833.930830345784;14061.931146608915;14288.928555357157;14745.189014603871;13750;13769.793453098011;14059;14176.787348189991;15154.924225378803;13446.260455675032;13820.032597718466;13888.097273677178;15021.849781502046;15160.31778569945;11543;11619.231211014974;11744.29534227949;11868.940655296668;11901.86375064819;11596.536138554364;11743.765124697287;12380.257184568954;12415.193012454161;12423.254604723745 13:22:31 INFO - PROCESS | 17415 | __end_tp_report 13:22:31 INFO - PROCESS | 17415 | __start_cc_report 13:22:31 INFO - PROCESS | 17415 | _x_x_mozilla_cycle_collect,341 13:22:31 INFO - PROCESS | 17415 | __end_cc_report 13:22:31 INFO - PROCESS | 17415 | __startTimestamp1466540551840__endTimestamp 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | ------- Summary: start ------- 13:22:31 INFO - PROCESS | 17415 | Number of tests: 6 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#0] dojo.html Cycles:165 Average:5462.83 Median:5727.89 stddev:744.85 (13.0%) stddev-sans-first:724.79 13:22:31 INFO - PROCESS | 17415 | Values: 3154.5 3169.3 3182.9 3191.7 3195.3 5373.0 5416.1 5505.4 5525.6 5530.6 5394.3 5443.1 5451.3 5509.6 5530.8 4948.5 4972.1 5073.3 5113.7 5157.7 571.7 4899.2 4900.1 4918.4 4931.8 4962.0 4981.0 4985.4 4986.3 5015.6 5023.5 5036.9 5055.0 5056.5 5068.1 4902.7 4929.2 4963.3 4988.3 4992.5 5392.1 5492.2 5501.0 5503.3 5515.0 5665.9 5817.4 5847.6 5887.4 5901.2 5870.6 5897.8 5911.8 5970.6 5979.0 5525.1 5539.9 5543.4 5543.5 5545.7 5878.3 5988.5 6070.2 6073.8 6074.1 5809.3 5839.5 5846.9 5859.5 5897.6 5916.2 5923.9 5938.3 5942.7 5946.7 5727.9 5819.1 5847.5 5877.3 5906.5 5833.1 5901.4 5903.0 5905.4 5933.3 4439.0 4482.1 4499.7 4501.3 4501.5 3941.0 3945.8 3948.0 3951.1 4002.0 5681.1 5683.9 5701.2 5716.3 5717.4 5956.0 5982.5 5985.7 5988.9 6006.5 5502.8 5649.1 5697.7 5737.5 5750.8 5125.3 5140.2 5140.9 5146.8 5151.8 5970.1 6171.6 6178.1 6179.1 6195.7 5894.9 5912.8 5932.7 5957.6 5972.1 6094.2 6152.2 6152.4 6153.1 6158.9 5665.2 5737.6 5785.5 5805.6 5817.1 5858.3 5963.9 5970.4 5983.9 5987.0 5717.0 5809.0 5835.3 5838.3 5853.5 5680.4 5781.5 5796.4 5802.8 5829.3 5704.7 5741.9 5776.0 5778.2 5804.9 5854.0 5867.9 5874.8 5910.4 5920.2 5543.8 5605.8 5704.9 5718.2 5777.9 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#1] ext.html Cycles:180 Average:61342.23 Median:42405.08 stddev:122908.31 (289.8%) stddev-sans-first:123168.38 13:22:31 INFO - PROCESS | 17415 | Values: 562.5 588.9 603.4 624.8 634.4 39345.2 42479.0 43213.6 43312.1 43329.0 42972.6 43839.3 43847.6 43936.0 44036.8 8845.8 9028.0 9048.3 9062.8 9066.0 8892.0 8973.6 8974.9 8979.3 9008.3 9049.6 9062.2 9068.0 9068.4 9099.6 8989.9 9011.3 9070.7 9092.6 9102.3 8928.6 8951.2 8985.1 9034.7 9036.0 40553.0 40616.6 40794.6 40953.0 40955.8 3569.6 3671.9 3691.3 3706.9 3770.0 32735.7 32746.7 32783.2 33287.8 34548.7 4285.6 4338.7 4345.8 4395.4 4494.3 320057.0 320627.0 321387.0 322051.0 323356.4 60790.4 60924.4 61218.0 61274.4 61336.0 35920.3 36577.5 36809.4 38322.6 38394.4 16847.2 17198.1 17272.8 17278.1 17310.7 13586.3 13778.3 13798.4 13820.5 13881.2 19598.8 19689.8 19801.9 19968.9 20023.6 7171.3 7226.3 7306.9 7346.3 7450.9 988.3 1068.4 1090.6 1098.8 1162.0 32748.6 32915.0 32963.0 33241.5 33282.2 1077.2 1094.2 1112.3 1141.2 1170.5 16336.8 16951.5 16974.6 17020.7 17057.6 531997.0 535619.0 542382.0 542703.0 544862.0 59105.7 59354.0 59741.1 59854.1 59899.7 1343.8 1345.8 1400.6 1402.2 1413.0 30483.8 31180.7 31379.5 31489.7 32236.2 50317.5 50889.2 51128.0 51206.2 51248.5 487411.0 500541.0 501007.0 501673.0 502154.0 28679.7 28784.9 28991.7 29051.9 29186.3 47935.5 48959.5 49112.0 49701.3 50089.0 41646.6 42111.4 42423.4 42903.6 42958.6 39877.4 40221.8 40303.6 41629.4 42307.8 41077.6 41646.0 42386.8 42755.8 45437.1 41576.8 43236.8 44990.1 47975.3 48095.3 31587.5 33323.7 34724.8 35088.8 35159.6 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#2] jquery.html Cycles:180 Average:27386.61 Median:37989.71 stddev:76653.31 (201.8%) stddev-sans-first:76841.53 13:22:31 INFO - PROCESS | 17415 | Values: 385.3 387.5 389.6 396.3 406.2 18570.0 19278.4 19304.1 19314.5 19433.0 18412.0 18912.2 19287.1 19547.5 19582.3 5620.7 5758.0 5760.8 5764.9 5886.0 5643.4 5717.7 5784.9 5787.6 5800.8 5580.4 5622.6 5674.4 5679.0 5709.5 5659.6 5679.8 5682.7 5698.2 5715.3 4864.9 5161.6 5168.6 5180.0 5241.5 11973.8 12176.0 20220.9 21477.8 21492.0 2243.4 2271.7 2273.9 2319.2 2833.0 9801.2 9910.6 9912.7 9964.7 10013.7 1831.4 1873.8 1915.1 1921.3 1938.9 67594.7 76319.0 76425.6 78051.0 79333.0 10751.9 10788.8 10952.8 11103.3 11219.6 15290.8 15330.4 15389.8 15433.2 15512.7 8200.3 8207.3 8268.3 8405.4 8498.1 7978.7 8005.6 8069.3 8161.6 8246.8 4634.9 4729.9 4755.6 4849.6 4887.5 1841.3 1890.6 1916.9 1929.5 1954.4 896.1 982.3 1019.0 1029.2 1058.1 18103.9 19611.1 19812.1 20108.0 20875.8 914.9 965.0 973.7 1007.2 1031.6 10733.8 11360.2 11397.2 11423.3 11430.8 460671.0 461027.0 467918.0 469027.0 470784.0 80532.2 81393.2 82051.6 82228.0 82337.6 1019.0 1025.7 1041.1 1049.0 1056.5 17158.5 17205.8 17607.3 17632.7 17830.5 28679.1 37883.0 38096.4 39265.2 39854.6 54188.0 54845.0 55907.2 56174.4 57489.5 7415.4 7840.2 8699.0 8766.2 9120.0 12026.2 12043.3 12162.0 12559.4 12779.6 5869.9 7559.6 10875.1 11086.9 11091.3 10477.4 10773.9 10863.6 11014.3 11329.2 10810.9 11046.6 11205.2 11356.0 11661.8 7387.8 7440.2 8026.9 8075.3 8102.4 10736.0 10794.6 11296.3 11304.7 11539.7 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#3] mootools.html Cycles:180 Average:5914.21 Median:452.02 stddev:3395.88 (751.3%) stddev-sans-first:3388.99 13:22:31 INFO - PROCESS | 17415 | Values: 1470.8 1491.6 1590.8 1720.5 1738.9 7690.3 8490.7 8588.9 9238.9 9280.6 8605.3 8832.4 8883.0 8903.3 8925.6 2360.3 2398.0 2401.8 2403.2 2406.5 2373.9 2382.8 2398.9 2409.3 2409.8 2340.0 2356.8 2373.4 2381.1 2422.3 2183.3 2184.9 2199.3 2206.1 2286.7 2227.9 2228.4 2244.5 2247.4 2312.9 8993.4 8998.1 9020.2 9023.2 9085.5 5341.9 5452.0 5455.5 5459.4 5487.3 3126.3 3197.5 3348.6 3381.3 3393.8 1006.2 1026.1 1039.1 1040.5 1051.1 12804.1 12808.0 12862.7 12862.8 12909.7 4754.7 4792.4 4832.5 4879.7 4914.3 10727.6 10728.1 10743.5 10760.4 10762.0 5439.1 5476.8 5478.5 5484.0 5485.0 4363.8 4743.0 4938.1 4969.9 4985.9 4015.6 4032.7 4134.1 4146.4 4172.3 1290.9 1310.4 1314.4 1319.7 1325.3 951.6 997.5 1001.3 1004.1 1020.0 6235.8 6236.0 6263.0 6339.7 6465.3 438.4 444.0 447.4 448.5 455.6 3884.5 3917.5 3918.9 3954.6 3956.1 10588.0 10716.5 11155.6 11178.7 11202.5 10692.8 10858.8 10993.6 11042.5 11091.7 8289.5 8349.2 8360.7 8390.0 8391.1 6124.2 6226.0 6297.4 6302.6 6330.3 9942.0 9978.8 10119.0 10201.2 10274.6 10231.2 10331.4 10368.3 10379.5 10407.4 7294.4 7500.6 7751.6 7952.7 8048.5 8798.2 8814.0 8859.5 8879.6 8892.2 7855.7 8045.2 8069.9 8095.4 8195.6 7542.8 7603.2 7882.0 7905.2 8052.6 6757.4 7167.7 7258.1 7269.9 7274.1 5465.9 5533.5 5558.4 5621.1 5627.6 5477.9 5487.1 5487.4 5578.5 5672.9 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#4] prototype.html Cycles:180 Average:4874.54 Median:5441.85 stddev:1435.20 (26.4%) stddev-sans-first:1397.90 13:22:31 INFO - PROCESS | 17415 | Values: 319.0 333.4 335.9 336.5 343.5 5450.3 5487.8 5547.9 5628.7 5644.8 5567.4 5578.1 5589.8 5590.6 5597.3 4356.7 4366.7 4377.2 4383.5 4418.1 4330.3 4345.6 4373.4 4406.2 4430.6 4313.9 4341.6 4351.8 4352.1 4373.6 4173.6 4388.8 4404.2 4412.5 4413.2 3806.8 3841.0 3854.4 3877.9 3878.3 5437.4 5437.8 5438.3 5445.4 5466.1 4883.8 4884.8 4940.8 4941.4 4957.8 5767.0 5808.5 5818.2 5821.2 5842.3 4204.4 4242.6 4250.6 4276.7 4284.7 5832.7 6014.2 6114.7 6115.3 6137.8 4350.0 4359.6 4374.4 4384.5 4390.0 4420.9 4438.6 4440.3 4448.6 4448.6 4907.1 4952.3 5022.2 5022.3 5050.0 5620.2 5740.1 5890.4 5893.6 5894.0 1516.8 1531.8 1536.1 1536.1 1548.1 970.5 975.3 1000.0 1010.7 1010.9 4980.4 5069.8 5093.7 5131.7 5150.4 5259.5 5320.9 5409.2 5417.9 5430.6 4891.4 4947.4 5044.5 5082.8 5090.9 2847.3 2854.9 2878.8 2882.1 2884.4 5460.5 5464.6 5473.7 5507.7 5549.2 5367.8 5669.6 6183.2 6218.6 6226.6 6221.3 6288.6 6293.7 6306.7 6339.0 5936.0 6000.2 6021.5 6074.7 6140.0 5951.8 5988.8 6001.5 6009.2 6062.4 6089.8 6337.6 6392.4 6393.5 6408.1 4235.9 4249.3 4281.5 4281.8 4303.5 5995.0 6081.3 6113.7 6184.3 6217.7 5879.6 5895.1 5895.3 5906.5 5933.6 5821.9 5841.0 5884.3 5919.2 5952.5 5583.9 5698.8 5751.5 5760.0 5771.2 5876.7 5962.9 5994.2 5996.5 6013.6 5716.5 5828.9 5848.2 5860.3 5862.0 13:22:31 INFO - PROCESS | 17415 | 13:22:31 INFO - PROCESS | 17415 | [#5] yui.html Cycles:180 Average:19561.74 Median:26758.83 stddev:26591.59 (99.4%) stddev-sans-first:26628.76 13:22:31 INFO - PROCESS | 17415 | Values: 771.9 808.4 824.1 824.8 837.8 15246.8 15760.9 15853.0 15875.0 15931.0 13798.5 13960.3 14022.4 14042.9 14756.9 811.5 812.1 816.7 816.8 818.0 802.2 805.7 807.0 807.5 814.4 853.8 855.0 862.7 864.4 864.8 850.4 850.5 852.6 853.7 854.6 617.5 626.6 629.9 631.0 631.5 14612.3 14691.0 14735.8 14800.9 14971.9 13877.4 14157.4 14257.5 14485.5 14487.8 12409.1 12433.7 12605.0 12664.8 12689.6 3723.0 3761.6 3796.0 3806.0 3811.6 67466.7 80047.0 81254.2 81594.0 82103.5 11439.2 11554.7 11613.3 11711.5 11888.3 19825.4 21095.3 21373.8 21377.1 21442.8 8636.4 8752.5 8829.0 8903.5 9095.5 4818.7 4898.4 4947.8 5021.4 5052.3 3546.2 3645.7 3652.1 3662.3 3672.5 635.5 656.5 660.8 670.5 676.1 620.6 725.3 736.4 739.6 784.0 9750.2 9751.3 9774.8 10103.6 10172.8 576.5 643.3 680.0 692.8 703.7 4884.5 4922.4 4925.7 4980.9 5063.9 64853.0 65550.7 66818.0 66954.7 114195.0 93654.5 95792.0 96040.0 96388.5 96775.5 82628.6 82750.6 84183.6 84476.6 86600.1 10079.1 10542.4 10624.7 10842.5 10848.7 39884.4 41339.8 48699.0 49048.0 49655.5 66412.3 67649.0 72543.3 74446.0 77681.0 12324.3 12618.3 13002.3 13167.7 14148.4 14308.4 15951.7 16027.5 16113.0 16349.5 13375.3 13833.9 14061.9 14288.9 14745.2 13750.0 13769.8 14059.0 14176.8 15154.9 13446.3 13820.0 13888.1 15021.8 15160.3 11543.0 11619.2 11744.3 11868.9 11901.9 11596.5 11743.8 12380.3 12415.2 12423.3 13:22:31 INFO - PROCESS | 17415 | -------- Summary: end -------- 13:22:31 INFO - PROCESS | 17415 | 13:22:32 INFO - TEST-INFO | 17415: exit 0 13:22:32 INFO - TEST-OK | dromaeo_css | took 1111209ms 13:22:32 INFO - TEST-START | kraken 13:22:32 INFO - operating with platform_type : linux_ 13:22:32 INFO - Initialising browser for kraken test... 13:22:32 INFO - TEST-INFO | started process 17655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXSFQD/profile http://localhost:60554/getInfo.html) 13:22:37 INFO - PROCESS | 17655 | __metrics Screen width/height:1600/1200 13:22:37 INFO - PROCESS | 17655 | colorDepth:24 13:22:37 INFO - PROCESS | 17655 | Browser inner width/height: 1024/697 13:22:37 INFO - PROCESS | 17655 | __metrics 13:22:38 ERROR - PROCESS | 17655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:22:38 INFO - TEST-INFO | 17655: exit 0 13:22:38 INFO - Browser initialized. 13:22:38 INFO - Running cycle 1/1 for kraken test... 13:22:38 INFO - TEST-INFO | started process 17776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXSFQD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:50 INFO - PROCESS | 17776 | RSS: Main: 185102336 13:22:50 INFO - PROCESS | 17776 | 13:22:53 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-beat-detection) 13:22:54 INFO - PROCESS | 17776 | RSS: Main: 191107072 13:22:54 INFO - PROCESS | 17776 | 13:22:56 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-dft) 13:22:57 INFO - PROCESS | 17776 | RSS: Main: 190087168 13:22:57 INFO - PROCESS | 17776 | 13:23:00 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-fft) 13:23:01 INFO - PROCESS | 17776 | RSS: Main: 185143296 13:23:01 INFO - PROCESS | 17776 | 13:23:03 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60554/tests/kraken/driver.html?testName=audio-oscillator) 13:23:03 INFO - PROCESS | 17776 | RSS: Main: 185577472 13:23:03 INFO - PROCESS | 17776 | 13:23:05 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:23:06 INFO - PROCESS | 17776 | RSS: Main: 185696256 13:23:06 INFO - PROCESS | 17776 | 13:23:09 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-darkroom) 13:23:10 INFO - PROCESS | 17776 | RSS: Main: 186179584 13:23:10 INFO - PROCESS | 17776 | 13:23:13 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60554/tests/kraken/driver.html?testName=imaging-desaturate) 13:23:14 INFO - PROCESS | 17776 | RSS: Main: 184840192 13:23:14 INFO - PROCESS | 17776 | 13:23:17 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60554/tests/kraken/driver.html?testName=json-parse-financial) 13:23:17 INFO - PROCESS | 17776 | RSS: Main: 185298944 13:23:17 INFO - PROCESS | 17776 | 13:23:19 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:23:20 INFO - PROCESS | 17776 | RSS: Main: 185675776 13:23:20 INFO - PROCESS | 17776 | 13:23:21 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:23:22 INFO - PROCESS | 17776 | RSS: Main: 185913344 13:23:22 INFO - PROCESS | 17776 | 13:23:24 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:23:25 INFO - PROCESS | 17776 | RSS: Main: 186363904 13:23:25 INFO - PROCESS | 17776 | 13:23:27 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:23:28 INFO - PROCESS | 17776 | RSS: Main: 186421248 13:23:28 INFO - PROCESS | 17776 | 13:23:31 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:23:31 INFO - PROCESS | 17776 | RSS: Main: 186257408 13:23:31 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | Cycle 1(1): loaded http://localhost:60554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60554/tests/kraken/driver.html?testName=ai-astar) 13:23:33 INFO - PROCESS | 17776 | RSS: Main: 187154432 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | __start_tp_report 13:23:33 INFO - PROCESS | 17776 | _x_x_mozilla_page_load 13:23:33 INFO - PROCESS | 17776 | _x_x_mozilla_page_load_details 13:23:33 INFO - PROCESS | 17776 | |i|pagename|runs| 13:23:33 INFO - PROCESS | 17776 | |0;ai-astar;102;111;103;111;111;111;114;112;110;110 13:23:33 INFO - PROCESS | 17776 | |1;audio-beat-detection;156;130;154;183;139;158;155;136;183;127 13:23:33 INFO - PROCESS | 17776 | |2;audio-dft;163;162;161;162;165;168;162;167;161;162 13:23:33 INFO - PROCESS | 17776 | |3;audio-fft;75;76;75;167;75;75;74;75;169;76 13:23:33 INFO - PROCESS | 17776 | |4;audio-oscillator;85;86;142;85;84;89;145;87;86;135 13:23:33 INFO - PROCESS | 17776 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;118;118;117 13:23:33 INFO - PROCESS | 17776 | |6;imaging-darkroom;147;147;148;148;149;146;149;148;146;148 13:23:33 INFO - PROCESS | 17776 | |7;imaging-desaturate;95;96;95;96;96;95;97;97;96;96 13:23:33 INFO - PROCESS | 17776 | |8;json-parse-financial;56;57;56;56;55;55;59;58;57;54 13:23:33 INFO - PROCESS | 17776 | |9;json-stringify-tinderbox;62;61;61;63;61;62;62;63;61;63 13:23:33 INFO - PROCESS | 17776 | |10;stanford-crypto-aes;85;78;84;79;80;81;80;80;92;79 13:23:33 INFO - PROCESS | 17776 | |11;stanford-crypto-ccm;135;124;122;123;139;128;130;125;130;126 13:23:33 INFO - PROCESS | 17776 | |12;stanford-crypto-pbkdf2;160;163;159;159;164;163;162;160;159;163 13:23:33 INFO - PROCESS | 17776 | |13;stanford-crypto-sha256-iterative;65;62;63;63;65;63;63;63;64;67 13:23:33 INFO - PROCESS | 17776 | __end_tp_report 13:23:33 INFO - PROCESS | 17776 | __start_cc_report 13:23:33 INFO - PROCESS | 17776 | _x_x_mozilla_cycle_collect,902 13:23:33 INFO - PROCESS | 17776 | __end_cc_report 13:23:33 INFO - PROCESS | 17776 | __startTimestamp1466540613786__endTimestamp 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | ------- Summary: start ------- 13:23:33 INFO - PROCESS | 17776 | Number of tests: 14 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:3.00 13:23:33 INFO - PROCESS | 17776 | Values: 102.0 111.0 103.0 111.0 111.0 111.0 114.0 112.0 110.0 110.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:155.50 stddev:19.78 (12.7%) stddev-sans-first:20.93 13:23:33 INFO - PROCESS | 17776 | Values: 156.0 130.0 154.0 183.0 139.0 158.0 155.0 136.0 183.0 127.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:2.50 (1.5%) stddev-sans-first:2.65 13:23:33 INFO - PROCESS | 17776 | Values: 163.0 162.0 161.0 162.0 165.0 168.0 162.0 167.0 161.0 162.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.17 (52.2%) stddev-sans-first:40.95 13:23:33 INFO - PROCESS | 17776 | Values: 75.0 76.0 75.0 167.0 75.0 75.0 74.0 75.0 169.0 76.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:85.50 stddev:26.55 (31.1%) stddev-sans-first:27.40 13:23:33 INFO - PROCESS | 17776 | Values: 85.0 86.0 142.0 85.0 84.0 89.0 145.0 87.0 86.0 135.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:23:33 INFO - PROCESS | 17776 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 13:23:33 INFO - PROCESS | 17776 | Values: 147.0 147.0 148.0 148.0 149.0 146.0 149.0 148.0 146.0 148.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 13:23:33 INFO - PROCESS | 17776 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 97.0 97.0 96.0 96.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.49 (2.6%) stddev-sans-first:1.58 13:23:33 INFO - PROCESS | 17776 | Values: 56.0 57.0 56.0 56.0 55.0 55.0 59.0 58.0 57.0 54.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 13:23:33 INFO - PROCESS | 17776 | Values: 62.0 61.0 61.0 63.0 61.0 62.0 62.0 63.0 61.0 63.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:4.21 (5.2%) stddev-sans-first:4.30 13:23:33 INFO - PROCESS | 17776 | Values: 85.0 78.0 84.0 79.0 80.0 81.0 80.0 80.0 92.0 79.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:129.00 stddev:5.45 (4.2%) stddev-sans-first:5.20 13:23:33 INFO - PROCESS | 17776 | Values: 135.0 124.0 122.0 123.0 139.0 128.0 130.0 125.0 130.0 126.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:162.50 stddev:1.99 (1.2%) stddev-sans-first:2.06 13:23:33 INFO - PROCESS | 17776 | Values: 160.0 163.0 159.0 159.0 164.0 163.0 162.0 160.0 159.0 163.0 13:23:33 INFO - PROCESS | 17776 | 13:23:33 INFO - PROCESS | 17776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.48 (2.3%) stddev-sans-first:1.50 13:23:33 INFO - PROCESS | 17776 | Values: 65.0 62.0 63.0 63.0 65.0 63.0 63.0 63.0 64.0 67.0 13:23:33 INFO - PROCESS | 17776 | -------- Summary: end -------- 13:23:33 INFO - PROCESS | 17776 | 13:23:34 INFO - TEST-INFO | 17776: exit 0 13:23:34 INFO - TEST-OK | kraken | took 62214ms 13:23:34 INFO - SUITE-END | took 1173s 13:23:34 INFO - Completed test suite (00:19:33) 13:23:34 INFO - javascript benchmark 13:23:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7306.362737144479, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.4637411640024, 3169.255225022118, 3182.9204269893257, 3191.6967888050626, 3195.3130077033447, 5373.032854086263, 5416.133418653017, 5505.394406615274, 5525.640833345829, 5530.5852061095375, 5394.32570928634, 5443.129099344106, 5451.2640793492865, 5509.614326997112, 5530.778768849251, 4948.505149485059, 4972.105021096201, 5073.289739436464, 5113.693178409308, 5157.742112894341, 571.682071592889, 4899.216125419934, 4900.0689868924965, 4918.36061312029, 4931.841017360917, 4961.9751901240625, 4980.978899325648, 4985.351904252442, 4986.252062190682, 5015.59875209986, 5023.472535383805, 5036.949630503685, 5055.0, 5056.494350564914, 5068.113080210986, 4902.7058376497525, 4929.2359684248995, 4963.255511673242, 4988.326575912241, 4992.525710057539, 5392.083345831218, 5492.231087647732, 5501.037318469252, 5503.347032893826, 5515.0, 5665.8583535411535, 5817.418258174191, 5847.619904706181, 5887.35239123696, 5901.203337549418, 5870.647761134345, 5897.7935772247765, 5911.763529458816, 5970.611910225822, 5979.043353063489, 5525.0883604205255, 5539.889202215933, 5543.390227074979, 5543.473370029841, 5545.694986775726, 5878.323992740804, 5988.520918326523, 6070.150178974947, 6073.757049717962, 6074.058520929263, 5809.331926828384, 5839.503642190376, 5846.883062338729, 5859.5019423349495, 5897.616654917417, 5916.171735956969, 5923.940760592425, 5938.287405511366, 5942.732577034044, 5946.732397042144, 5727.8854422912145, 5819.098039803837, 5847.532197424196, 5877.294724633071, 5906.468417842329, 5833.125031245348, 5901.439363260483, 5902.970485147547, 5905.379935106838, 5933.317668468095, 4438.955610443854, 4482.103579284091, 4499.685022048425, 4501.279795232813, 4501.527339629291, 3940.9802950985636, 3945.822437990297, 3948.0, 3951.05174758056, 4002.0195052212393, 5681.147827825776, 5683.8863222736145, 5701.173329867146, 5716.256886604715, 5717.371089180187, 5956.0, 5982.4914882234625, 5985.670788106696, 5988.9401105989255, 6006.5495087868585, 5502.752376143083, 5649.067903795828, 5697.7151142443545, 5737.483626473554, 5750.798722044792, 5125.256837758504, 5140.228965655182, 5140.897182056338, 5146.76839542214, 5151.793928242903, 5970.104484327298, 6171.56799024073, 6178.104174894705, 6179.104029915727, 6195.659238741822, 5894.911576326359, 5912.793052243151, 5932.673702946379, 5957.582969192288, 5972.13404056418, 6094.238220222473, 6152.200213972155, 6152.384761523812, 6153.077038444269, 6158.938410615837, 5665.178549110274, 5737.5983681141915, 5785.479306862402, 5805.564582656402, 5817.069268916953, 5858.2677165354335, 5963.880722385615, 5970.432808883149, 5983.910241346471, 5986.970065149646, 5716.971415143064, 5809.041508151107, 5835.270591176103, 5838.32859221178, 5853.531717462678, 5680.375158732453, 5781.537477001746, 5796.362400135898, 5802.796902108406, 5829.3296270927685, 5704.657720536781, 5741.8564535886935, 5776.046952252831, 5778.219940308005, 5804.854878628068, 5854.0, 5867.853303667443, 5874.794382196774, 5910.379410161871, 5920.171176035445, 5543.833684989457, 5605.80379686709, 5704.857378565403, 5718.199452076629, 5777.9133313001175], "value": 5412.619061112253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5246666566752, 588.8792797476517, 603.4418163199041, 624.7657128576784, 634.4226753654176, 39345.213095738065, 42479.0, 43213.56786432143, 43312.133757324875, 43329.0, 42972.57027429725, 43839.3424098638, 43847.56152438475, 43936.0, 44036.779816100876, 8845.778855528615, 9028.0, 9048.321375896801, 9062.818743625123, 9066.048064953151, 8892.0, 8973.641054357819, 8974.86537701935, 8979.326550508706, 9008.324375671818, 9049.592768325441, 9062.229710474585, 9067.95466022669, 9068.410553314014, 9099.63601455941, 8989.865152022725, 9011.27909767217, 9070.727878163632, 9092.63629454821, 9102.271818254523, 8928.598213080428, 8951.23914467271, 8985.146411090936, 9034.683786067457, 9036.0, 40553.0, 40616.593834061576, 40794.59205407967, 40953.0, 40955.795221024004, 3569.5538057742783, 3671.9265614687824, 3691.280200360931, 3706.8517259309597, 3770.0386401467727, 32735.672643273738, 32746.6725332746, 32783.18042048944, 33287.83356083228, 34548.65451345479, 4285.579402980621, 4338.717983331074, 4345.826166953318, 4395.362672412514, 4494.348319493688, 320057.0, 320627.0, 321387.0, 322051.0, 323356.38321808475, 60790.392096079355, 60924.390756092755, 61218.0, 61274.387256126865, 61336.0, 35920.28159436849, 36577.45133822995, 36809.44785828215, 38322.616773832466, 38394.42408363877, 16847.241874115694, 17198.14009299555, 17272.827271727372, 17278.13609319529, 17310.740338894928, 13586.320683965761, 13778.311084445939, 13798.448062077405, 13820.516281930084, 13881.167129972235, 19598.804011959983, 19689.803101969082, 19801.900990494956, 19968.90015549913, 20023.59952800936, 7171.318724721144, 7226.313500217471, 7306.853862922711, 7346.302101300368, 7450.85098298031, 988.2686811759246, 1068.4016950507742, 1090.5801266512449, 1098.8406681031206, 1161.959331423413, 32748.64862174354, 32915.0, 32963.0, 33241.501377479355, 33282.16794580155, 1077.2405454154803, 1094.2121672395863, 1112.3492756737398, 1141.19545720267, 1170.5493385046818, 16336.836631633532, 16951.49145525636, 16974.57563560921, 17020.744688829676, 17057.573560661083, 531997.0, 535619.0, 542382.0, 542703.0, 544862.0, 59105.704471477366, 59354.0, 59741.103883441785, 59854.10218846721, 59899.70050149722, 1343.8454577723687, 1345.8384993800807, 1400.5588239704462, 1402.2287741742205, 1412.971740565183, 30483.847580761954, 31180.688193117778, 31379.529307060868, 31489.685103148677, 32236.19409514687, 50317.49682503128, 50889.23666145085, 51127.99999999851, 51206.23190652069, 51248.48751512437, 487411.0, 500541.0, 501007.0, 501673.0, 502154.0, 28679.713202867704, 28784.856075719486, 28991.710082899746, 29051.85474072616, 29186.27034324074, 47935.520644793105, 48959.510404895496, 49112.0, 49701.254481182084, 50089.0, 41646.58353416427, 42111.36832947447, 42423.36364954466, 42903.57096428996, 42958.57041429546, 39877.40490380352, 40221.798891006525, 40303.59696402998, 41629.37555936724, 42307.7884610575, 41077.589224107374, 41646.0, 42386.788066059475, 42755.786221068694, 45437.09125817399, 41576.79211603923, 43236.783816080715, 44990.100197996515, 47975.28037079516, 48095.27857082077, 31587.526187107673, 33323.66676333303, 34724.82637586796, 35088.82455587706, 35159.64840351666], "value": 20400.786572012657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.26246627709025, 387.53689341237197, 389.63958338536867, 396.2728393398114, 406.1714103229412, 18570.0, 19278.421647350566, 19304.131314090864, 19314.51713707158, 19433.0, 18412.0, 18912.243510259606, 19287.132079056442, 19547.5113122172, 19582.314618988337, 5620.662760234379, 5758.0, 5760.7695692172265, 5764.913526297109, 5886.028805247129, 5643.435656434365, 5717.656940583557, 5784.855378615526, 5787.594868359217, 5800.796972105977, 5580.386157522669, 5622.578306626999, 5674.404187560309, 5679.034564124109, 5709.543236541088, 5659.575531835108, 5679.829605111853, 5682.744276507547, 5698.202251684767, 5715.342735585398, 4864.854054378375, 5161.638685292031, 5168.560672342818, 5179.974100129513, 5241.475852414766, 11973.820392694117, 12176.0, 20220.898895505576, 21477.785222147733, 21492.0, 2243.4167116549816, 2271.6933214016226, 2273.9090436382526, 2319.1651005637955, 2833.0, 9801.215902727765, 9910.55402506889, 9912.653057142965, 9964.701058968243, 10013.749656258578, 1831.4414103698366, 1873.812618738129, 1915.1381878154887, 1921.34674210769, 1938.8545859060628, 67594.66202669004, 76319.0, 76425.61787191029, 78051.0, 79332.99999999942, 10751.946240268748, 10788.813230544634, 10952.835707464394, 11103.25177333233, 11219.60731374398, 15290.847091528942, 15330.386784528717, 15389.769153462707, 15433.151176685391, 15512.689746205238, 8200.343972482187, 8207.302379297827, 8268.297194738394, 8405.41162118658, 8498.107698691672, 7978.6808527659405, 8005.559694216874, 8069.273765361146, 8161.63272652732, 8246.793830154294, 4634.884127896762, 4729.858104256878, 4755.619550435957, 4849.636277279218, 4887.462379138292, 1841.3371186372894, 1890.5651700109051, 1916.8658193926292, 1929.4983304340692, 1954.4136758972252, 896.1262768800367, 982.2780256511459, 1018.9796204075877, 1029.1715169288645, 1058.1217589400778, 18103.909480452512, 19611.11749971226, 19812.108455119553, 20108.0, 20875.79124208769, 914.8627705844177, 964.9903500965041, 973.6738192705382, 1007.1942446043282, 1031.5770534080991, 10733.765616953993, 11360.204785664924, 11397.202195846212, 11423.314601123793, 11430.771384572428, 460671.0, 461027.0, 467918.0, 469027.0, 470784.0, 80532.19467805247, 81393.18606813856, 82051.5897420521, 82228.0, 82337.58831205925, 1018.9643362482277, 1025.6666583360288, 1041.109851077318, 1049.0296475759892, 1056.4612047855649, 17158.48524544266, 17205.827941720923, 17607.29570817153, 17632.73550896712, 17830.46508604744, 28679.139625811258, 37883.0, 38096.42855357117, 39265.214695705356, 39854.60145398509, 54188.0, 54845.0, 55907.161392579954, 56174.43825561855, 57489.53849384302, 7415.369693575891, 7840.176781437867, 8698.956505217433, 8766.167214114648, 9120.0, 12026.218295810744, 12043.277403355827, 12162.0, 12559.434825432694, 12779.552715654907, 5869.853253668522, 7559.622018898923, 10875.07561857251, 11086.944565277123, 11091.279066860629, 10477.42374169428, 10773.946130269298, 10863.565457381615, 11014.339139651647, 11329.206955513364, 10810.891891081303, 11046.613368532062, 11205.215634905479, 11356.034737047114, 11661.825072623747, 7387.7783666490095, 7440.218777028334, 8026.919730802851, 8075.313598344206, 8102.351811854919, 10736.0, 10794.56821727122, 11296.322220666787, 11304.717382065513, 11539.711507212387], "value": 8900.672738568983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.8382077971426, 1491.552534239728, 1590.7931968844048, 1720.5182548886307, 1738.9391371302006, 7690.269424404687, 8490.745277641665, 8588.91411085889, 9238.907610923889, 9280.582373793179, 8605.311575073994, 8832.425892317011, 8882.955585222066, 8903.287736981043, 8925.598348074336, 2360.3155085025364, 2397.9640305395433, 2401.7838394544488, 2403.230966090852, 2406.5186962607463, 2373.8694371809543, 2382.8451150675237, 2398.8920498577604, 2409.277216834951, 2409.795167410772, 2339.9883000584973, 2356.846804957681, 2373.4066483379156, 2381.071382160959, 2422.2975337152207, 2183.268605017321, 2184.8798316092607, 2199.2632468123197, 2206.1065268566176, 2286.737025242102, 2227.944301392462, 2228.3760547046854, 2244.461329280977, 2247.4156719252946, 2312.8959196836013, 8993.370464067519, 8998.100189981014, 9020.233280171193, 9023.233025192802, 9085.545722713903, 5341.866453338659, 5452.04589196889, 5455.536279416255, 5459.3994660587305, 5487.341519017704, 3126.296583268769, 3197.536357228189, 3348.598168219805, 3381.3237352529345, 3393.847276872522, 1006.2402885821232, 1026.1226651213256, 1039.1115596165246, 1040.5109598488698, 1051.05405135378, 12804.103712740112, 12808.0, 12862.678433039155, 12862.807057894139, 12909.741805163938, 4754.720751323767, 4792.424909010941, 4832.540908613676, 4879.682820616648, 4914.262860570943, 10727.570897164182, 10728.141748660088, 10743.462826858626, 10760.3543787373, 10762.0, 5439.102548079522, 5476.808311709071, 5478.534324582375, 5483.972580137074, 5485.040117979338, 4363.759993200404, 4742.9762851186215, 4938.111139994836, 4969.925451118236, 4985.925211121836, 4015.558288588253, 4032.6572241359227, 4134.069834287261, 4146.398772178018, 4172.332426811696, 1290.8773666501668, 1310.3972172800427, 1314.4019471140607, 1319.7096638739463, 1325.337331334333, 951.571792693277, 997.4713401897006, 1001.2890847498212, 1004.1163775877181, 1019.9541020654088, 6235.812925612239, 6236.0, 6263.0, 6339.717701627411, 6465.256495502983, 438.4169055156698, 443.9689221754446, 447.4362303497617, 448.4864829769895, 455.55583306276776, 3884.533855937306, 3917.5298964124486, 3918.8824335269987, 3954.62431069048, 3956.090099277182, 10588.047075763217, 10716.464176791129, 11155.553777848796, 11178.664640060812, 11202.495887685074, 10692.786144277226, 10858.782824343469, 10993.560257589766, 11042.503087361089, 11091.72270693239, 8289.461185022954, 8349.165083491724, 8360.749177524684, 8390.0, 8391.076981532027, 6124.234470691164, 6225.968870155621, 6297.433231009231, 6302.590331628429, 6330.303666596763, 9942.0, 9978.800423991333, 10119.0, 10201.183905287411, 10274.640387586398, 10231.181505479693, 10331.431771252654, 10368.326058806153, 10379.532921018723, 10407.427591482237, 7294.416446684359, 7500.624968751432, 7751.612419379121, 7952.721654742057, 8048.476849004796, 8798.208161265517, 8814.0, 8859.512726800089, 8879.644814207359, 8892.15524525169, 7855.7250496232355, 8045.195480452142, 8069.87895181561, 8095.39284553649, 8195.590220489072, 7542.773716788505, 7603.239676032353, 7882.0, 7905.249001344863, 8052.597370131352, 6757.391834734897, 7167.7132914682825, 7258.0927384076995, 7269.890951635624, 7274.127104747464, 5465.890682186414, 5533.474319939599, 5558.44415558441, 5621.100623900156, 5627.606067575231, 5477.917831232455, 5487.067198576331, 5487.368952570346, 5578.525825304894, 5672.886542269214], "value": 4626.968373495249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.99362012759747, 333.4098645397646, 335.8639750900885, 336.4717393691903, 343.4933473127139, 5450.31871016123, 5487.835364939048, 5547.944520554794, 5628.705397758518, 5644.774209031634, 5567.4432556744405, 5578.135389014699, 5589.832305030855, 5590.552755779538, 5597.272354593897, 4356.6514678825615, 4366.694331396803, 4377.168338015783, 4383.495897971734, 4418.072204836988, 4330.285502892035, 4345.587169218935, 4373.387725718402, 4406.2289099407635, 4430.6012458878695, 4313.935290970638, 4341.565843415665, 4351.847685331014, 4352.107817897323, 4373.584509471611, 4173.582641735832, 4388.824447022115, 4404.163208990281, 4412.492563355191, 4413.227685155101, 3806.8198858354, 3841.0, 3854.4218367244857, 3877.9224415511812, 3878.3019056569806, 5437.401885792559, 5437.8368648940595, 5438.320209973754, 5445.373782015079, 5466.125419932791, 4883.780229889663, 4884.780184891689, 4940.752962351868, 4941.382327209099, 4957.752112394402, 5767.0, 5808.535317174616, 5818.156367326714, 5821.15593238978, 5842.328132264802, 4204.432401625802, 4242.596953289432, 4250.617444429985, 4276.743395396286, 4284.700070995032, 5832.658488547615, 6014.2482189726725, 6114.663693496856, 6115.327313995457, 6137.833811575786, 4349.978250108729, 4359.629431498295, 4374.365716971085, 4384.539623339567, 4389.978050109729, 4420.9115817684105, 4438.622717069021, 4440.33394990754, 4448.644108471314, 4448.644108471314, 4907.141250281186, 4952.316212487772, 5022.221555658879, 5022.296878437021, 5049.974750126225, 5620.156976453564, 5740.110282906073, 5890.352061273256, 5893.5579831512805, 5894.0, 1516.8483151684743, 1531.7625768005978, 1536.1167328785994, 1536.1474381718253, 1548.0943647965842, 970.5341436110706, 975.317277905469, 999.9700008999741, 1010.661428421487, 1010.8736407949007, 4980.352554167935, 5069.771860266297, 5093.701106217891, 5131.692098474104, 5150.4334523202415, 5259.526642602184, 5320.920186197211, 5409.161579955114, 5417.864553386197, 5430.647007944471, 4891.413030436371, 4947.356843610308, 5044.520770526794, 5082.771275292621, 5090.898182036339, 2847.302410909299, 2854.9143525694262, 2878.7545714342846, 2882.135359392174, 2884.351021020296, 5460.481254280837, 5464.644798088111, 5473.7263136843, 5507.7246137692955, 5549.223108764776, 5367.765413954812, 5669.582604348912, 6183.165272688219, 6218.6268823869805, 6226.626402415779, 6221.2845522765465, 6288.591241569192, 6293.748250070037, 6306.716197771111, 6339.017452294902, 5936.0, 6000.189974353407, 6021.458068773832, 6074.66589337573, 6140.0, 5951.809638072316, 5988.790392336247, 6001.459868611846, 6009.158717779427, 6062.363451837494, 6089.817305480843, 6337.619742815262, 6392.4246817786625, 6393.520485963664, 6408.1349017881985, 4235.894102647459, 4249.3215180004345, 4281.464816897887, 4281.807318670605, 4303.50509691377, 5995.0407934731975, 6081.27024757032, 6113.663748493876, 6184.319724830175, 6217.689115544114, 5879.559033072451, 5895.056790913433, 5895.263092113486, 5906.468417842415, 5933.554983376178, 5821.94178058214, 5840.970795145997, 5884.264466941632, 5919.171316015847, 5952.464278214981, 5583.860403489945, 5698.8290351289525, 5751.4536119068625, 5760.020796464527, 5771.249737534094, 5876.678711908687, 5962.850928726816, 5994.160817485468, 5996.520278377807, 6013.609115407485, 5716.514096301861, 5828.94171058284, 5848.239728835224, 5860.267466566679, 5862.0], "value": 4415.219731569367, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.8957940678007, 808.3613944983462, 824.142891392951, 824.7855557555034, 837.8324335132975, 15246.771298430518, 15760.921195394036, 15853.048817070983, 15875.047497150179, 15931.0, 13798.517051903185, 13960.301984900765, 14022.368993395296, 14042.92978535106, 14756.852431475681, 811.4847072109224, 812.1229072601606, 816.657004058294, 816.8447994880984, 817.9713710020151, 802.1657476224719, 805.6656487557657, 807.0, 807.4509333653114, 814.3770015937812, 853.7780177153953, 854.974350769478, 862.6851199312268, 864.360373323739, 864.8097418567905, 850.4174640371334, 850.5449584472277, 852.6248450681711, 853.684136869356, 854.6068808348167, 617.5461036138435, 626.5520153090562, 629.9401556852092, 630.9621422714652, 631.5011141198494, 14612.26938653063, 14691.0, 14735.778963315559, 14800.925995369955, 14971.925140374336, 13877.37551810161, 14157.362918668581, 14257.500987465493, 14485.493007744784, 14487.753712163734, 12409.131360804748, 12433.689157771129, 12605.0, 12664.81002784959, 12689.61931142058, 3722.9627703722886, 3761.605031471711, 3795.962040379616, 3805.961940380616, 3811.6188381161937, 67466.66266668733, 80047.0, 81254.18745812585, 81594.0, 82103.48430836301, 11439.199256052163, 11554.711132221593, 11613.30320180792, 11711.472983715754, 11888.28670279786, 19825.405237842886, 21095.261665841623, 21373.78626213749, 21377.144914203258, 21442.78557214408, 8636.438631488933, 8752.47485150893, 8828.955855220684, 8903.465792052368, 9095.545222738836, 4818.6626936114835, 4898.363212782387, 4947.777350019186, 5021.447640759514, 5052.317937078521, 3546.2375589247918, 3645.744797864177, 3652.0687224757517, 3662.3407786598136, 3672.5042119314085, 635.5265327331168, 656.4846595422571, 660.8347913021745, 670.4904272752743, 676.1176664452838, 620.5935112501319, 725.2638571849577, 736.3624682474497, 739.5858319341079, 783.9882401763978, 9750.221186961682, 9751.317407781387, 9774.755631109138, 10103.595856165817, 10172.779266488069, 576.4840467781312, 643.250613035808, 679.952403331772, 692.8337199072187, 703.711478293897, 4884.535969082932, 4922.360093187863, 4925.729084900293, 4980.900381992412, 5063.873403164876, 64853.0, 65550.67224663847, 66818.0, 66954.66522667356, 114195.0, 93654.53172734093, 95792.0, 96040.0, 96388.51805741066, 96775.51612242035, 82628.58685706533, 82750.58624706959, 84183.5790821042, 84476.57761711151, 86600.13399866047, 10079.13535995843, 10542.420166890895, 10624.681259562225, 10842.457877105955, 10848.67453976382, 39884.401733973435, 41339.7933010333, 48699.0, 49048.0, 49655.50344496653, 66412.33587664062, 67649.0, 72543.27456725365, 74446.0, 77681.0, 12324.260544367367, 12618.305993170463, 13002.349882506027, 13167.67080822987, 14148.43406263738, 14308.427662893784, 15951.68096638084, 16027.519174424786, 16113.0, 16349.509514714578, 13375.26436045988, 13833.930830345784, 14061.931146608915, 14288.928555357157, 14745.189014603871, 13750.0, 13769.793453098011, 14059.0, 14176.787348189991, 15154.924225378803, 13446.260455675032, 13820.032597718466, 13888.097273677178, 15021.849781502046, 15160.31778569945, 11543.0, 11619.231211014974, 11744.29534227949, 11868.940655296668, 11901.86375064819, 11596.536138554364, 11743.765124697287, 12380.257184568954, 12415.193012454161, 12423.254604723745], "value": 7575.96750567767, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 103.0, 111.0, 111.0, 111.0, 114.0, 112.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 154.0, 183.0, 139.0, 158.0, 155.0, 136.0, 183.0, 127.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 165.0, 168.0, 162.0, 167.0, 161.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 167.0, 75.0, 75.0, 74.0, 75.0, 169.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 142.0, 85.0, 84.0, 89.0, 145.0, 87.0, 86.0, 135.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 149.0, 146.0, 149.0, 148.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 55.0, 55.0, 59.0, 58.0, 57.0, 54.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 62.0, 63.0, 61.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 84.0, 79.0, 80.0, 81.0, 80.0, 80.0, 92.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 122.0, 123.0, 139.0, 128.0, 130.0, 125.0, 130.0, 126.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 159.0, 159.0, 164.0, 163.0, 162.0, 160.0, 159.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 64.0, 67.0], "value": 63.8, "unit": "score"}]}]} 13:23:35 INFO - Return code: 0 13:23:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:23:35 ERROR - # TBPL SUCCESS # 13:23:35 INFO - Running post-action listener: _resource_record_post_action 13:23:35 INFO - ##### 13:23:35 INFO - ##### Finished run-tests step (success) 13:23:35 INFO - ##### 13:23:35 INFO - Running post-run listener: _resource_record_post_run 13:23:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400982016; Read time: 16; Write time: 458640 13:23:35 INFO - TinderboxPrint: CPU usage
13.5% 13:23:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:23:35 INFO - TinderboxPrint: I/O write bytes / time
400,982,016 / 458,640 13:23:35 INFO - TinderboxPrint: CPU idle
8,225.8 (86.5%) 13:23:35 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 13:23:35 INFO - TinderboxPrint: Swap in / out
0 / 0 13:23:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111267840; Read time: 0; Write time: 140044 13:23:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289595392; Read time: 16; Write time: 318564 13:23:35 INFO - Running post-run listener: _upload_blobber_files 13:23:35 INFO - Blob upload gear active. 13:23:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:23:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:23:35 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:23:35 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:23:36 INFO - (blobuploader) - INFO - Open directory for files ... 13:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:36 INFO - (blobuploader) - INFO - Done attempting. 13:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:23:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:40 INFO - (blobuploader) - INFO - Done attempting. 13:23:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:23:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:23:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:41 INFO - (blobuploader) - INFO - Done attempting. 13:23:41 INFO - (blobuploader) - INFO - Iteration through files over. 13:23:41 INFO - Return code: 0 13:23:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:23:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:23:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a602c6e09d6e62aa1377a34a88c77b3ac5e604416b632aaac275a022234244e34f703d31c367ad06d0f0a643b2f7ef830f797f639a87e207908143ecb59dc4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a070f18d445b0b22c492b6566750538706fb480db67dd5e710441ca76a5c12397b5fcc557f18ef73bdd990d1eaa1ab2420a6e934560f7cb445a25837be70c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8d3e9e26cbc7c298f7bdeddfaa3384fc87a6f4496af1044270c52d6143f2810a5cfa3b729c7a27178cf77e2a1b1d8664bbe504bf273bdf917cccf2788418542"} 13:23:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:23:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:23:41 INFO - Contents: 13:23:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a602c6e09d6e62aa1377a34a88c77b3ac5e604416b632aaac275a022234244e34f703d31c367ad06d0f0a643b2f7ef830f797f639a87e207908143ecb59dc4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a070f18d445b0b22c492b6566750538706fb480db67dd5e710441ca76a5c12397b5fcc557f18ef73bdd990d1eaa1ab2420a6e934560f7cb445a25837be70c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8d3e9e26cbc7c298f7bdeddfaa3384fc87a6f4496af1044270c52d6143f2810a5cfa3b729c7a27178cf77e2a1b1d8664bbe504bf273bdf917cccf2788418542"} 13:23:41 INFO - Running post-run listener: copy_logs_to_upload_dir 13:23:41 INFO - Copying logs to upload dir... 13:23:41 INFO - mkdir: /builds/slave/test/build/upload/logs 13:23:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.911678 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-06-21 13:23:40.971707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:40.975549) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 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-Inbound/sha512/7a602c6e09d6e62aa1377a34a88c77b3ac5e604416b632aaac275a022234244e34f703d31c367ad06d0f0a643b2f7ef830f797f639a87e207908143ecb59dc4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a070f18d445b0b22c492b6566750538706fb480db67dd5e710441ca76a5c12397b5fcc557f18ef73bdd990d1eaa1ab2420a6e934560f7cb445a25837be70c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8d3e9e26cbc7c298f7bdeddfaa3384fc87a6f4496af1044270c52d6143f2810a5cfa3b729c7a27178cf77e2a1b1d8664bbe504bf273bdf917cccf2788418542"} build_url:https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a602c6e09d6e62aa1377a34a88c77b3ac5e604416b632aaac275a022234244e34f703d31c367ad06d0f0a643b2f7ef830f797f639a87e207908143ecb59dc4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a070f18d445b0b22c492b6566750538706fb480db67dd5e710441ca76a5c12397b5fcc557f18ef73bdd990d1eaa1ab2420a6e934560f7cb445a25837be70c4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f8d3e9e26cbc7c298f7bdeddfaa3384fc87a6f4496af1044270c52d6143f2810a5cfa3b729c7a27178cf77e2a1b1d8664bbe504bf273bdf917cccf2788418542"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:41.001926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:41.002336) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466534235.268459-924778249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:41.087276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 13:23:41.087679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 13:23:41.088057) ========= ========= Total master_lag: 0.22 =========