builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1466539359.48 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.481738) ========= 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.482206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.482544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.497949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.498278) ========= 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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.8M=0s 2016-06-21 13:02:40 (53.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.622319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.622653) ========= 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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.671948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:39.672328) ========= 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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 13:02:40,142 truncating revision to first 12 chars 2016-06-21 13:02:40,142 Setting DEBUG logging. 2016-06-21 13:02:40,142 attempt 1/10 2016-06-21 13:02:40,142 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,564 unpacking tar archive at: mozilla-inbound-5ac2f675c083/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:40.470397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:40.470976) ========= script_repo_revision: 5ac2f675c083d59ef6329d164cf92733ab344557 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:40.471626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:40.471937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 13:02:40.482589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 13:02:40.482973) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 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 --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', 13:02:41 INFO - 'system_bits': '32', 13:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:02:41 INFO - 'title': 'talos-linux64-ix-058', 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:42 INFO - Running post-action listener: _resource_record_post_action 13:02:42 INFO - ##### 13:02:42 INFO - ##### Finished clobber step (success) 13:02:42 INFO - ##### 13:02:42 INFO - ##### 13:02:42 INFO - ##### Running read-buildbot-config step. 13:02:42 INFO - ##### 13:02:42 INFO - Running pre-action listener: _resource_record_pre_action 13:02:42 INFO - Running main action method: read_buildbot_config 13:02:42 INFO - Using buildbot properties: 13:02:42 INFO - { 13:02:42 INFO - "project": "", 13:02:42 INFO - "product": "firefox", 13:02:42 INFO - "script_repo_revision": "production", 13:02:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:02:42 INFO - "repository": "", 13:02:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:02:42 INFO - "buildid": "20160621103055", 13:02:42 INFO - "pgo_build": "True", 13:02:42 INFO - "basedir": "/builds/slave/test", 13:02:42 INFO - "buildnumber": 1965, 13:02:42 INFO - "slavename": "talos-linux64-ix-058", 13:02:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:02:42 INFO - "platform": "ubuntu64_hw", 13:02:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:02:42 INFO - "branch": "mozilla-inbound", 13:02:42 INFO - "repo_path": "integration/mozilla-inbound", 13:02:42 INFO - "revision": "5ac2f675c083d59ef6329d164cf92733ab344557", 13:02:42 INFO - "stage_platform": "linux64-pgo", 13:02:42 INFO - "builduid": "fb2ce4740fb04e6d9ddfd9f8c071170b", 13:02:42 INFO - "slavebuilddir": "test" 13:02:42 INFO - } 13:02:42 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:42 INFO - Running post-action listener: _resource_record_post_action 13:02:42 INFO - ##### 13:02:42 INFO - ##### Finished read-buildbot-config step (success) 13:02:42 INFO - ##### 13:02:42 INFO - ##### 13:02:42 INFO - ##### Running download-and-extract step. 13:02:42 INFO - ##### 13:02:42 INFO - Running pre-action listener: _resource_record_pre_action 13:02:42 INFO - Running main action method: download_and_extract 13:02:42 INFO - mkdir: /builds/slave/test/build/tests 13:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:42 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:42 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:42 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:42 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:42 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:43 INFO - Downloaded 1361 bytes. 13:02:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:02:43 INFO - Using the following test package requirements: 13:02:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:02:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:02:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'jsshell-linux-x86_64.zip'], 13:02:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:02:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:02:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:02:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:02:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:02:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:02:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:02:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:02:43 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:43 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:43 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:43 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:43 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:43 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:46 INFO - Downloaded 24226042 bytes. 13:02:46 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:46 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:02:47 INFO - Return code: 0 13:02:47 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:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:47 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:47 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:47 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:47 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:47 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:50 INFO - Downloaded 24226042 bytes. 13:02:50 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:50 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:02:52 INFO - Return code: 0 13:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:52 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:02:52 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:02:52 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:02:52 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:02:52 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:02:53 INFO - Downloaded 14405384 bytes. 13:02:53 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:02:53 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:02:53 INFO - Return code: 0 13:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:02:53 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:02:53 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:02:53 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:02:53 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:02:53 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:02:58 INFO - Downloaded 60120933 bytes. 13:02:58 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:02:58 INFO - mkdir: /builds/slave/test/properties 13:02:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:02:58 INFO - Writing to file /builds/slave/test/properties/build_url 13:02:58 INFO - Contents: 13:02:58 INFO - build_url:https://queue.taskcluster.net/v1/task/VTIKP7qfRt2rWsyzH4f39g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:02:58 INFO - Running post-action listener: _resource_record_post_action 13:02:58 INFO - Running post-action listener: set_extra_try_arguments 13:02:58 INFO - ##### 13:02:58 INFO - ##### Finished download-and-extract step (success) 13:02:58 INFO - ##### 13:02:58 INFO - ##### 13:02:58 INFO - ##### Running populate-webroot step. 13:02:58 INFO - ##### 13:02:58 INFO - Running pre-action listener: _resource_record_pre_action 13:02:58 INFO - Running main action method: populate_webroot 13:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:02:58 INFO - '--tppagecycles', 13:02:58 INFO - '7'], 13:02:58 INFO - 'tests': ['tsvgm']}}, 13:02:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:02:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:02:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:02:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:02:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:02:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['damp', 'tps']}, 13:02:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'tests': ['damp', 'tps']}, 13:02:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['dromaeo_dom']}, 13:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:02:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['basic_compositor_video']}, 13:02:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:02:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'other-e10s': {'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['a11yr', 13:02:58 INFO - 'ts_paint', 13:02:58 INFO - 'tpaint', 13:02:58 INFO - 'sessionrestore', 13:02:58 INFO - 'sessionrestore_no_auto_restore', 13:02:58 INFO - 'tabpaint']}, 13:02:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['tsvgx', 13:02:58 INFO - 'tsvgr_opacity', 13:02:58 INFO - 'tart', 13:02:58 INFO - 'tscrollx', 13:02:58 INFO - 'cart']}, 13:02:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:02:58 INFO - 'tsvgr_opacity', 13:02:58 INFO - 'tart', 13:02:58 INFO - 'tscrollx', 13:02:58 INFO - 'cart']}, 13:02:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'talos_options': ['--disable-e10s'], 13:02:58 INFO - 'tests': ['tp5o']}, 13:02:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'tests': ['tp5o']}, 13:02:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'talos_options': ['--disable-e10s', 13:02:58 INFO - '--xperf_path', 13:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:58 INFO - 'tests': ['tp5n']}, 13:02:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:02:58 INFO - 'talos_options': ['--xperf_path', 13:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:02:58 INFO - 'tests': ['tp5n']}}, 13:02:58 INFO - 'talos.zip': {'path': '', 13:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:02:58 INFO - Running post-action listener: _resource_record_post_action 13:02:58 INFO - ##### 13:02:58 INFO - ##### Finished populate-webroot step (success) 13:02:58 INFO - ##### 13:02:58 INFO - ##### 13:02:58 INFO - ##### Running create-virtualenv step. 13:02:58 INFO - ##### 13:02:58 INFO - Running pre-action listener: _resource_record_pre_action 13:02:58 INFO - Running main action method: create_virtualenv 13:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 13:02:58 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:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:02:58 INFO - Using real prefix '/usr' 13:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:02:59 INFO - Installing distribute.............................................................................................................................................................................................done. 13:03:01 INFO - Installing pip.................done. 13:03:01 INFO - Return code: 0 13:03:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:03:01 INFO - Using env: {'DISPLAY': ':0', 13:03:01 INFO - 'HOME': '/home/cltbld', 13:03:01 INFO - 'LANG': 'en_US.UTF-8', 13:03:01 INFO - 'LANGUAGE': 'en_US:en', 13:03:01 INFO - 'LOGNAME': 'cltbld', 13:03:01 INFO - 'MAIL': '/var/mail/cltbld', 13:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:01 INFO - 'MOZ_NO_REMOTE': '1', 13:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:01 INFO - 'NO_EM_RESTART': '1', 13:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:01 INFO - 'PWD': '/builds/slave/test', 13:03:01 INFO - 'SHELL': '/bin/bash', 13:03:01 INFO - 'SHLVL': '1', 13:03:01 INFO - 'TERM': 'linux', 13:03:01 INFO - 'TMOUT': '86400', 13:03:01 INFO - 'USER': 'cltbld', 13:03:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:01 INFO - '_': '/tools/buildbot/bin/python'} 13:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:01 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:01 INFO - Cleaning up... 13:03:01 INFO - Return code: 0 13:03:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:03:01 INFO - Using env: {'DISPLAY': ':0', 13:03:01 INFO - 'HOME': '/home/cltbld', 13:03:01 INFO - 'LANG': 'en_US.UTF-8', 13:03:01 INFO - 'LANGUAGE': 'en_US:en', 13:03:01 INFO - 'LOGNAME': 'cltbld', 13:03:01 INFO - 'MAIL': '/var/mail/cltbld', 13:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:01 INFO - 'MOZ_NO_REMOTE': '1', 13:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:01 INFO - 'NO_EM_RESTART': '1', 13:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:01 INFO - 'PWD': '/builds/slave/test', 13:03:01 INFO - 'SHELL': '/bin/bash', 13:03:01 INFO - 'SHLVL': '1', 13:03:01 INFO - 'TERM': 'linux', 13:03:01 INFO - 'TMOUT': '86400', 13:03:01 INFO - 'USER': 'cltbld', 13:03:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:01 INFO - '_': '/tools/buildbot/bin/python'} 13:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:01 INFO - Downloading/unpacking psutil>=3.1.1 13:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:03:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:03 INFO - Installing collected packages: psutil 13:03:03 INFO - Running setup.py install for psutil 13:03:03 INFO - building 'psutil._psutil_linux' extension 13:03:03 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:04 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:04 INFO - building 'psutil._psutil_posix' extension 13:03:04 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:04 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:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:03:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:03:04 INFO - Successfully installed psutil 13:03:04 INFO - Cleaning up... 13:03:04 INFO - Return code: 0 13:03:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:03:04 INFO - Using env: {'DISPLAY': ':0', 13:03:04 INFO - 'HOME': '/home/cltbld', 13:03:04 INFO - 'LANG': 'en_US.UTF-8', 13:03:04 INFO - 'LANGUAGE': 'en_US:en', 13:03:04 INFO - 'LOGNAME': 'cltbld', 13:03:04 INFO - 'MAIL': '/var/mail/cltbld', 13:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:04 INFO - 'MOZ_NO_REMOTE': '1', 13:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:04 INFO - 'NO_EM_RESTART': '1', 13:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:04 INFO - 'PWD': '/builds/slave/test', 13:03:04 INFO - 'SHELL': '/bin/bash', 13:03:04 INFO - 'SHLVL': '1', 13:03:04 INFO - 'TERM': 'linux', 13:03:04 INFO - 'TMOUT': '86400', 13:03:04 INFO - 'USER': 'cltbld', 13:03:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:04 INFO - '_': '/tools/buildbot/bin/python'} 13:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:03:06 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:06 INFO - Installing collected packages: mozsystemmonitor 13:03:06 INFO - Running setup.py install for mozsystemmonitor 13:03:06 INFO - Successfully installed mozsystemmonitor 13:03:06 INFO - Cleaning up... 13:03:06 INFO - Return code: 0 13:03:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:03:06 INFO - Using env: {'DISPLAY': ':0', 13:03:06 INFO - 'HOME': '/home/cltbld', 13:03:06 INFO - 'LANG': 'en_US.UTF-8', 13:03:06 INFO - 'LANGUAGE': 'en_US:en', 13:03:06 INFO - 'LOGNAME': 'cltbld', 13:03:06 INFO - 'MAIL': '/var/mail/cltbld', 13:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:06 INFO - 'MOZ_NO_REMOTE': '1', 13:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:06 INFO - 'NO_EM_RESTART': '1', 13:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:06 INFO - 'PWD': '/builds/slave/test', 13:03:06 INFO - 'SHELL': '/bin/bash', 13:03:06 INFO - 'SHLVL': '1', 13:03:06 INFO - 'TERM': 'linux', 13:03:06 INFO - 'TMOUT': '86400', 13:03:06 INFO - 'USER': 'cltbld', 13:03:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:06 INFO - '_': '/tools/buildbot/bin/python'} 13:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:06 INFO - Downloading/unpacking jsonschema==2.5.1 13:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:03:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:09 INFO - Downloading functools32-3.2.3-2.tar.gz 13:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:03:09 INFO - warning: no files found matching '*.txt' 13:03:09 INFO - no previously-included directories found matching 'build' 13:03:09 INFO - no previously-included directories found matching 'dist' 13:03:09 INFO - no previously-included directories found matching '.git*' 13:03:09 INFO - Installing collected packages: jsonschema, functools32 13:03:09 INFO - Running setup.py install for functools32 13:03:09 INFO - warning: no files found matching '*.txt' 13:03:09 INFO - no previously-included directories found matching 'build' 13:03:09 INFO - no previously-included directories found matching 'dist' 13:03:09 INFO - no previously-included directories found matching '.git*' 13:03:09 INFO - Successfully installed jsonschema functools32 13:03:09 INFO - Cleaning up... 13:03:09 INFO - Return code: 0 13:03:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:09 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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 13:03:09 INFO - 'HOME': '/home/cltbld', 13:03:09 INFO - 'LANG': 'en_US.UTF-8', 13:03:09 INFO - 'LANGUAGE': 'en_US:en', 13:03:09 INFO - 'LOGNAME': 'cltbld', 13:03:09 INFO - 'MAIL': '/var/mail/cltbld', 13:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:09 INFO - 'MOZ_NO_REMOTE': '1', 13:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:09 INFO - 'NO_EM_RESTART': '1', 13:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:09 INFO - 'PWD': '/builds/slave/test', 13:03:09 INFO - 'SHELL': '/bin/bash', 13:03:09 INFO - 'SHLVL': '1', 13:03:09 INFO - 'TERM': 'linux', 13:03:09 INFO - 'TMOUT': '86400', 13:03:09 INFO - 'USER': 'cltbld', 13:03:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:09 INFO - '_': '/tools/buildbot/bin/python'} 13:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:11 INFO - Downloading blobuploader-1.2.4.tar.gz 13:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:03:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:03:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:12 INFO - Downloading docopt-0.6.1.tar.gz 13:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:03:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:03:12 INFO - Running setup.py install for blobuploader 13:03:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:03:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:03:12 INFO - Running setup.py install for requests 13:03:12 INFO - Running setup.py install for docopt 13:03:12 INFO - Successfully installed blobuploader requests docopt 13:03:12 INFO - Cleaning up... 13:03:12 INFO - Return code: 0 13:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:12 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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 13:03:12 INFO - 'HOME': '/home/cltbld', 13:03:12 INFO - 'LANG': 'en_US.UTF-8', 13:03:12 INFO - 'LANGUAGE': 'en_US:en', 13:03:12 INFO - 'LOGNAME': 'cltbld', 13:03:12 INFO - 'MAIL': '/var/mail/cltbld', 13:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:12 INFO - 'MOZ_NO_REMOTE': '1', 13:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:12 INFO - 'NO_EM_RESTART': '1', 13:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:12 INFO - 'PWD': '/builds/slave/test', 13:03:12 INFO - 'SHELL': '/bin/bash', 13:03:12 INFO - 'SHLVL': '1', 13:03:12 INFO - 'TERM': 'linux', 13:03:12 INFO - 'TMOUT': '86400', 13:03:12 INFO - 'USER': 'cltbld', 13:03:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:12 INFO - '_': '/tools/buildbot/bin/python'} 13:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:13 INFO - Running setup.py (path:/tmp/pip-rBUHuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:13 INFO - Running setup.py (path:/tmp/pip-RQ0Y_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:13 INFO - Running setup.py (path:/tmp/pip-A9vQ5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:13 INFO - Running setup.py (path:/tmp/pip-xWNoed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:13 INFO - Running setup.py (path:/tmp/pip-gEvlys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:13 INFO - Running setup.py (path:/tmp/pip-esqeAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:13 INFO - Running setup.py (path:/tmp/pip-WryRLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:13 INFO - Running setup.py (path:/tmp/pip-6AP5EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:13 INFO - Running setup.py (path:/tmp/pip-525xSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:13 INFO - Running setup.py (path:/tmp/pip-gkeyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:13 INFO - Running setup.py (path:/tmp/pip-bKzplU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:13 INFO - Running setup.py (path:/tmp/pip-4taNxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:13 INFO - Running setup.py (path:/tmp/pip-SMbW26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:13 INFO - Running setup.py (path:/tmp/pip-PTjAGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:14 INFO - Running setup.py (path:/tmp/pip-ZKH2Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:14 INFO - Running setup.py (path:/tmp/pip-zyhyIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:14 INFO - Running setup.py (path:/tmp/pip-DpByJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:03:14 INFO - Running setup.py install for manifestparser 13:03:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:03:14 INFO - Running setup.py install for mozcrash 13:03:14 INFO - Running setup.py install for mozdebug 13:03:14 INFO - Running setup.py install for mozdevice 13:03:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:03:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:03:14 INFO - Running setup.py install for mozfile 13:03:14 INFO - Running setup.py install for mozhttpd 13:03:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:03:14 INFO - Running setup.py install for mozinfo 13:03:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:03:14 INFO - Running setup.py install for mozInstall 13:03:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Running setup.py install for mozleak 13:03:15 INFO - Running setup.py install for mozlog 13:03:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Running setup.py install for moznetwork 13:03:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Running setup.py install for mozprocess 13:03:15 INFO - Running setup.py install for mozprofile 13:03:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Running setup.py install for mozrunner 13:03:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:03:15 INFO - Running setup.py install for mozscreenshot 13:03:15 INFO - Running setup.py install for moztest 13:03:15 INFO - Running setup.py install for mozversion 13:03:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:03:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:03:16 INFO - Cleaning up... 13:03:16 INFO - Return code: 0 13:03:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:16 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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 13:03:16 INFO - 'HOME': '/home/cltbld', 13:03:16 INFO - 'LANG': 'en_US.UTF-8', 13:03:16 INFO - 'LANGUAGE': 'en_US:en', 13:03:16 INFO - 'LOGNAME': 'cltbld', 13:03:16 INFO - 'MAIL': '/var/mail/cltbld', 13:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:16 INFO - 'MOZ_NO_REMOTE': '1', 13:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:16 INFO - 'NO_EM_RESTART': '1', 13:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:16 INFO - 'PWD': '/builds/slave/test', 13:03:16 INFO - 'SHELL': '/bin/bash', 13:03:16 INFO - 'SHLVL': '1', 13:03:16 INFO - 'TERM': 'linux', 13:03:16 INFO - 'TMOUT': '86400', 13:03:16 INFO - 'USER': 'cltbld', 13:03:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:16 INFO - '_': '/tools/buildbot/bin/python'} 13:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:03:16 INFO - Running setup.py (path:/tmp/pip-Zvtj6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:03:16 INFO - Running setup.py (path:/tmp/pip-x90UK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:03:16 INFO - Running setup.py (path:/tmp/pip-mgrsEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:03:16 INFO - Running setup.py (path:/tmp/pip-1TxNs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:03:16 INFO - Running setup.py (path:/tmp/pip-wPZvR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:03:16 INFO - Running setup.py (path:/tmp/pip-8NoD05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:03:16 INFO - Running setup.py (path:/tmp/pip-TMJVX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:03:16 INFO - Running setup.py (path:/tmp/pip-EGZtq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:03:16 INFO - Running setup.py (path:/tmp/pip-0sy_Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:03:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:03:16 INFO - Running setup.py (path:/tmp/pip-Jo0HYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:03:17 INFO - Running setup.py (path:/tmp/pip-CTC0JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:03:17 INFO - Running setup.py (path:/tmp/pip-_wSsbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:03:17 INFO - Running setup.py (path:/tmp/pip-4KYLi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:03:17 INFO - Running setup.py (path:/tmp/pip-xuJMyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:17 INFO - Running setup.py (path:/tmp/pip-DscN05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:03:17 INFO - Running setup.py (path:/tmp/pip-7Q6HjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:03:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:03:17 INFO - Running setup.py (path:/tmp/pip-Nc5reb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:03:17 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:17 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:17 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:17 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:17 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:17 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:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:19 INFO - Downloading blessings-1.6.tar.gz 13:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:03:19 INFO - Installing collected packages: blessings 13:03:19 INFO - Running setup.py install for blessings 13:03:19 INFO - Successfully installed blessings 13:03:19 INFO - Cleaning up... 13:03:19 INFO - Return code: 0 13:03:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:03:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:19 INFO - Reading from file tmpfile_stdout 13:03:19 INFO - Current package versions: 13:03:19 INFO - argparse == 1.2.1 13:03:19 INFO - blessings == 1.6 13:03:19 INFO - blobuploader == 1.2.4 13:03:19 INFO - docopt == 0.6.1 13:03:19 INFO - functools32 == 3.2.3-2 13:03:19 INFO - jsonschema == 2.5.1 13:03:19 INFO - manifestparser == 1.1 13:03:19 INFO - mozInstall == 1.12 13:03:19 INFO - mozcrash == 0.17 13:03:19 INFO - mozdebug == 0.1 13:03:19 INFO - mozdevice == 0.48 13:03:19 INFO - mozfile == 1.2 13:03:19 INFO - mozhttpd == 0.7 13:03:19 INFO - mozinfo == 0.9 13:03:19 INFO - mozleak == 0.1 13:03:19 INFO - mozlog == 3.2 13:03:19 INFO - moznetwork == 0.27 13:03:19 INFO - mozprocess == 0.22 13:03:19 INFO - mozprofile == 0.28 13:03:19 INFO - mozrunner == 6.11 13:03:19 INFO - mozscreenshot == 0.1 13:03:19 INFO - mozsystemmonitor == 0.3 13:03:19 INFO - moztest == 0.7 13:03:19 INFO - mozversion == 1.4 13:03:19 INFO - psutil == 3.1.1 13:03:19 INFO - requests == 1.2.3 13:03:19 INFO - wsgiref == 0.1.2 13:03:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:03:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:03:19 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 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 13:03:19 INFO - 'HOME': '/home/cltbld', 13:03:19 INFO - 'LANG': 'en_US.UTF-8', 13:03:19 INFO - 'LANGUAGE': 'en_US:en', 13:03:19 INFO - 'LOGNAME': 'cltbld', 13:03:19 INFO - 'MAIL': '/var/mail/cltbld', 13:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:19 INFO - 'MOZ_NO_REMOTE': '1', 13:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:19 INFO - 'NO_EM_RESTART': '1', 13:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:19 INFO - 'PWD': '/builds/slave/test', 13:03:19 INFO - 'SHELL': '/bin/bash', 13:03:19 INFO - 'SHLVL': '1', 13:03:19 INFO - 'TERM': 'linux', 13:03:19 INFO - 'TMOUT': '86400', 13:03:19 INFO - 'USER': 'cltbld', 13:03:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:19 INFO - '_': '/tools/buildbot/bin/python'} 13:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Cleaning up... 13:03:20 INFO - Return code: 0 13:03:20 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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', 'jsonschema'] 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 jsonschema 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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:20 INFO - '_': '/tools/buildbot/bin/python'} 13:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:03:20 INFO - Cleaning up... 13:03:20 INFO - Return code: 0 13:03:20 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fa9255f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, '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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', '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', 'flake8'] 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 flake8 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': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:20 INFO - '_': '/tools/buildbot/bin/python'} 13:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:03:20 INFO - Downloading/unpacking flake8 13:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:03:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:03:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:03:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:03:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:03:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:03:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:03:23 INFO - no previously-included directories found matching 'docs/_build' 13:03:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:03:23 INFO - Running setup.py install for pep8 13:03:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:03:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:03:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:03:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:03:23 INFO - no previously-included directories found matching 'docs/_build' 13:03:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:03:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:03:23 INFO - Cleaning up... 13:03:23 INFO - Return code: 0 13:03:23 INFO - Running post-action listener: _resource_record_post_action 13:03:23 INFO - Running post-action listener: _start_resource_monitoring 13:03:23 INFO - Starting resource monitoring. 13:03:23 INFO - ##### 13:03:23 INFO - ##### Finished create-virtualenv step (success) 13:03:23 INFO - ##### 13:03:23 INFO - ##### 13:03:23 INFO - ##### Running install step. 13:03:23 INFO - ##### 13:03:23 INFO - Running pre-action listener: _resource_record_pre_action 13:03:23 INFO - Running main action method: install 13:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:03:23 INFO - Reading from file tmpfile_stdout 13:03:23 INFO - Detecting whether we're running mozinstall >=1.0... 13:03:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:03:23 INFO - Reading from file tmpfile_stdout 13:03:23 INFO - Output received: 13:03:23 INFO - Usage: mozinstall [options] installer 13:03:23 INFO - Options: 13:03:23 INFO - -h, --help show this help message and exit 13:03:23 INFO - -d DEST, --destination=DEST 13:03:23 INFO - Directory to install application into. [default: 13:03:23 INFO - "/builds/slave/test"] 13:03:23 INFO - --app=APP Application being installed. [default: firefox] 13:03:23 INFO - mkdir: /builds/slave/test/build/application 13:03:23 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:23 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:03:40 INFO - Reading from file tmpfile_stdout 13:03:40 INFO - Output received: 13:03:40 INFO - /builds/slave/test/build/application/firefox/firefox 13:03:40 INFO - Running post-action listener: _resource_record_post_action 13:03:40 INFO - ##### 13:03:40 INFO - ##### Finished install step (success) 13:03:40 INFO - ##### 13:03:40 INFO - ##### 13:03:40 INFO - ##### Running run-tests step. 13:03:40 INFO - ##### 13:03:40 INFO - Running pre-action listener: _resource_record_pre_action 13:03:40 INFO - Running main action method: run_tests 13:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:03:40 INFO - Python 2.7.3 13:03:40 INFO - Return code: 0 13:03:40 INFO - grabbing minidump binary from tooltool 13:03:40 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:40 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 0x2c742e0>, '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 0x2be0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be05d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:03:40 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:03:40 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:03:40 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:03:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:03:40 INFO - Return code: 0 13:03:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:03:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:03:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:03:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:03:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:03:41 INFO - Return code: 0 13:03:41 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', '--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-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:03:41 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 --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-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:03:41 INFO - Using env: {'DISPLAY': ':0', 13:03:41 INFO - 'HOME': '/home/cltbld', 13:03:41 INFO - 'LANG': 'en_US.UTF-8', 13:03:41 INFO - 'LANGUAGE': 'en_US:en', 13:03:41 INFO - 'LOGNAME': 'cltbld', 13:03:41 INFO - 'MAIL': '/var/mail/cltbld', 13:03:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:03:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:03:41 INFO - 'MOZ_NO_REMOTE': '1', 13:03:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:03:41 INFO - 'NO_EM_RESTART': '1', 13:03:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:03:41 INFO - 'PWD': '/builds/slave/test', 13:03:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:03:41 INFO - 'SHELL': '/bin/bash', 13:03:41 INFO - 'SHLVL': '1', 13:03:41 INFO - 'TERM': 'linux', 13:03:41 INFO - 'TMOUT': '86400', 13:03:41 INFO - 'USER': 'cltbld', 13:03:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802', 13:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:03:41 INFO - '_': '/tools/buildbot/bin/python'} 13:03:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--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-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:03:42 INFO - mozversion application_buildid: 20160621103055 13:03:42 INFO - mozversion application_changeset: 5ac2f675c083d59ef6329d164cf92733ab344557 13:03:42 INFO - mozversion application_display_name: Nightly 13:03:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:03:42 INFO - mozversion application_name: Firefox 13:03:42 INFO - mozversion application_remotingname: firefox 13:03:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:03:42 INFO - mozversion application_vendor: Mozilla 13:03:42 INFO - mozversion application_version: 50.0a1 13:03:42 INFO - mozversion platform_buildid: 20160621103055 13:03:42 INFO - mozversion platform_changeset: 5ac2f675c083d59ef6329d164cf92733ab344557 13:03:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:03:42 INFO - mozversion platform_version: 50.0a1 13:03:42 INFO - using testdate: 1466539422 13:03:42 INFO - actual date: 1466539422 13:03:42 INFO - starting webserver on 'localhost:59619' 13:03:42 INFO - SUITE-START | Running 2 tests 13:03:42 INFO - TEST-START | dromaeo_css 13:03:42 INFO - operating with platform_type : linux_ 13:03:42 INFO - Initialising browser for dromaeo_css test... 13:03:42 INFO - TEST-INFO | started process 23931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChW3BR/profile http://localhost:59619/getInfo.html) 13:03:46 INFO - PROCESS | 23931 | __metrics Screen width/height:1600/1200 13:03:46 INFO - PROCESS | 23931 | colorDepth:24 13:03:46 INFO - PROCESS | 23931 | Browser inner width/height: 1024/697 13:03:46 INFO - PROCESS | 23931 | __metrics 13:03:47 INFO - PROCESS | 23931 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:48 INFO - TEST-INFO | 23931: exit 0 13:03:48 INFO - Browser initialized. 13:03:48 INFO - Running cycle 1/1 for dromaeo_css test... 13:03:48 INFO - TEST-INFO | started process 24011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChW3BR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:04:00 INFO - PROCESS | 24011 | RSS: Main: 173674496 13:04:00 INFO - PROCESS | 24011 | 13:04:52 INFO - PROCESS | 24011 | 1466539492030 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:00 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59619/tests/dromaeo/cssquery-ext.html) 13:07:01 INFO - PROCESS | 24011 | RSS: Main: 311705600 13:07:01 INFO - PROCESS | 24011 | 13:10:03 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-ext.html (next: http://localhost:59619/tests/dromaeo/cssquery-jquery.html) 13:10:04 INFO - PROCESS | 24011 | RSS: Main: 259411968 13:10:04 INFO - PROCESS | 24011 | 13:13:06 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59619/tests/dromaeo/cssquery-mootools.html) 13:13:07 INFO - PROCESS | 24011 | RSS: Main: 257056768 13:13:07 INFO - PROCESS | 24011 | 13:16:09 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59619/tests/dromaeo/cssquery-prototype.html) 13:16:09 INFO - PROCESS | 24011 | RSS: Main: 259149824 13:16:09 INFO - PROCESS | 24011 | 13:19:12 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59619/tests/dromaeo/cssquery-yui.html) 13:19:13 INFO - PROCESS | 24011 | RSS: Main: 222359552 13:19:13 INFO - PROCESS | 24011 | 13:22:15 INFO - PROCESS | 24011 | Cycle 1(1): loaded http://localhost:59619/tests/dromaeo/cssquery-yui.html (next: http://localhost:59619/tests/dromaeo/cssquery-dojo.html) 13:22:16 INFO - PROCESS | 24011 | RSS: Main: 294531072 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | __start_tp_report 13:22:16 INFO - PROCESS | 24011 | _x_x_mozilla_page_load 13:22:16 INFO - PROCESS | 24011 | _x_x_mozilla_page_load_details 13:22:16 INFO - PROCESS | 24011 | |i|pagename|runs| 13:22:16 INFO - PROCESS | 24011 | |0;dojo.html;3073.4928736758434;3109.9067027989154;3113.968860311397;3136.9372612547736;3181.077487528617;5293.100172970595;5353.705546194962;5363.195520671901;5409;5523.889522209553;5330.626856120073;5351.438098999607;5408;5441.863953401157;5452.59105567082;4850.078485087831;4872.65891387603;4881.780319885596;4957.231629097478;4969.378827646544;4955.727434991074;5035.118854200518;5052.570531504826;5089.720065396402;5098.158803797388;4837;4854.466008739036;4973.104841128596;4989.2017277235645;5023.924641130349;4867.269909513566;4921.876953076166;4938.555530002317;4949.109160351135;4952.801887924478;4867.269909513601;4904.288878112654;4908.4846091160625;4911.705297682115;4955.677880937764;5318.601104917147;5343.706096164709;5436.646617969819;5468;5477.863053423656;5755.079187330007;5829.47534721877;5856.121581762727;5856.619319744203;5858.941410585882;5883.7058147092475;5899.085641725539;5916.763329466816;5921.082232254007;5922.082077278029;5305.1776974569;5364.570834333205;5406.135018397116;5447.918281225785;5458.6724796512335;5984.611000284967;5994.220751302303;5999.160117583542;5999.190109335271;6001.2498437695285;5721.628094173865;5754.223179870663;5760.942390576124;5765.336986246635;5766.509846662997;5628.352739435018;5682.289713785777;5726.198332233407;5732.3407808101765;5845.883082338414;5737.426257374313;5747.109198074305;5747.626404283708;5754.280714910637;5756.481916627524;5713.914291285634;5719.571032172604;5767.769289228384;5771.509421699203;5778.191053252548;4298.742075475481;4348.869533913988;4377.124575084996;4394.846180383735;4405.9559404405545;3908;3921.5490218625223;3933.4099885016903;3962.881113566598;3968.2460332536725;5416.160495123262;5514.944850551524;5519.834404967857;5520;5521.889562208733;5763.510101641407;5828.0966450200285;5836.328822185418;5841.678707671119;5860.150278209721;5561.360443549043;5567.635929197291;5569.665820050729;5572.665640061609;5573.27547418833;4869.586085182799;4997.500249975046;5058.974705126451;5064.797408103635;5114.43741188469;6008.09878518217;6048.455638992512;6050.42520960508;6051.394860513913;6109;5817.970910145422;5829.125631155361;5830.883382332415;5834;5839.503642190291;5822.679752613478;5961.672108034099;6030.125631783455;6034.849128771816;6047.848803779941;5754.367019627922;5757.309122905278;5762.250907382014;5764.884702305846;5817.767289308549;5801.8549536261935;5802.47777700009;5836.854078648068;5847.883042339215;5861.1501332307425;5558.055130627884;5614.29821272341;5637.069883469182;5654.886902262014;5738.741756620879;5589.776408943597;5610.074337734228;5626.2685850839125;5650.152477128464;5667;5521.282233309644;5532.087205611029;5534.944650553604;5536.86753241575;5538.141588053858;5560.416156303691;5592.496675299242;5635;5639.3232812062815;5647.717614119196;5562.471565201299;5565.1095824667855;5583.916241256466;5590.86022849432;5611.3266408031295 13:22:16 INFO - PROCESS | 24011 | |1;ext.html;572.1932075773158;594.9974293315763;612.8937268230844;615.4245780195521;629.3014753623479;30556;39869.60130398695;41619.37570936439;41694;41794.582054179446;42615.57384426155;43017.13965720684;43067;43114.137717245634;43237.78381108098;7994.520328780262;8759.080296568864;8901.24339431146;8905.643774249022;10551.366917984908;10423.27037107399;10833.295835770688;10841;10843.67468975932;10855.294405863593;10977.231593788438;10980.286281391724;11008.559657613725;11013.944930275338;11030.613928512505;8155.714549990722;8341.20758527939;10494.108000819939;10773.83839242412;10786.838197427045;10687.091597214247;10727.83908241377;10735.785284294348;10739.570417183382;10749.086327662159;41834.37248441276;42211.36682949758;42386.364204536956;42490;42547.78726106381;3593.1376469647357;3677.9264414711824;3716.1824398632257;3849.653531182179;3896.9220615587815;32089.83955080233;32935.835320823244;33000.33999320024;33203.6679633203;33812.49281260783;4412.278512602945;4463.263561512346;4469.240229161051;4512.864614061584;4566.634669226454;339449;339549;340906;341185;341262;52632.21051684228;53268;53302.73348633232;53359.199612005854;53427.73286133622;35535.466967995504;36386.27227455436;36629.450558241646;38285.617143828764;38436.42345364766;17708.645827083386;17789.822101779075;17894;17908.46274611764;17910.373136940143;10445.216608754374;13385.933070334586;13616.795748063787;13635.795463068062;13939.303034848217;19570.90214548918;19575.314863979693;19603.21587136527;19659.60680786376;19671.21315147407;7241.8551628967125;7296.306850849161;7422.6288685565505;7462.1123164327455;7472.9252707473315;957.2916042128775;1018.5162048027275;1054.852320675106;1056.9682909512726;1089.1667874076338;31772.523412148836;31865.681343186734;32058;32275.838620806746;32376.67623323784;1071.1377341240377;1154.2555051991587;1188.8097904335266;1194.856617205941;1212.8908398244023;16868.493945181417;17002.574935626708;17012;17050.48848534546;17125.914370428316;564542;574261;574773;575059;575486;56202;57698.13452798211;57910;57916;57923.710381447825;1246.6447062587301;1288.4652869059234;1293.702448436846;1351.2703140304125;1356.7964805279287;26695.466090677688;32868.34263314673;34479;34573.48139777855;34603.13492162716;52515.21227181519;53999;54005.729971349894;54032.459675402744;54173.72913135409;483698;496880;497725;497853;497904;24836.50326993414;27065.323366915196;27338.72661273362;27958.161255162377;28087.438251234453;46951.29573056475;47299;47808;48352.51647483621;48667.75666121647;40809;40826.59173408228;40948.590514094474;40951.38572921468;42090.57909420867;40059.799701001306;40377.596224037385;40502.392464112476;40678.1864362717;41267.38098928458;40108.59891401165;40813;40863.7956810214;41267.38098928458;41373.172536548496;34415.31169376648;36583.81708091549;37010;37077.443838341904;37079.814600926824;27079.59380609332;27085.593716094667;27283.59074613922;27460.45079098447;27613.447731044864 13:22:16 INFO - PROCESS | 24011 | |2;jquery.html;388.53181915791464;394.4162639293847;394.76708741842305;397.04510651882225;416.8020190409556;14132.929335353334;17613.383531576397;18414.447566573006;19898.403047908567;19913.50216244593;15475.69048619027;17733;18633.440996770085;19275.710864337012;19611;5447.782088716446;5697.0599851024535;5705.372409035002;5707.343655479611;5734.770609175628;4071.97964010181;5546.417626149257;5649.519790817785;5919;6351.523635727316;6305.716242769064;6379.744810207586;6395.968020159916;6413.679316034203;6428.839279018039;6147.170132032164;6303.401176888211;6369.140166077566;6379.043143528462;6386.904196437057;5458.099413596752;5629.296337957755;5629.971850140764;5639;5642.351129620105;19667.508312292164;19875.80124198754;19919.701204481946;22871;24571.87714061436;2424.624183251581;2445.205308274818;2480.3675062858856;2487.6144197649214;2516.924492265235;14598;14662.486812961495;14741.410343586243;14791.40834366624;15190.772138417933;1910.8280254776998;1931.565397785501;1949.440447641895;1982.9900850495799;2000.8699434536709;77737;78491.60754196193;79480.20519794786;80904.19095809084;83273;15889.364425423084;17442.215100320514;17459.912700436416;17894.836835605645;18074.63850722978;31415.21461963469;31601.36797264042;31616.36767264642;32040.198995025312;32042.839785800923;9906.306558540833;10202.489875506195;10295.3822770634;10378.169746420268;10599.417032063157;7136.6431678415875;8782.560871956377;8881.866771998426;9147.771305717277;9159.679411220575;8100.8379832403025;8639.611217495229;8865.512396818236;8932.553372331358;9067.410618309788;3275.950860737091;3291.2923721400016;3394.711449526818;3473.235888104613;3521.366154092288;887.7558671365297;983.8179936711731;1008.1481148429712;1045.6497073480318;1048.4705223861902;18273;19330.710039349422;19378.903105484384;19498.805011949982;19988.600227995357;998.3311181508407;1029;1031.3244824639874;1061.920355973305;1077.5205033760058;10458.790824183474;10764;10855.185861060452;10947.671569852917;11006.174536909604;409000;411943;413213;416778;425856;88993;89886;91221;93182;93877;959.2709540749081;990.1336330710628;1003.5383723487278;1006.8439391894268;1015.939043657383;16730.916345418194;16782.1608919556;16861.241244144287;16963.321467141177;17577.472675819747;40726.59273407346;40785;41350.586494135874;41633.58366416297;42460.575394246895;58418.4158158413;59341.40658593359;59755.70122149361;59776.701116494136;60437.69781151066;8696.956515217384;8918.509481978293;8964.417312874642;8994.415363001646;9139.131782480654;9591.616335346507;12746.936265318986;13771.655708606964;13845.723085538435;14024.158550486596;11874.346910919638;12197.573084941985;12223.449944752685;12278.938605306916;12289.139760217056;11899.226550274205;11917.76164476723;12225.816612750637;12353.38233088324;12373;12164.452599633214;12273.202241854251;12292.631221063382;12373.876261237632;12536.937315313366;7609.847803043797;7950.64222110018;7999.4400391972;8325.625346859284;9048.547572621474;11115;11709.590164344207;12176.452059657513;12252.632421027383;12284.815727763911 13:22:16 INFO - PROCESS | 24011 | |3;mootools.html;1268.6257554021563;1474.5207807462577;1487.8735307498864;1579.9447019354318;1732.948011559652;8419.484492791295;8777.078406767294;8829.602667879944;9042.638294468214;9061.093890610935;8809.119088091204;9030.322725795559;9030.593623286952;9040.231580315665;9040.63837446503;2028.1684509351169;2316.316686577455;2365.810735141193;2400.855948643078;2403.062805505854;2411.3730430088217;2426.259990702835;2428.9028438862424;2431.878406079698;2440.1459489178824;2252.88735563222;2287.9199228027023;2301.2290882554366;2305.262316058862;2306.7116610423695;2016.3648450738044;2265.275111964172;2347.507023525062;2348.2016114521143;2368.1237941961585;2298.2071185440996;2330.673705681206;2334.4047267946567;2340.707411573553;2341.4731685370657;9034.728958131267;9062.682806101755;9114.680986165518;9130.680426185118;9130.726078217598;5297.258383826267;5435.891282174374;5442.9727851360885;5449.509544141007;5449.536789372908;3197.5683282756763;3315.8342082896;3364.5794275715534;3393.6267010628812;3401.846916888746;1039.688093571933;1059.0733108530037;1071.839224116381;1081.626838740641;1085.4138765066855;12815.871841281654;12854.935725321408;12881.291528965903;12883.162594431333;12898.09713320068;4759.0719809637485;4768.116593945372;4775.498572649891;4782.928256076161;4927.236278376858;10536.104431123287;10627.468626568641;10630.096441802534;10692.732681683021;10702.839457408145;4806.927896081562;5452.863678408072;5510.724463776875;5515.806946756844;5522.3649280333275;4500.797464114123;4557.931631025537;4564.406627138451;4865.683730557503;5018.673786203885;3925.548561915359;4014.9761810738073;4059.79701014954;4067.9593204068174;4141.151064031867;1255.9937200314123;1279.969624452306;1281.7756892543955;1290.864459231786;1301.7266374061364;1012.4684540616088;1022.447878145793;1022.4989755019986;1022.504085518523;1032.4734385463319;6215.285242197205;6226.40849119333;6230.408111229426;6351.110844481776;6536.673166341664;436.9475662920406;442.5397586510058;450.05937590436145;453.931910213464;460.07984031936127;4286.657067434598;4367.497737760198;4376.627986621173;4398.076403955205;4419.46966364032;10605.522751476203;10899.83650245247;10909.127269818395;10984.945075274572;11038.558457661604;10908.727281817859;10930.180236482296;10934.890651093547;10935.781284374269;10939.726506837393;7857.960710196527;8211.234584564347;8227;8323.708670196515;8331.95834020826;6057.666828324484;6205.689715514297;6310.432061114522;6378.075179099097;6413.679316034273;10233.539490722786;10464.895351046393;10661.09380702649;10666.040056394651;10672.786544269227;10514.26400151982;10705.571777128827;10768.138548915911;10846.67459976202;10866.565337386415;7199.496035277481;7874.960625196837;7965.721199757981;8132.186781322057;8397.286230670461;8503;8672.696455624275;8768.649254029768;8808.779780505538;8808.86786698213;7761.456698031084;7892.171322011106;7932.127465978622;7954.960225199068;7994.960025200069;7364.5581265124265;7463.141738700119;7826.452148349561;7839.216078392115;7899.605019748875;6982.231954484901;7129.429645628441;7155.785326440215;7161.033260509765;7168.139823221247;5128.743562821769;5286.418493965738;5414.75633596497;5455.918161227664;5599.076152434803;5209.557187639093;5239.502247286502;5300.814471493479;5379.300690910157;5498 13:22:16 INFO - PROCESS | 24011 | |4;prototype.html;321.07850469153533;331.3224455987505;332.24082970412604;334.0762790883207;339.8097065643239;5163.457836927125;5163.561097306733;5314.9468505314935;5359.89280214396;5368.382635996862;5232.633715639907;5242.483607868216;5251.501107394801;5251.711155886424;5265.8946821063555;4142.627163555287;4151.3150330195485;4161.521425036114;4162.583741625844;4173.812178451962;3956;3980.6417422431973;4139.586041395852;4148.709590328678;4160.271952408331;4072.552019277877;4094.549599544048;4094.5700701426367;4101.589841015904;4104.322786740185;4104.199681062194;4117.438415770352;4128.401381799622;4132;4148.274052040881;3442.3803715331233;3641.526601541809;3655.378585640421;3658.743887927846;3668.1746607013474;5147.742612869341;5156.355455568054;5175.197844334134;5197.506236907488;5201.609879259033;4680.134175177603;4698.953010469886;4714.717116972993;4726;4726.83456079039;5407.567394608422;5497.752601132958;5533.833984980457;5535.197396377543;5553.416891226403;3910.413437984325;3963.4451176835264;3964.207158568269;3965.6827453803626;3972.523297204325;5721.856953576153;5740.885182296331;5741.483266506035;5752.712364381764;5774.249347584829;3901.843926242975;4041.2725709372594;4050.1292222172374;4051.918961620751;4054.8986275343354;4081.4490043843703;4101.446304748881;4109.547949725527;4110.897227569275;4113.71204015716;4615.861524154281;4680.742559159211;4683.437987441529;4683.81264749413;4709.62323014158;5538.6399884007415;5542.695151766611;5550.833474995757;5559.554515825915;5565.554755619541;1354.7222819322014;1399.6640806206437;1406.2546850169222;1413.2297897645808;1416.7945647881206;897.7531178925848;898.2454738020094;901.9909800902038;916.3448134583805;918.554501066982;4750.311204875274;4799.66402351832;4813.785658597015;4822.397200349957;4824.34871292378;4930.260460930889;4960.255961605788;5001.299818025479;5034.917492739079;5065.138926382524;4719.905601888012;4723.598494128038;4811.759412029384;4838.709677419366;5093.286939828427;3020.5771192033135;3036.681148479378;3048.658590220296;3049.5667036492814;3051;5906.586538942319;5929.288485381696;5936.406359364116;5952.5833191676165;5958.612690175211;5602.786899174803;5814.30228372598;5825.592208545446;5834.620749651259;5842.678652674143;5885.911711324334;5888.908323130391;5894.263217097777;5914.964881145782;5952.910706339495;5569.081101618188;5628.183913332462;5712.314522257356;5720.71283961122;5742.799002034909;5568.16477528374;5636.21093046982;5700.401457847032;5714.428557144252;5717.628354156966;5882.735276912464;5899.823005309848;5908.379620139824;5909.438603332676;5927.199828023162;3611.331903597843;3836.712246581462;3995.561597824839;4051.331530297468;4072.8981775454668;5730.656160630376;5771.769129234784;5773.538116950718;5776.364599893925;5777.74000169985;5557.944420555743;5578.3584887738425;5622.493975542221;5626.1842032905815;5628.3115065481015;5381.811636592701;5383.730813459233;5456.727163641723;5469.15228139639;5477.068898287221;5373.462653734595;5384.892302154013;5391.838244852661;5404.567634589145;5448.155535891943;5320.813771517978;5506.972465137809;5602.775888964559;5610.326760788568;5616.1856530803625;5495.752691128829;5526.198701188386;5527.281453411031;5539.584531160099;5557.555395568425 13:22:16 INFO - PROCESS | 24011 | |5;yui.html;728.3917928529678;765.1162906842592;768.3123604374085;792.4888446951717;820.8071103290725;14246.501372451967;15253.466128685499;15257.465988690397;15334.233288335594;16835;14473.5657930262;14615.707685846277;15137.31882065307;15168.393264269416;15190.392384304614;673.441043933534;776.669915286004;795.8487887301409;805.5609692717454;806.0810675829559;803.2289002557552;809.5749731391037;809.7570728781371;810.3638643664694;811.0308181722844;854.5043874552745;859.1494420523668;859.8839156713857;861.0872475176302;861.336770686571;693.2512886083043;834.9666013359458;843.2031730015138;849.235687880909;854.0520022774715;622.6295354264206;626.1359324132713;628.2366924187135;628.4501061571125;629.1129507394552;13764.105333153413;13835.51575694856;13909.026368154233;13921.373538190806;13978.930105349407;13534.323283835769;14004.439822407194;14039.438422463089;14051.578452646438;14089.859101408958;13058.15122017066;13147.737045259137;13233.206007639476;13269.800952985714;13974.441022359093;4500.392447019676;4527.4567051953645;4560.338750881137;4567.748773817439;4587.632989360844;75543.62228188824;76802;77200.22799771986;77283.61358193173;78042.82935755968;11394.25937314072;11556.826647600124;11559.826602600968;11575.536978520933;11598.961287048962;20391.490212744502;20411;20453.38639840807;20473.48816279575;20492.282770102975;8430.578471076422;8690;8751.474911505331;8766.60550275239;8774.561271936378;4786.497417771154;4946.554810067111;4970.950290497121;5007;5021.271915572222;3442.3287458945765;3556.4309710446205;3557.7687450316166;3558.1638314995957;3558.5195998540385;636.3064259956669;647.8153726188013;651.9543631945718;657.8881590129689;664.4584663499232;653.5947712418331;663.290279401046;663.6648492511348;668.0026720106943;676.1581830620909;9274.90725092754;9279.536023198812;9406.168175730954;9501.649211268359;9629.903700962901;646.618495087891;668.4585485756553;673.1282988529865;685.4242436353487;713.454132959192;4473.329000649864;4488.483824360175;4697.436307643036;4737.45519265282;4738.3129446230105;102690;111425.44287278673;113861;114542;117438;59125;76831.84752228721;85450.57274713587;95332.52333738287;97183.51408242913;68900;81794.59102704449;82340.58829705932;83234.99999999879;83243;8923.643054277756;8931.392349376914;8945.284377249674;8979.685711000084;9106.772330691785;50690;50885;52421.21368179557;53246.73376633092;54174.45825541694;72657.6367118161;73258.26741732728;73446.7965961022;74672.62663686647;77856;11790.410479476164;11881.1089168311;12049.457774400349;12065.09511786602;12177.147599667938;12652.240865547728;12960.861457859724;13025.609231723063;13358.666033348854;13651.795223071464;11318.26431281964;11357.772844542898;11451.312921224753;11831.40842957866;11927;11803.291802491878;11873.525058997544;11985.161038727554;12016.699582510508;12432.689182770504;11710.94144529272;11716.9454749073;11925.642230733092;12104.75790484203;12314.13801033919;9921.206303495848;10003.499825008575;10022.595383374928;10134.263295553617;10327;9386.249100072115;10127.447871243872;10262.743431414274;10298.948505257425;10326 13:22:16 INFO - PROCESS | 24011 | __end_tp_report 13:22:16 INFO - PROCESS | 24011 | __start_cc_report 13:22:16 INFO - PROCESS | 24011 | _x_x_mozilla_cycle_collect,1152 13:22:16 INFO - PROCESS | 24011 | __end_cc_report 13:22:16 INFO - PROCESS | 24011 | __startTimestamp1466540536230__endTimestamp 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | ------- Summary: start ------- 13:22:16 INFO - PROCESS | 24011 | Number of tests: 6 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#0] dojo.html Cycles:165 Average:5388.82 Median:5572.67 stddev:620.17 (11.1%) stddev-sans-first:594.88 13:22:16 INFO - PROCESS | 24011 | Values: 3073.5 3109.9 3114.0 3136.9 3181.1 5293.1 5353.7 5363.2 5409.0 5523.9 5330.6 5351.4 5408.0 5441.9 5452.6 4850.1 4872.7 4881.8 4957.2 4969.4 4955.7 5035.1 5052.6 5089.7 5098.2 4837.0 4854.5 4973.1 4989.2 5023.9 4867.3 4921.9 4938.6 4949.1 4952.8 4867.3 4904.3 4908.5 4911.7 4955.7 5318.6 5343.7 5436.6 5468.0 5477.9 5755.1 5829.5 5856.1 5856.6 5858.9 5883.7 5899.1 5916.8 5921.1 5922.1 5305.2 5364.6 5406.1 5447.9 5458.7 5984.6 5994.2 5999.2 5999.2 6001.2 5721.6 5754.2 5760.9 5765.3 5766.5 5628.4 5682.3 5726.2 5732.3 5845.9 5737.4 5747.1 5747.6 5754.3 5756.5 5713.9 5719.6 5767.8 5771.5 5778.2 4298.7 4348.9 4377.1 4394.8 4406.0 3908.0 3921.5 3933.4 3962.9 3968.2 5416.2 5514.9 5519.8 5520.0 5521.9 5763.5 5828.1 5836.3 5841.7 5860.2 5561.4 5567.6 5569.7 5572.7 5573.3 4869.6 4997.5 5059.0 5064.8 5114.4 6008.1 6048.5 6050.4 6051.4 6109.0 5818.0 5829.1 5830.9 5834.0 5839.5 5822.7 5961.7 6030.1 6034.8 6047.8 5754.4 5757.3 5762.3 5764.9 5817.8 5801.9 5802.5 5836.9 5847.9 5861.2 5558.1 5614.3 5637.1 5654.9 5738.7 5589.8 5610.1 5626.3 5650.2 5667.0 5521.3 5532.1 5534.9 5536.9 5538.1 5560.4 5592.5 5635.0 5639.3 5647.7 5562.5 5565.1 5583.9 5590.9 5611.3 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#1] ext.html Cycles:180 Average:61982.92 Median:20343.96 stddev:127426.37 (626.4%) stddev-sans-first:127700.41 13:22:16 INFO - PROCESS | 24011 | Values: 572.2 595.0 612.9 615.4 629.3 30556.0 39869.6 41619.4 41694.0 41794.6 42615.6 43017.1 43067.0 43114.1 43237.8 7994.5 8759.1 8901.2 8905.6 10551.4 10423.3 10833.3 10841.0 10843.7 10855.3 10977.2 10980.3 11008.6 11013.9 11030.6 8155.7 8341.2 10494.1 10773.8 10786.8 10687.1 10727.8 10735.8 10739.6 10749.1 41834.4 42211.4 42386.4 42490.0 42547.8 3593.1 3677.9 3716.2 3849.7 3896.9 32089.8 32935.8 33000.3 33203.7 33812.5 4412.3 4463.3 4469.2 4512.9 4566.6 339449.0 339549.0 340906.0 341185.0 341262.0 52632.2 53268.0 53302.7 53359.2 53427.7 35535.5 36386.3 36629.5 38285.6 38436.4 17708.6 17789.8 17894.0 17908.5 17910.4 10445.2 13385.9 13616.8 13635.8 13939.3 19570.9 19575.3 19603.2 19659.6 19671.2 7241.9 7296.3 7422.6 7462.1 7472.9 957.3 1018.5 1054.9 1057.0 1089.2 31772.5 31865.7 32058.0 32275.8 32376.7 1071.1 1154.3 1188.8 1194.9 1212.9 16868.5 17002.6 17012.0 17050.5 17125.9 564542.0 574261.0 574773.0 575059.0 575486.0 56202.0 57698.1 57910.0 57916.0 57923.7 1246.6 1288.5 1293.7 1351.3 1356.8 26695.5 32868.3 34479.0 34573.5 34603.1 52515.2 53999.0 54005.7 54032.5 54173.7 483698.0 496880.0 497725.0 497853.0 497904.0 24836.5 27065.3 27338.7 27958.2 28087.4 46951.3 47299.0 47808.0 48352.5 48667.8 40809.0 40826.6 40948.6 40951.4 42090.6 40059.8 40377.6 40502.4 40678.2 41267.4 40108.6 40813.0 40863.8 41267.4 41373.2 34415.3 36583.8 37010.0 37077.4 37079.8 27079.6 27085.6 27283.6 27460.5 27613.4 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#2] jquery.html Cycles:180 Average:27861.71 Median:31828.28 stddev:68792.59 (216.1%) stddev-sans-first:68954.65 13:22:16 INFO - PROCESS | 24011 | Values: 388.5 394.4 394.8 397.0 416.8 14132.9 17613.4 18414.4 19898.4 19913.5 15475.7 17733.0 18633.4 19275.7 19611.0 5447.8 5697.1 5705.4 5707.3 5734.8 4072.0 5546.4 5649.5 5919.0 6351.5 6305.7 6379.7 6396.0 6413.7 6428.8 6147.2 6303.4 6369.1 6379.0 6386.9 5458.1 5629.3 5630.0 5639.0 5642.4 19667.5 19875.8 19919.7 22871.0 24571.9 2424.6 2445.2 2480.4 2487.6 2516.9 14598.0 14662.5 14741.4 14791.4 15190.8 1910.8 1931.6 1949.4 1983.0 2000.9 77737.0 78491.6 79480.2 80904.2 83273.0 15889.4 17442.2 17459.9 17894.8 18074.6 31415.2 31601.4 31616.4 32040.2 32042.8 9906.3 10202.5 10295.4 10378.2 10599.4 7136.6 8782.6 8881.9 9147.8 9159.7 8100.8 8639.6 8865.5 8932.6 9067.4 3276.0 3291.3 3394.7 3473.2 3521.4 887.8 983.8 1008.1 1045.6 1048.5 18273.0 19330.7 19378.9 19498.8 19988.6 998.3 1029.0 1031.3 1061.9 1077.5 10458.8 10764.0 10855.2 10947.7 11006.2 409000.0 411943.0 413213.0 416778.0 425856.0 88993.0 89886.0 91221.0 93182.0 93877.0 959.3 990.1 1003.5 1006.8 1015.9 16730.9 16782.2 16861.2 16963.3 17577.5 40726.6 40785.0 41350.6 41633.6 42460.6 58418.4 59341.4 59755.7 59776.7 60437.7 8697.0 8918.5 8964.4 8994.4 9139.1 9591.6 12746.9 13771.7 13845.7 14024.2 11874.3 12197.6 12223.4 12278.9 12289.1 11899.2 11917.8 12225.8 12353.4 12373.0 12164.5 12273.2 12292.6 12373.9 12536.9 7609.8 7950.6 7999.4 8325.6 9048.5 11115.0 11709.6 12176.5 12252.6 12284.8 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#3] mootools.html Cycles:180 Average:5924.95 Median:2431.00 stddev:3420.45 (140.7%) stddev-sans-first:3412.15 13:22:16 INFO - PROCESS | 24011 | Values: 1268.6 1474.5 1487.9 1579.9 1732.9 8419.5 8777.1 8829.6 9042.6 9061.1 8809.1 9030.3 9030.6 9040.2 9040.6 2028.2 2316.3 2365.8 2400.9 2403.1 2411.4 2426.3 2428.9 2431.9 2440.1 2252.9 2287.9 2301.2 2305.3 2306.7 2016.4 2265.3 2347.5 2348.2 2368.1 2298.2 2330.7 2334.4 2340.7 2341.5 9034.7 9062.7 9114.7 9130.7 9130.7 5297.3 5435.9 5443.0 5449.5 5449.5 3197.6 3315.8 3364.6 3393.6 3401.8 1039.7 1059.1 1071.8 1081.6 1085.4 12815.9 12854.9 12881.3 12883.2 12898.1 4759.1 4768.1 4775.5 4782.9 4927.2 10536.1 10627.5 10630.1 10692.7 10702.8 4806.9 5452.9 5510.7 5515.8 5522.4 4500.8 4557.9 4564.4 4865.7 5018.7 3925.5 4015.0 4059.8 4068.0 4141.2 1256.0 1280.0 1281.8 1290.9 1301.7 1012.5 1022.4 1022.5 1022.5 1032.5 6215.3 6226.4 6230.4 6351.1 6536.7 436.9 442.5 450.1 453.9 460.1 4286.7 4367.5 4376.6 4398.1 4419.5 10605.5 10899.8 10909.1 10984.9 11038.6 10908.7 10930.2 10934.9 10935.8 10939.7 7858.0 8211.2 8227.0 8323.7 8332.0 6057.7 6205.7 6310.4 6378.1 6413.7 10233.5 10464.9 10661.1 10666.0 10672.8 10514.3 10705.6 10768.1 10846.7 10866.6 7199.5 7875.0 7965.7 8132.2 8397.3 8503.0 8672.7 8768.6 8808.8 8808.9 7761.5 7892.2 7932.1 7955.0 7995.0 7364.6 7463.1 7826.5 7839.2 7899.6 6982.2 7129.4 7155.8 7161.0 7168.1 5128.7 5286.4 5414.8 5455.9 5599.1 5209.6 5239.5 5300.8 5379.3 5498.0 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#4] prototype.html Cycles:180 Average:4622.26 Median:5199.56 stddev:1366.84 (26.3%) stddev-sans-first:1332.01 13:22:16 INFO - PROCESS | 24011 | Values: 321.1 331.3 332.2 334.1 339.8 5163.5 5163.6 5314.9 5359.9 5368.4 5232.6 5242.5 5251.5 5251.7 5265.9 4142.6 4151.3 4161.5 4162.6 4173.8 3956.0 3980.6 4139.6 4148.7 4160.3 4072.6 4094.5 4094.6 4101.6 4104.3 4104.2 4117.4 4128.4 4132.0 4148.3 3442.4 3641.5 3655.4 3658.7 3668.2 5147.7 5156.4 5175.2 5197.5 5201.6 4680.1 4699.0 4714.7 4726.0 4726.8 5407.6 5497.8 5533.8 5535.2 5553.4 3910.4 3963.4 3964.2 3965.7 3972.5 5721.9 5740.9 5741.5 5752.7 5774.2 3901.8 4041.3 4050.1 4051.9 4054.9 4081.4 4101.4 4109.5 4110.9 4113.7 4615.9 4680.7 4683.4 4683.8 4709.6 5538.6 5542.7 5550.8 5559.6 5565.6 1354.7 1399.7 1406.3 1413.2 1416.8 897.8 898.2 902.0 916.3 918.6 4750.3 4799.7 4813.8 4822.4 4824.3 4930.3 4960.3 5001.3 5034.9 5065.1 4719.9 4723.6 4811.8 4838.7 5093.3 3020.6 3036.7 3048.7 3049.6 3051.0 5906.6 5929.3 5936.4 5952.6 5958.6 5602.8 5814.3 5825.6 5834.6 5842.7 5885.9 5888.9 5894.3 5915.0 5952.9 5569.1 5628.2 5712.3 5720.7 5742.8 5568.2 5636.2 5700.4 5714.4 5717.6 5882.7 5899.8 5908.4 5909.4 5927.2 3611.3 3836.7 3995.6 4051.3 4072.9 5730.7 5771.8 5773.5 5776.4 5777.7 5557.9 5578.4 5622.5 5626.2 5628.3 5381.8 5383.7 5456.7 5469.2 5477.1 5373.5 5384.9 5391.8 5404.6 5448.2 5320.8 5507.0 5602.8 5610.3 5616.2 5495.8 5526.2 5527.3 5539.6 5557.6 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - PROCESS | 24011 | [#5] yui.html Cycles:180 Average:19832.92 Median:4988.98 stddev:28418.16 (569.6%) stddev-sans-first:28461.67 13:22:16 INFO - PROCESS | 24011 | Values: 728.4 765.1 768.3 792.5 820.8 14246.5 15253.5 15257.5 15334.2 16835.0 14473.6 14615.7 15137.3 15168.4 15190.4 673.4 776.7 795.8 805.6 806.1 803.2 809.6 809.8 810.4 811.0 854.5 859.1 859.9 861.1 861.3 693.3 835.0 843.2 849.2 854.1 622.6 626.1 628.2 628.5 629.1 13764.1 13835.5 13909.0 13921.4 13978.9 13534.3 14004.4 14039.4 14051.6 14089.9 13058.2 13147.7 13233.2 13269.8 13974.4 4500.4 4527.5 4560.3 4567.7 4587.6 75543.6 76802.0 77200.2 77283.6 78042.8 11394.3 11556.8 11559.8 11575.5 11599.0 20391.5 20411.0 20453.4 20473.5 20492.3 8430.6 8690.0 8751.5 8766.6 8774.6 4786.5 4946.6 4971.0 5007.0 5021.3 3442.3 3556.4 3557.8 3558.2 3558.5 636.3 647.8 652.0 657.9 664.5 653.6 663.3 663.7 668.0 676.2 9274.9 9279.5 9406.2 9501.6 9629.9 646.6 668.5 673.1 685.4 713.5 4473.3 4488.5 4697.4 4737.5 4738.3 102690.0 111425.4 113861.0 114542.0 117438.0 59125.0 76831.8 85450.6 95332.5 97183.5 68900.0 81794.6 82340.6 83235.0 83243.0 8923.6 8931.4 8945.3 8979.7 9106.8 50690.0 50885.0 52421.2 53246.7 54174.5 72657.6 73258.3 73446.8 74672.6 77856.0 11790.4 11881.1 12049.5 12065.1 12177.1 12652.2 12960.9 13025.6 13358.7 13651.8 11318.3 11357.8 11451.3 11831.4 11927.0 11803.3 11873.5 11985.2 12016.7 12432.7 11710.9 11716.9 11925.6 12104.8 12314.1 9921.2 10003.5 10022.6 10134.3 10327.0 9386.2 10127.4 10262.7 10298.9 10326.0 13:22:16 INFO - PROCESS | 24011 | -------- Summary: end -------- 13:22:16 INFO - PROCESS | 24011 | 13:22:16 INFO - TEST-INFO | 24011: exit 0 13:22:16 INFO - TEST-OK | dromaeo_css | took 1114933ms 13:22:16 INFO - TEST-START | kraken 13:22:17 INFO - operating with platform_type : linux_ 13:22:17 INFO - Initialising browser for kraken test... 13:22:17 INFO - TEST-INFO | started process 24196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEBtnzs/profile http://localhost:59619/getInfo.html) 13:22:21 INFO - PROCESS | 24196 | __metrics Screen width/height:1600/1200 13:22:21 INFO - PROCESS | 24196 | colorDepth:24 13:22:21 INFO - PROCESS | 24196 | Browser inner width/height: 1024/697 13:22:21 INFO - PROCESS | 24196 | __metrics 13:22:22 INFO - PROCESS | 24196 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:22:23 INFO - TEST-INFO | 24196: exit 0 13:22:23 INFO - Browser initialized. 13:22:23 INFO - Running cycle 1/1 for kraken test... 13:22:23 INFO - TEST-INFO | started process 24279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEBtnzs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:22:35 INFO - PROCESS | 24279 | RSS: Main: 173604864 13:22:35 INFO - PROCESS | 24279 | 13:22:37 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-beat-detection) 13:22:38 INFO - PROCESS | 24279 | RSS: Main: 232288256 13:22:38 INFO - PROCESS | 24279 | 13:22:41 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-dft) 13:22:41 INFO - PROCESS | 24279 | RSS: Main: 220192768 13:22:41 INFO - PROCESS | 24279 | 13:22:44 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-fft) 13:22:45 INFO - PROCESS | 24279 | RSS: Main: 286519296 13:22:45 INFO - PROCESS | 24279 | 13:22:47 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59619/tests/kraken/driver.html?testName=audio-oscillator) 13:22:48 INFO - PROCESS | 24279 | RSS: Main: 197091328 13:22:48 INFO - PROCESS | 24279 | 13:22:50 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:22:51 INFO - PROCESS | 24279 | RSS: Main: 201474048 13:22:51 INFO - PROCESS | 24279 | 13:22:54 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-darkroom) 13:22:54 INFO - PROCESS | 24279 | RSS: Main: 237780992 13:22:54 INFO - PROCESS | 24279 | 13:22:58 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59619/tests/kraken/driver.html?testName=imaging-desaturate) 13:22:58 INFO - PROCESS | 24279 | RSS: Main: 238362624 13:22:58 INFO - PROCESS | 24279 | 13:23:01 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59619/tests/kraken/driver.html?testName=json-parse-financial) 13:23:02 INFO - PROCESS | 24279 | RSS: Main: 237674496 13:23:02 INFO - PROCESS | 24279 | 13:23:03 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59619/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:23:04 INFO - PROCESS | 24279 | RSS: Main: 224686080 13:23:04 INFO - PROCESS | 24279 | 13:23:06 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:23:06 INFO - PROCESS | 24279 | RSS: Main: 228130816 13:23:06 INFO - PROCESS | 24279 | 13:23:08 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:23:09 INFO - PROCESS | 24279 | RSS: Main: 236281856 13:23:09 INFO - PROCESS | 24279 | 13:23:11 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:23:12 INFO - PROCESS | 24279 | RSS: Main: 238559232 13:23:12 INFO - PROCESS | 24279 | 13:23:15 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:23:15 INFO - PROCESS | 24279 | RSS: Main: 238333952 13:23:15 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | Cycle 1(1): loaded http://localhost:59619/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59619/tests/kraken/driver.html?testName=ai-astar) 13:23:17 INFO - PROCESS | 24279 | RSS: Main: 281747456 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | __start_tp_report 13:23:17 INFO - PROCESS | 24279 | _x_x_mozilla_page_load 13:23:17 INFO - PROCESS | 24279 | _x_x_mozilla_page_load_details 13:23:17 INFO - PROCESS | 24279 | |i|pagename|runs| 13:23:17 INFO - PROCESS | 24279 | |0;ai-astar;102;112;112;110;113;110;111;110;111;111 13:23:17 INFO - PROCESS | 24279 | |1;audio-beat-detection;158;137;128;179;127;128;153;124;182;129 13:23:17 INFO - PROCESS | 24279 | |2;audio-dft;160;160;162;160;161;162;162;161;160;160 13:23:17 INFO - PROCESS | 24279 | |3;audio-fft;75;75;75;126;75;76;75;74;96;75 13:23:17 INFO - PROCESS | 24279 | |4;audio-oscillator;87;86;115;87;88;88;126;86;86;141 13:23:17 INFO - PROCESS | 24279 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;118;116;117 13:23:17 INFO - PROCESS | 24279 | |6;imaging-darkroom;146;145;145;146;146;146;146;145;145;146 13:23:17 INFO - PROCESS | 24279 | |7;imaging-desaturate;95;96;95;95;95;96;95;95;95;95 13:23:17 INFO - PROCESS | 24279 | |8;json-parse-financial;55;55;55;53;54;53;55;55;55;55 13:23:17 INFO - PROCESS | 24279 | |9;json-stringify-tinderbox;63;63;63;63;64;63;64;64;64;63 13:23:17 INFO - PROCESS | 24279 | |10;stanford-crypto-aes;79;83;80;79;85;79;78;80;96;79 13:23:17 INFO - PROCESS | 24279 | |11;stanford-crypto-ccm;121;121;129;122;131;119;117;142;127;124 13:23:17 INFO - PROCESS | 24279 | |12;stanford-crypto-pbkdf2;164;161;166;165;164;169;158;163;168;163 13:23:17 INFO - PROCESS | 24279 | |13;stanford-crypto-sha256-iterative;63;63;63;62;66;62;63;62;62;61 13:23:17 INFO - PROCESS | 24279 | __end_tp_report 13:23:17 INFO - PROCESS | 24279 | __start_cc_report 13:23:17 INFO - PROCESS | 24279 | _x_x_mozilla_cycle_collect,1642 13:23:17 INFO - PROCESS | 24279 | __end_cc_report 13:23:17 INFO - PROCESS | 24279 | __startTimestamp1466540597858__endTimestamp 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | ------- Summary: start ------- 13:23:17 INFO - PROCESS | 24279 | Number of tests: 14 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.05 (2.7%) stddev-sans-first:1.05 13:23:17 INFO - PROCESS | 24279 | Values: 102.0 112.0 112.0 110.0 113.0 110.0 111.0 110.0 111.0 111.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:145.00 stddev:22.16 (15.3%) stddev-sans-first:22.96 13:23:17 INFO - PROCESS | 24279 | Values: 158.0 137.0 128.0 179.0 127.0 128.0 153.0 124.0 182.0 129.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:23:17 INFO - PROCESS | 24279 | Values: 160.0 160.0 162.0 160.0 161.0 162.0 162.0 161.0 160.0 160.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:16.75 (22.3%) stddev-sans-first:17.56 13:23:17 INFO - PROCESS | 24279 | Values: 75.0 75.0 75.0 126.0 75.0 76.0 75.0 74.0 96.0 75.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:86.50 stddev:20.51 (23.7%) stddev-sans-first:21.29 13:23:17 INFO - PROCESS | 24279 | Values: 87.0 86.0 115.0 87.0 88.0 88.0 126.0 86.0 86.0 141.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:23:17 INFO - PROCESS | 24279 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 118.0 116.0 117.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:23:17 INFO - PROCESS | 24279 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:23:17 INFO - PROCESS | 24279 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 13:23:17 INFO - PROCESS | 24279 | Values: 55.0 55.0 55.0 53.0 54.0 53.0 55.0 55.0 55.0 55.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:23:17 INFO - PROCESS | 24279 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.00 stddev:5.43 (6.8%) stddev-sans-first:5.67 13:23:17 INFO - PROCESS | 24279 | Values: 79.0 83.0 80.0 79.0 85.0 79.0 78.0 80.0 96.0 79.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:125.50 stddev:7.35 (5.9%) stddev-sans-first:7.63 13:23:17 INFO - PROCESS | 24279 | Values: 121.0 121.0 129.0 122.0 131.0 119.0 117.0 142.0 127.0 124.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:3.21 (2.0%) stddev-sans-first:3.41 13:23:17 INFO - PROCESS | 24279 | Values: 164.0 161.0 166.0 165.0 164.0 169.0 158.0 163.0 168.0 163.0 13:23:17 INFO - PROCESS | 24279 | 13:23:17 INFO - PROCESS | 24279 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 13:23:17 INFO - PROCESS | 24279 | Values: 63.0 63.0 63.0 62.0 66.0 62.0 63.0 62.0 62.0 61.0 13:23:17 INFO - PROCESS | 24279 | -------- Summary: end -------- 13:23:17 INFO - PROCESS | 24279 | 13:23:18 INFO - TEST-INFO | 24279: exit 0 13:23:18 INFO - TEST-OK | kraken | took 61857ms 13:23:18 INFO - SUITE-END | took 1176s 13:23:19 INFO - Completed test suite (00:19:36) 13:23:19 INFO - javascript benchmark 13:23:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.4928736758434, 3109.9067027989154, 3113.968860311397, 3136.9372612547736, 3181.077487528617, 5293.100172970595, 5353.705546194962, 5363.195520671901, 5409.0, 5523.889522209553, 5330.626856120073, 5351.438098999607, 5408.0, 5441.863953401157, 5452.59105567082, 4850.078485087831, 4872.65891387603, 4881.780319885596, 4957.231629097478, 4969.378827646544, 4955.727434991074, 5035.118854200518, 5052.570531504826, 5089.720065396402, 5098.158803797388, 4837.0, 4854.466008739036, 4973.104841128596, 4989.2017277235645, 5023.924641130349, 4867.269909513566, 4921.876953076166, 4938.555530002317, 4949.109160351135, 4952.801887924478, 4867.269909513601, 4904.288878112654, 4908.4846091160625, 4911.705297682115, 4955.677880937764, 5318.601104917147, 5343.706096164709, 5436.646617969819, 5468.0, 5477.863053423656, 5755.079187330007, 5829.47534721877, 5856.121581762727, 5856.619319744203, 5858.941410585882, 5883.7058147092475, 5899.085641725539, 5916.763329466816, 5921.082232254007, 5922.082077278029, 5305.1776974569, 5364.570834333205, 5406.135018397116, 5447.918281225785, 5458.6724796512335, 5984.611000284967, 5994.220751302303, 5999.160117583542, 5999.190109335271, 6001.2498437695285, 5721.628094173865, 5754.223179870663, 5760.942390576124, 5765.336986246635, 5766.509846662997, 5628.352739435018, 5682.289713785777, 5726.198332233407, 5732.3407808101765, 5845.883082338414, 5737.426257374313, 5747.109198074305, 5747.626404283708, 5754.280714910637, 5756.481916627524, 5713.914291285634, 5719.571032172604, 5767.769289228384, 5771.509421699203, 5778.191053252548, 4298.742075475481, 4348.869533913988, 4377.124575084996, 4394.846180383735, 4405.9559404405545, 3908.0, 3921.5490218625223, 3933.4099885016903, 3962.881113566598, 3968.2460332536725, 5416.160495123262, 5514.944850551524, 5519.834404967857, 5520.0, 5521.889562208733, 5763.510101641407, 5828.0966450200285, 5836.328822185418, 5841.678707671119, 5860.150278209721, 5561.360443549043, 5567.635929197291, 5569.665820050729, 5572.665640061609, 5573.27547418833, 4869.586085182799, 4997.500249975046, 5058.974705126451, 5064.797408103635, 5114.43741188469, 6008.09878518217, 6048.455638992512, 6050.42520960508, 6051.394860513913, 6109.0, 5817.970910145422, 5829.125631155361, 5830.883382332415, 5834.0, 5839.503642190291, 5822.679752613478, 5961.672108034099, 6030.125631783455, 6034.849128771816, 6047.848803779941, 5754.367019627922, 5757.309122905278, 5762.250907382014, 5764.884702305846, 5817.767289308549, 5801.8549536261935, 5802.47777700009, 5836.854078648068, 5847.883042339215, 5861.1501332307425, 5558.055130627884, 5614.29821272341, 5637.069883469182, 5654.886902262014, 5738.741756620879, 5589.776408943597, 5610.074337734228, 5626.2685850839125, 5650.152477128464, 5667.0, 5521.282233309644, 5532.087205611029, 5534.944650553604, 5536.86753241575, 5538.141588053858, 5560.416156303691, 5592.496675299242, 5635.0, 5639.3232812062815, 5647.717614119196, 5562.471565201299, 5565.1095824667855, 5583.916241256466, 5590.86022849432, 5611.3266408031295], "value": 5346.253140716002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1932075773158, 594.9974293315763, 612.8937268230844, 615.4245780195521, 629.3014753623479, 30556.0, 39869.60130398695, 41619.37570936439, 41694.0, 41794.582054179446, 42615.57384426155, 43017.13965720684, 43067.0, 43114.137717245634, 43237.78381108098, 7994.520328780262, 8759.080296568864, 8901.24339431146, 8905.643774249022, 10551.366917984908, 10423.27037107399, 10833.295835770688, 10841.0, 10843.67468975932, 10855.294405863593, 10977.231593788438, 10980.286281391724, 11008.559657613725, 11013.944930275338, 11030.613928512505, 8155.714549990722, 8341.20758527939, 10494.108000819939, 10773.83839242412, 10786.838197427045, 10687.091597214247, 10727.83908241377, 10735.785284294348, 10739.570417183382, 10749.086327662159, 41834.37248441276, 42211.36682949758, 42386.364204536956, 42490.0, 42547.78726106381, 3593.1376469647357, 3677.9264414711824, 3716.1824398632257, 3849.653531182179, 3896.9220615587815, 32089.83955080233, 32935.835320823244, 33000.33999320024, 33203.6679633203, 33812.49281260783, 4412.278512602945, 4463.263561512346, 4469.240229161051, 4512.864614061584, 4566.634669226454, 339449.0, 339549.0, 340906.0, 341185.0, 341262.0, 52632.21051684228, 53268.0, 53302.73348633232, 53359.199612005854, 53427.73286133622, 35535.466967995504, 36386.27227455436, 36629.450558241646, 38285.617143828764, 38436.42345364766, 17708.645827083386, 17789.822101779075, 17894.0, 17908.46274611764, 17910.373136940143, 10445.216608754374, 13385.933070334586, 13616.795748063787, 13635.795463068062, 13939.303034848217, 19570.90214548918, 19575.314863979693, 19603.21587136527, 19659.60680786376, 19671.21315147407, 7241.8551628967125, 7296.306850849161, 7422.6288685565505, 7462.1123164327455, 7472.9252707473315, 957.2916042128775, 1018.5162048027275, 1054.852320675106, 1056.9682909512726, 1089.1667874076338, 31772.523412148836, 31865.681343186734, 32058.0, 32275.838620806746, 32376.67623323784, 1071.1377341240377, 1154.2555051991587, 1188.8097904335266, 1194.856617205941, 1212.8908398244023, 16868.493945181417, 17002.574935626708, 17012.0, 17050.48848534546, 17125.914370428316, 564542.0, 574261.0, 574773.0, 575059.0, 575486.0, 56202.0, 57698.13452798211, 57910.0, 57916.0, 57923.710381447825, 1246.6447062587301, 1288.4652869059234, 1293.702448436846, 1351.2703140304125, 1356.7964805279287, 26695.466090677688, 32868.34263314673, 34479.0, 34573.48139777855, 34603.13492162716, 52515.21227181519, 53999.0, 54005.729971349894, 54032.459675402744, 54173.72913135409, 483698.0, 496880.0, 497725.0, 497853.0, 497904.0, 24836.50326993414, 27065.323366915196, 27338.72661273362, 27958.161255162377, 28087.438251234453, 46951.29573056475, 47299.0, 47808.0, 48352.51647483621, 48667.75666121647, 40809.0, 40826.59173408228, 40948.590514094474, 40951.38572921468, 42090.57909420867, 40059.799701001306, 40377.596224037385, 40502.392464112476, 40678.1864362717, 41267.38098928458, 40108.59891401165, 40813.0, 40863.7956810214, 41267.38098928458, 41373.172536548496, 34415.31169376648, 36583.81708091549, 37010.0, 37077.443838341904, 37079.814600926824, 27079.59380609332, 27085.593716094667, 27283.59074613922, 27460.45079098447, 27613.447731044864], "value": 20356.756897931315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.53181915791464, 394.4162639293847, 394.76708741842305, 397.04510651882225, 416.8020190409556, 14132.929335353334, 17613.383531576397, 18414.447566573006, 19898.403047908567, 19913.50216244593, 15475.69048619027, 17733.0, 18633.440996770085, 19275.710864337012, 19611.0, 5447.782088716446, 5697.0599851024535, 5705.372409035002, 5707.343655479611, 5734.770609175628, 4071.97964010181, 5546.417626149257, 5649.519790817785, 5919.0, 6351.523635727316, 6305.716242769064, 6379.744810207586, 6395.968020159916, 6413.679316034203, 6428.839279018039, 6147.170132032164, 6303.401176888211, 6369.140166077566, 6379.043143528462, 6386.904196437057, 5458.099413596752, 5629.296337957755, 5629.971850140764, 5639.0, 5642.351129620105, 19667.508312292164, 19875.80124198754, 19919.701204481946, 22871.0, 24571.87714061436, 2424.624183251581, 2445.205308274818, 2480.3675062858856, 2487.6144197649214, 2516.924492265235, 14598.0, 14662.486812961495, 14741.410343586243, 14791.40834366624, 15190.772138417933, 1910.8280254776998, 1931.565397785501, 1949.440447641895, 1982.9900850495799, 2000.8699434536709, 77737.0, 78491.60754196193, 79480.20519794786, 80904.19095809084, 83273.0, 15889.364425423084, 17442.215100320514, 17459.912700436416, 17894.836835605645, 18074.63850722978, 31415.21461963469, 31601.36797264042, 31616.36767264642, 32040.198995025312, 32042.839785800923, 9906.306558540833, 10202.489875506195, 10295.3822770634, 10378.169746420268, 10599.417032063157, 7136.6431678415875, 8782.560871956377, 8881.866771998426, 9147.771305717277, 9159.679411220575, 8100.8379832403025, 8639.611217495229, 8865.512396818236, 8932.553372331358, 9067.410618309788, 3275.950860737091, 3291.2923721400016, 3394.711449526818, 3473.235888104613, 3521.366154092288, 887.7558671365297, 983.8179936711731, 1008.1481148429712, 1045.6497073480318, 1048.4705223861902, 18273.0, 19330.710039349422, 19378.903105484384, 19498.805011949982, 19988.600227995357, 998.3311181508407, 1029.0, 1031.3244824639874, 1061.920355973305, 1077.5205033760058, 10458.790824183474, 10764.0, 10855.185861060452, 10947.671569852917, 11006.174536909604, 409000.0, 411943.0, 413213.0, 416778.0, 425856.0, 88993.0, 89886.0, 91221.0, 93182.0, 93877.0, 959.2709540749081, 990.1336330710628, 1003.5383723487278, 1006.8439391894268, 1015.939043657383, 16730.916345418194, 16782.1608919556, 16861.241244144287, 16963.321467141177, 17577.472675819747, 40726.59273407346, 40785.0, 41350.586494135874, 41633.58366416297, 42460.575394246895, 58418.4158158413, 59341.40658593359, 59755.70122149361, 59776.701116494136, 60437.69781151066, 8696.956515217384, 8918.509481978293, 8964.417312874642, 8994.415363001646, 9139.131782480654, 9591.616335346507, 12746.936265318986, 13771.655708606964, 13845.723085538435, 14024.158550486596, 11874.346910919638, 12197.573084941985, 12223.449944752685, 12278.938605306916, 12289.139760217056, 11899.226550274205, 11917.76164476723, 12225.816612750637, 12353.38233088324, 12373.0, 12164.452599633214, 12273.202241854251, 12292.631221063382, 12373.876261237632, 12536.937315313366, 7609.847803043797, 7950.64222110018, 7999.4400391972, 8325.625346859284, 9048.547572621474, 11115.0, 11709.590164344207, 12176.452059657513, 12252.632421027383, 12284.815727763911], "value": 10033.30755261782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.6257554021563, 1474.5207807462577, 1487.8735307498864, 1579.9447019354318, 1732.948011559652, 8419.484492791295, 8777.078406767294, 8829.602667879944, 9042.638294468214, 9061.093890610935, 8809.119088091204, 9030.322725795559, 9030.593623286952, 9040.231580315665, 9040.63837446503, 2028.1684509351169, 2316.316686577455, 2365.810735141193, 2400.855948643078, 2403.062805505854, 2411.3730430088217, 2426.259990702835, 2428.9028438862424, 2431.878406079698, 2440.1459489178824, 2252.88735563222, 2287.9199228027023, 2301.2290882554366, 2305.262316058862, 2306.7116610423695, 2016.3648450738044, 2265.275111964172, 2347.507023525062, 2348.2016114521143, 2368.1237941961585, 2298.2071185440996, 2330.673705681206, 2334.4047267946567, 2340.707411573553, 2341.4731685370657, 9034.728958131267, 9062.682806101755, 9114.680986165518, 9130.680426185118, 9130.726078217598, 5297.258383826267, 5435.891282174374, 5442.9727851360885, 5449.509544141007, 5449.536789372908, 3197.5683282756763, 3315.8342082896, 3364.5794275715534, 3393.6267010628812, 3401.846916888746, 1039.688093571933, 1059.0733108530037, 1071.839224116381, 1081.626838740641, 1085.4138765066855, 12815.871841281654, 12854.935725321408, 12881.291528965903, 12883.162594431333, 12898.09713320068, 4759.0719809637485, 4768.116593945372, 4775.498572649891, 4782.928256076161, 4927.236278376858, 10536.104431123287, 10627.468626568641, 10630.096441802534, 10692.732681683021, 10702.839457408145, 4806.927896081562, 5452.863678408072, 5510.724463776875, 5515.806946756844, 5522.3649280333275, 4500.797464114123, 4557.931631025537, 4564.406627138451, 4865.683730557503, 5018.673786203885, 3925.548561915359, 4014.9761810738073, 4059.79701014954, 4067.9593204068174, 4141.151064031867, 1255.9937200314123, 1279.969624452306, 1281.7756892543955, 1290.864459231786, 1301.7266374061364, 1012.4684540616088, 1022.447878145793, 1022.4989755019986, 1022.504085518523, 1032.4734385463319, 6215.285242197205, 6226.40849119333, 6230.408111229426, 6351.110844481776, 6536.673166341664, 436.9475662920406, 442.5397586510058, 450.05937590436145, 453.931910213464, 460.07984031936127, 4286.657067434598, 4367.497737760198, 4376.627986621173, 4398.076403955205, 4419.46966364032, 10605.522751476203, 10899.83650245247, 10909.127269818395, 10984.945075274572, 11038.558457661604, 10908.727281817859, 10930.180236482296, 10934.890651093547, 10935.781284374269, 10939.726506837393, 7857.960710196527, 8211.234584564347, 8227.0, 8323.708670196515, 8331.95834020826, 6057.666828324484, 6205.689715514297, 6310.432061114522, 6378.075179099097, 6413.679316034273, 10233.539490722786, 10464.895351046393, 10661.09380702649, 10666.040056394651, 10672.786544269227, 10514.26400151982, 10705.571777128827, 10768.138548915911, 10846.67459976202, 10866.565337386415, 7199.496035277481, 7874.960625196837, 7965.721199757981, 8132.186781322057, 8397.286230670461, 8503.0, 8672.696455624275, 8768.649254029768, 8808.779780505538, 8808.86786698213, 7761.456698031084, 7892.171322011106, 7932.127465978622, 7954.960225199068, 7994.960025200069, 7364.5581265124265, 7463.141738700119, 7826.452148349561, 7839.216078392115, 7899.605019748875, 6982.231954484901, 7129.429645628441, 7155.785326440215, 7161.033260509765, 7168.139823221247, 5128.743562821769, 5286.418493965738, 5414.75633596497, 5455.918161227664, 5599.076152434803, 5209.557187639093, 5239.502247286502, 5300.814471493479, 5379.300690910157, 5498.0], "value": 4630.187689234965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.07850469153533, 331.3224455987505, 332.24082970412604, 334.0762790883207, 339.8097065643239, 5163.457836927125, 5163.561097306733, 5314.9468505314935, 5359.89280214396, 5368.382635996862, 5232.633715639907, 5242.483607868216, 5251.501107394801, 5251.711155886424, 5265.8946821063555, 4142.627163555287, 4151.3150330195485, 4161.521425036114, 4162.583741625844, 4173.812178451962, 3956.0, 3980.6417422431973, 4139.586041395852, 4148.709590328678, 4160.271952408331, 4072.552019277877, 4094.549599544048, 4094.5700701426367, 4101.589841015904, 4104.322786740185, 4104.199681062194, 4117.438415770352, 4128.401381799622, 4132.0, 4148.274052040881, 3442.3803715331233, 3641.526601541809, 3655.378585640421, 3658.743887927846, 3668.1746607013474, 5147.742612869341, 5156.355455568054, 5175.197844334134, 5197.506236907488, 5201.609879259033, 4680.134175177603, 4698.953010469886, 4714.717116972993, 4726.0, 4726.83456079039, 5407.567394608422, 5497.752601132958, 5533.833984980457, 5535.197396377543, 5553.416891226403, 3910.413437984325, 3963.4451176835264, 3964.207158568269, 3965.6827453803626, 3972.523297204325, 5721.856953576153, 5740.885182296331, 5741.483266506035, 5752.712364381764, 5774.249347584829, 3901.843926242975, 4041.2725709372594, 4050.1292222172374, 4051.918961620751, 4054.8986275343354, 4081.4490043843703, 4101.446304748881, 4109.547949725527, 4110.897227569275, 4113.71204015716, 4615.861524154281, 4680.742559159211, 4683.437987441529, 4683.81264749413, 4709.62323014158, 5538.6399884007415, 5542.695151766611, 5550.833474995757, 5559.554515825915, 5565.554755619541, 1354.7222819322014, 1399.6640806206437, 1406.2546850169222, 1413.2297897645808, 1416.7945647881206, 897.7531178925848, 898.2454738020094, 901.9909800902038, 916.3448134583805, 918.554501066982, 4750.311204875274, 4799.66402351832, 4813.785658597015, 4822.397200349957, 4824.34871292378, 4930.260460930889, 4960.255961605788, 5001.299818025479, 5034.917492739079, 5065.138926382524, 4719.905601888012, 4723.598494128038, 4811.759412029384, 4838.709677419366, 5093.286939828427, 3020.5771192033135, 3036.681148479378, 3048.658590220296, 3049.5667036492814, 3051.0, 5906.586538942319, 5929.288485381696, 5936.406359364116, 5952.5833191676165, 5958.612690175211, 5602.786899174803, 5814.30228372598, 5825.592208545446, 5834.620749651259, 5842.678652674143, 5885.911711324334, 5888.908323130391, 5894.263217097777, 5914.964881145782, 5952.910706339495, 5569.081101618188, 5628.183913332462, 5712.314522257356, 5720.71283961122, 5742.799002034909, 5568.16477528374, 5636.21093046982, 5700.401457847032, 5714.428557144252, 5717.628354156966, 5882.735276912464, 5899.823005309848, 5908.379620139824, 5909.438603332676, 5927.199828023162, 3611.331903597843, 3836.712246581462, 3995.561597824839, 4051.331530297468, 4072.8981775454668, 5730.656160630376, 5771.769129234784, 5773.538116950718, 5776.364599893925, 5777.74000169985, 5557.944420555743, 5578.3584887738425, 5622.493975542221, 5626.1842032905815, 5628.3115065481015, 5381.811636592701, 5383.730813459233, 5456.727163641723, 5469.15228139639, 5477.068898287221, 5373.462653734595, 5384.892302154013, 5391.838244852661, 5404.567634589145, 5448.155535891943, 5320.813771517978, 5506.972465137809, 5602.775888964559, 5610.326760788568, 5616.1856530803625, 5495.752691128829, 5526.198701188386, 5527.281453411031, 5539.584531160099, 5557.555395568425], "value": 4186.443345884073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.3917928529678, 765.1162906842592, 768.3123604374085, 792.4888446951717, 820.8071103290725, 14246.501372451967, 15253.466128685499, 15257.465988690397, 15334.233288335594, 16835.0, 14473.5657930262, 14615.707685846277, 15137.31882065307, 15168.393264269416, 15190.392384304614, 673.441043933534, 776.669915286004, 795.8487887301409, 805.5609692717454, 806.0810675829559, 803.2289002557552, 809.5749731391037, 809.7570728781371, 810.3638643664694, 811.0308181722844, 854.5043874552745, 859.1494420523668, 859.8839156713857, 861.0872475176302, 861.336770686571, 693.2512886083043, 834.9666013359458, 843.2031730015138, 849.235687880909, 854.0520022774715, 622.6295354264206, 626.1359324132713, 628.2366924187135, 628.4501061571125, 629.1129507394552, 13764.105333153413, 13835.51575694856, 13909.026368154233, 13921.373538190806, 13978.930105349407, 13534.323283835769, 14004.439822407194, 14039.438422463089, 14051.578452646438, 14089.859101408958, 13058.15122017066, 13147.737045259137, 13233.206007639476, 13269.800952985714, 13974.441022359093, 4500.392447019676, 4527.4567051953645, 4560.338750881137, 4567.748773817439, 4587.632989360844, 75543.62228188824, 76802.0, 77200.22799771986, 77283.61358193173, 78042.82935755968, 11394.25937314072, 11556.826647600124, 11559.826602600968, 11575.536978520933, 11598.961287048962, 20391.490212744502, 20411.0, 20453.38639840807, 20473.48816279575, 20492.282770102975, 8430.578471076422, 8690.0, 8751.474911505331, 8766.60550275239, 8774.561271936378, 4786.497417771154, 4946.554810067111, 4970.950290497121, 5007.0, 5021.271915572222, 3442.3287458945765, 3556.4309710446205, 3557.7687450316166, 3558.1638314995957, 3558.5195998540385, 636.3064259956669, 647.8153726188013, 651.9543631945718, 657.8881590129689, 664.4584663499232, 653.5947712418331, 663.290279401046, 663.6648492511348, 668.0026720106943, 676.1581830620909, 9274.90725092754, 9279.536023198812, 9406.168175730954, 9501.649211268359, 9629.903700962901, 646.618495087891, 668.4585485756553, 673.1282988529865, 685.4242436353487, 713.454132959192, 4473.329000649864, 4488.483824360175, 4697.436307643036, 4737.45519265282, 4738.3129446230105, 102690.0, 111425.44287278673, 113861.0, 114542.0, 117438.0, 59125.0, 76831.84752228721, 85450.57274713587, 95332.52333738287, 97183.51408242913, 68900.0, 81794.59102704449, 82340.58829705932, 83234.99999999879, 83243.0, 8923.643054277756, 8931.392349376914, 8945.284377249674, 8979.685711000084, 9106.772330691785, 50690.0, 50885.0, 52421.21368179557, 53246.73376633092, 54174.45825541694, 72657.6367118161, 73258.26741732728, 73446.7965961022, 74672.62663686647, 77856.0, 11790.410479476164, 11881.1089168311, 12049.457774400349, 12065.09511786602, 12177.147599667938, 12652.240865547728, 12960.861457859724, 13025.609231723063, 13358.666033348854, 13651.795223071464, 11318.26431281964, 11357.772844542898, 11451.312921224753, 11831.40842957866, 11927.0, 11803.291802491878, 11873.525058997544, 11985.161038727554, 12016.699582510508, 12432.689182770504, 11710.94144529272, 11716.9454749073, 11925.642230733092, 12104.75790484203, 12314.13801033919, 9921.206303495848, 10003.499825008575, 10022.595383374928, 10134.263295553617, 10327.0, 9386.249100072115, 10127.447871243872, 10262.743431414274, 10298.948505257425, 10326.0], "value": 7331.512377655659, "unit": "score"}], "name": "dromaeo_css", "value": 7330.739646515308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 110.0, 113.0, 110.0, 111.0, 110.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 137.0, 128.0, 179.0, 127.0, 128.0, 153.0, 124.0, 182.0, 129.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 126.0, 75.0, 76.0, 75.0, 74.0, 96.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 115.0, 87.0, 88.0, 88.0, 126.0, 86.0, 86.0, 141.0], "value": 99.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 118.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 53.0, 54.0, 53.0, 55.0, 55.0, 55.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 80.0, 79.0, 85.0, 79.0, 78.0, 80.0, 96.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 129.0, 122.0, 131.0, 119.0, 117.0, 142.0, 127.0, 124.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 166.0, 165.0, 164.0, 169.0, 158.0, 163.0, 168.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 66.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1506.0, "alertThreshold": 2.0}]} 13:23:19 INFO - Return code: 0 13:23:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:23:19 INFO - # TBPL SUCCESS # 13:23:19 INFO - Running post-action listener: _resource_record_post_action 13:23:19 INFO - ##### 13:23:19 INFO - ##### Finished run-tests step (success) 13:23:19 INFO - ##### 13:23:19 INFO - Running post-run listener: _resource_record_post_run 13:23:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552116224; Read time: 16; Write time: 627892 13:23:19 INFO - TinderboxPrint: CPU usage
13.2% 13:23:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:23:19 INFO - TinderboxPrint: I/O write bytes / time
552,116,224 / 627,892 13:23:19 INFO - TinderboxPrint: CPU idle
8,271.9 (86.7%) 13:23:19 INFO - TinderboxPrint: CPU user
1,211.2 (12.7%) 13:23:19 INFO - TinderboxPrint: Swap in / out
0 / 0 13:23:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256004096; Read time: 0; Write time: 297884 13:23:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296112128; Read time: 16; Write time: 330008 13:23:19 INFO - Running post-run listener: _upload_blobber_files 13:23:19 INFO - Blob upload gear active. 13:23:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:23:19 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:19 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:19 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:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:20 INFO - (blobuploader) - INFO - Done attempting. 13:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:21 INFO - (blobuploader) - INFO - Done attempting. 13:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:23:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:23:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:23:25 INFO - (blobuploader) - INFO - Done attempting. 13:23:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:23:25 INFO - Return code: 0 13:23:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:23:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:23:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1170c03118be923fad7de315058e586f3bedc3eb07323219ed063f3cd903d8ee96ccc3ebbe0444de0e3b3a23d679da05a66d467e3a4897690459f67134cbfd91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59329a7248835b56907769a42f95ac6d9785cf07dcc18b328ac0e599cdb9b9eb20ed706bb206bb12874c8b29ce1f4cfc95cb8780dcf6b62c47a8e1079113e607", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb29a238b79ef40c4f8dc4d607fedd95bc639dc455e39fa05d6fbf8844cf8be679232de7e33dee3b54d90bd6497b3263f09a0b8f171194239ec55b15e62e393e"} 13:23:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:23:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:23:25 INFO - Contents: 13:23:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1170c03118be923fad7de315058e586f3bedc3eb07323219ed063f3cd903d8ee96ccc3ebbe0444de0e3b3a23d679da05a66d467e3a4897690459f67134cbfd91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59329a7248835b56907769a42f95ac6d9785cf07dcc18b328ac0e599cdb9b9eb20ed706bb206bb12874c8b29ce1f4cfc95cb8780dcf6b62c47a8e1079113e607", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb29a238b79ef40c4f8dc4d607fedd95bc639dc455e39fa05d6fbf8844cf8be679232de7e33dee3b54d90bd6497b3263f09a0b8f171194239ec55b15e62e393e"} 13:23:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:23:25 INFO - Copying logs to upload dir... 13:23:25 INFO - mkdir: /builds/slave/test/build/upload/logs 13:23:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.575471 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 13:23:25.073656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:25.077482) ========= 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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1170c03118be923fad7de315058e586f3bedc3eb07323219ed063f3cd903d8ee96ccc3ebbe0444de0e3b3a23d679da05a66d467e3a4897690459f67134cbfd91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59329a7248835b56907769a42f95ac6d9785cf07dcc18b328ac0e599cdb9b9eb20ed706bb206bb12874c8b29ce1f4cfc95cb8780dcf6b62c47a8e1079113e607", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb29a238b79ef40c4f8dc4d607fedd95bc639dc455e39fa05d6fbf8844cf8be679232de7e33dee3b54d90bd6497b3263f09a0b8f171194239ec55b15e62e393e"} 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.011454 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1170c03118be923fad7de315058e586f3bedc3eb07323219ed063f3cd903d8ee96ccc3ebbe0444de0e3b3a23d679da05a66d467e3a4897690459f67134cbfd91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59329a7248835b56907769a42f95ac6d9785cf07dcc18b328ac0e599cdb9b9eb20ed706bb206bb12874c8b29ce1f4cfc95cb8780dcf6b62c47a8e1079113e607", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb29a238b79ef40c4f8dc4d607fedd95bc639dc455e39fa05d6fbf8844cf8be679232de7e33dee3b54d90bd6497b3263f09a0b8f171194239ec55b15e62e393e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:25.103701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:25.104083) ========= 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=0e2a256762fed810e2f0f810000001b3-1466534603.904855-1894067802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 13:23:25.189210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 13:23:25.189876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 13:23:25.190601) ========= ========= Total master_lag: 0.17 =========