builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1466037265.8 results: success (0) buildid: 20160615145724 builduid: 180e562eea184d73906045e804e9b7d6 revision: 23c56144e51c56304df9620bb18fb8786e087e40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.795394) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.796350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.796644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.823938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.824198) ========= 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=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 17:34:26-- 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% 31.0M=0s 2016-06-15 17:34:26 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094292 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.931499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.931815) ========= 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=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015690 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:25.983066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:34:25.983390) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 23c56144e51c56304df9620bb18fb8786e087e40 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 23c56144e51c56304df9620bb18fb8786e087e40 --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=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 17:34:26,455 truncating revision to first 12 chars 2016-06-15 17:34:26,455 Setting DEBUG logging. 2016-06-15 17:34:26,455 attempt 1/10 2016-06-15 17:34:26,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/23c56144e51c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 17:34:27,858 unpacking tar archive at: mozilla-aurora-23c56144e51c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773944 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-15 17:34:27.770750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:27.771075) ========= script_repo_revision: 23c56144e51c56304df9620bb18fb8786e087e40 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:27.771459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:27.771738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 17:34:27.779764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-15 17:34:27.780030) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:28 INFO - MultiFileLogger online at 20160615 17:34:28 in /builds/slave/test 17:34:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:34:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:28 INFO - {'append_to_log': False, 17:34:28 INFO - 'base_work_dir': '/builds/slave/test', 17:34:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:34:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:28 INFO - 'branch': 'Mozilla-Aurora', 17:34:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:28 INFO - 'config_files': ('talos/linux_config.py',), 17:34:28 INFO - 'default_actions': ('clobber', 17:34:28 INFO - 'read-buildbot-config', 17:34:28 INFO - 'download-and-extract', 17:34:28 INFO - 'populate-webroot', 17:34:28 INFO - 'create-virtualenv', 17:34:28 INFO - 'install', 17:34:28 INFO - 'run-tests'), 17:34:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:28 INFO - 'download_minidump_stackwalk': True, 17:34:28 INFO - 'download_symbols': 'ondemand', 17:34:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:28 INFO - 'installer_path': 'installer.exe', 17:34:28 INFO - 'log_level': 'info', 17:34:28 INFO - 'log_name': 'talos', 17:34:28 INFO - 'log_to_console': True, 17:34:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:28 INFO - 'opt_config_files': (), 17:34:28 INFO - 'pip_index': False, 17:34:28 INFO - 'sps_profile': False, 17:34:28 INFO - 'sps_profile_interval': 0, 17:34:28 INFO - 'suite': 'dromaeojs', 17:34:28 INFO - 'system_bits': '32', 17:34:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:28 INFO - 'title': 'talos-linux64-ix-063', 17:34:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:28 INFO - 'use_talos_json': True, 17:34:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:28 INFO - 'work_dir': 'build'} 17:34:28 INFO - ##### 17:34:28 INFO - ##### Running clobber step. 17:34:28 INFO - ##### 17:34:28 INFO - Running pre-action listener: _resource_record_pre_action 17:34:28 INFO - Running main action method: clobber 17:34:28 INFO - rmtree: /builds/slave/test/build 17:34:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:28 INFO - Running post-action listener: _resource_record_post_action 17:34:28 INFO - ##### 17:34:28 INFO - ##### Finished clobber step (success) 17:34:28 INFO - ##### 17:34:28 INFO - ##### 17:34:28 INFO - ##### Running read-buildbot-config step. 17:34:28 INFO - ##### 17:34:28 INFO - Running pre-action listener: _resource_record_pre_action 17:34:28 INFO - Running main action method: read_buildbot_config 17:34:28 INFO - Using buildbot properties: 17:34:28 INFO - { 17:34:28 INFO - "project": "", 17:34:28 INFO - "product": "firefox", 17:34:28 INFO - "script_repo_revision": "production", 17:34:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:34:28 INFO - "repository": "", 17:34:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:34:28 INFO - "buildid": "20160615145724", 17:34:28 INFO - "pgo_build": "True", 17:34:28 INFO - "basedir": "/builds/slave/test", 17:34:28 INFO - "buildnumber": 299, 17:34:28 INFO - "slavename": "talos-linux64-ix-063", 17:34:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:34:28 INFO - "platform": "ubuntu64_hw", 17:34:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:34:28 INFO - "branch": "mozilla-aurora", 17:34:28 INFO - "repo_path": "releases/mozilla-aurora", 17:34:28 INFO - "revision": "23c56144e51c56304df9620bb18fb8786e087e40", 17:34:28 INFO - "stage_platform": "linux64-pgo", 17:34:28 INFO - "builduid": "180e562eea184d73906045e804e9b7d6", 17:34:28 INFO - "slavebuilddir": "test" 17:34:28 INFO - } 17:34:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:34:28 INFO - Running post-action listener: _resource_record_post_action 17:34:28 INFO - ##### 17:34:28 INFO - ##### Finished read-buildbot-config step (success) 17:34:28 INFO - ##### 17:34:28 INFO - ##### 17:34:28 INFO - ##### Running download-and-extract step. 17:34:28 INFO - ##### 17:34:28 INFO - Running pre-action listener: _resource_record_pre_action 17:34:28 INFO - Running main action method: download_and_extract 17:34:28 INFO - mkdir: /builds/slave/test/build/tests 17:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:28 INFO - https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:34:33 INFO - Downloaded 1361 bytes. 17:34:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:34:33 INFO - Using the following test package requirements: 17:34:33 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:34:33 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:34:33 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:34:33 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'jsshell-linux-x86_64.zip'], 17:34:33 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:34:33 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:34:33 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:34:33 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:34:33 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:34:33 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:33 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:34:33 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:34:33 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')]} 17:34:33 INFO - https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:36 INFO - Downloaded 24473779 bytes. 17:34:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:34:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:34:37 INFO - Return code: 0 17:34:37 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:34:37 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')]} 17:34:37 INFO - https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:34:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:40 INFO - Downloaded 24473779 bytes. 17:34:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:34:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:34:42 INFO - Return code: 0 17:34: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')]} 17:34:42 INFO - https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:34:44 INFO - Downloaded 10833369 bytes. 17:34:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:34:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:34:44 INFO - Return code: 0 17:34:44 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')]} 17:34:44 INFO - https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:34:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:34:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:34:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:34:50 INFO - Downloaded 63563156 bytes. 17:34:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:34:50 INFO - mkdir: /builds/slave/test/properties 17:34:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:50 INFO - Contents: 17:34:50 INFO - build_url:https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:34:51 INFO - Running post-action listener: _resource_record_post_action 17:34:51 INFO - Running post-action listener: set_extra_try_arguments 17:34:51 INFO - ##### 17:34:51 INFO - ##### Finished download-and-extract step (success) 17:34:51 INFO - ##### 17:34:51 INFO - ##### 17:34:51 INFO - ##### Running populate-webroot step. 17:34:51 INFO - ##### 17:34:51 INFO - Running pre-action listener: _resource_record_pre_action 17:34:51 INFO - Running main action method: populate_webroot 17:34:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:51 INFO - '--tppagecycles', 17:34:51 INFO - '7'], 17:34:51 INFO - 'tests': ['tsvgm']}}, 17:34:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['damp', 'tps']}, 17:34:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'tests': ['damp', 'tps']}, 17:34:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['dromaeo_dom']}, 17:34:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['a11yr', 17:34:51 INFO - 'ts_paint', 17:34:51 INFO - 'tpaint', 17:34:51 INFO - 'sessionrestore', 17:34:51 INFO - 'sessionrestore_no_auto_restore', 17:34:51 INFO - 'tabpaint']}, 17:34:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['tsvgx', 17:34:51 INFO - 'tsvgr_opacity', 17:34:51 INFO - 'tart', 17:34:51 INFO - 'tscrollx', 17:34:51 INFO - 'cart']}, 17:34:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:51 INFO - 'tsvgr_opacity', 17:34:51 INFO - 'tart', 17:34:51 INFO - 'tscrollx', 17:34:51 INFO - 'cart']}, 17:34:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'talos_options': ['--disable-e10s'], 17:34:51 INFO - 'tests': ['tp5o']}, 17:34:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'tests': ['tp5o']}, 17:34:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'talos_options': ['--disable-e10s', 17:34:51 INFO - '--xperf_path', 17:34:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:51 INFO - 'tests': ['tp5n']}, 17:34:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:51 INFO - 'talos_options': ['--xperf_path', 17:34:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:51 INFO - 'tests': ['tp5n']}}, 17:34:51 INFO - 'talos.zip': {'path': '', 17:34:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:51 INFO - Running post-action listener: _resource_record_post_action 17:34:51 INFO - ##### 17:34:51 INFO - ##### Finished populate-webroot step (success) 17:34:51 INFO - ##### 17:34:51 INFO - ##### 17:34:51 INFO - ##### Running create-virtualenv step. 17:34:51 INFO - ##### 17:34:51 INFO - Running pre-action listener: _resource_record_pre_action 17:34:51 INFO - Running main action method: create_virtualenv 17:34:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:51 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 17:34:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:51 INFO - Using real prefix '/usr' 17:34:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:53 INFO - Installing pip.................done. 17:34:53 INFO - Return code: 0 17:34:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:53 INFO - Using env: {'DISPLAY': ':0', 17:34:53 INFO - 'HOME': '/home/cltbld', 17:34:53 INFO - 'LANG': 'en_US.UTF-8', 17:34:53 INFO - 'LANGUAGE': 'en_US:en', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MAIL': '/var/mail/cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SHLVL': '1', 17:34:53 INFO - 'TERM': 'linux', 17:34:53 INFO - 'TMOUT': '86400', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - '_': '/tools/buildbot/bin/python'} 17:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:53 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 17:34:53 INFO - Cleaning up... 17:34:53 INFO - Return code: 0 17:34:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:34:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:34:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:34:53 INFO - Using env: {'DISPLAY': ':0', 17:34:53 INFO - 'HOME': '/home/cltbld', 17:34:53 INFO - 'LANG': 'en_US.UTF-8', 17:34:53 INFO - 'LANGUAGE': 'en_US:en', 17:34:53 INFO - 'LOGNAME': 'cltbld', 17:34:53 INFO - 'MAIL': '/var/mail/cltbld', 17:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:53 INFO - 'MOZ_NO_REMOTE': '1', 17:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:53 INFO - 'NO_EM_RESTART': '1', 17:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:53 INFO - 'PWD': '/builds/slave/test', 17:34:53 INFO - 'SHELL': '/bin/bash', 17:34:53 INFO - 'SHLVL': '1', 17:34:53 INFO - 'TERM': 'linux', 17:34:53 INFO - 'TMOUT': '86400', 17:34:53 INFO - 'USER': 'cltbld', 17:34:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:53 INFO - '_': '/tools/buildbot/bin/python'} 17:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:54 INFO - Downloading/unpacking psutil>=3.1.1 17:34:54 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 17:34:54 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 17:34:54 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 17:34:54 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 17:34:54 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 17:34:54 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 17:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:56 INFO - Installing collected packages: psutil 17:34:56 INFO - Running setup.py install for psutil 17:34:56 INFO - building 'psutil._psutil_linux' extension 17:34:56 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 17:34:56 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 17:34:56 INFO - building 'psutil._psutil_posix' extension 17:34:56 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 17:34:56 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 17:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:56 INFO - Successfully installed psutil 17:34:56 INFO - Cleaning up... 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:34:56 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 17:34:56 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 17:34:56 INFO - Using env: {'DISPLAY': ':0', 17:34:56 INFO - 'HOME': '/home/cltbld', 17:34:56 INFO - 'LANG': 'en_US.UTF-8', 17:34:56 INFO - 'LANGUAGE': 'en_US:en', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MAIL': '/var/mail/cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SHLVL': '1', 17:34:56 INFO - 'TERM': 'linux', 17:34:56 INFO - 'TMOUT': '86400', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - '_': '/tools/buildbot/bin/python'} 17:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:56 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 17:34:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:58 INFO - Installing collected packages: mozsystemmonitor 17:34:58 INFO - Running setup.py install for mozsystemmonitor 17:34:58 INFO - Successfully installed mozsystemmonitor 17:34:58 INFO - Cleaning up... 17:34:58 INFO - Return code: 0 17:34:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:58 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')]} 17:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:58 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')]} 17:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:58 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:34:58 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 17:34:58 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 17:34:58 INFO - Using env: {'DISPLAY': ':0', 17:34:58 INFO - 'HOME': '/home/cltbld', 17:34:58 INFO - 'LANG': 'en_US.UTF-8', 17:34:58 INFO - 'LANGUAGE': 'en_US:en', 17:34:58 INFO - 'LOGNAME': 'cltbld', 17:34:58 INFO - 'MAIL': '/var/mail/cltbld', 17:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:58 INFO - 'MOZ_NO_REMOTE': '1', 17:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:58 INFO - 'NO_EM_RESTART': '1', 17:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:58 INFO - 'PWD': '/builds/slave/test', 17:34:58 INFO - 'SHELL': '/bin/bash', 17:34:58 INFO - 'SHLVL': '1', 17:34:58 INFO - 'TERM': 'linux', 17:34:58 INFO - 'TMOUT': '86400', 17:34:58 INFO - 'USER': 'cltbld', 17:34:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:58 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:35:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:01 INFO - warning: no files found matching '*.txt' 17:35:01 INFO - no previously-included directories found matching 'build' 17:35:01 INFO - no previously-included directories found matching 'dist' 17:35:01 INFO - no previously-included directories found matching '.git*' 17:35:01 INFO - Installing collected packages: jsonschema, functools32 17:35:01 INFO - Running setup.py install for functools32 17:35:01 INFO - warning: no files found matching '*.txt' 17:35:01 INFO - no previously-included directories found matching 'build' 17:35:01 INFO - no previously-included directories found matching 'dist' 17:35:01 INFO - no previously-included directories found matching '.git*' 17:35:01 INFO - Successfully installed jsonschema functools32 17:35:01 INFO - Cleaning up... 17:35:01 INFO - Return code: 0 17:35:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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', '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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:35: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 blobuploader==1.2.4 17:35:01 INFO - Using env: {'DISPLAY': ':0', 17:35:01 INFO - 'HOME': '/home/cltbld', 17:35:01 INFO - 'LANG': 'en_US.UTF-8', 17:35:01 INFO - 'LANGUAGE': 'en_US:en', 17:35:01 INFO - 'LOGNAME': 'cltbld', 17:35:01 INFO - 'MAIL': '/var/mail/cltbld', 17:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:01 INFO - 'MOZ_NO_REMOTE': '1', 17:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:01 INFO - 'NO_EM_RESTART': '1', 17:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:01 INFO - 'PWD': '/builds/slave/test', 17:35:01 INFO - 'SHELL': '/bin/bash', 17:35:01 INFO - 'SHLVL': '1', 17:35:01 INFO - 'TERM': 'linux', 17:35:01 INFO - 'TMOUT': '86400', 17:35:01 INFO - 'USER': 'cltbld', 17:35:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:01 INFO - '_': '/tools/buildbot/bin/python'} 17:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:04 INFO - Downloading docopt-0.6.1.tar.gz 17:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:04 INFO - Running setup.py install for blobuploader 17:35:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:04 INFO - Running setup.py install for requests 17:35:04 INFO - Running setup.py install for docopt 17:35:04 INFO - Successfully installed blobuploader requests docopt 17:35:04 INFO - Cleaning up... 17:35:05 INFO - Return code: 0 17:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:05 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')]} 17:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 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')]} 17:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35:05 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 17:35:05 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 17:35:05 INFO - Using env: {'DISPLAY': ':0', 17:35:05 INFO - 'HOME': '/home/cltbld', 17:35:05 INFO - 'LANG': 'en_US.UTF-8', 17:35:05 INFO - 'LANGUAGE': 'en_US:en', 17:35:05 INFO - 'LOGNAME': 'cltbld', 17:35:05 INFO - 'MAIL': '/var/mail/cltbld', 17:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:05 INFO - 'MOZ_NO_REMOTE': '1', 17:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:05 INFO - 'NO_EM_RESTART': '1', 17:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:05 INFO - 'PWD': '/builds/slave/test', 17:35:05 INFO - 'SHELL': '/bin/bash', 17:35:05 INFO - 'SHLVL': '1', 17:35:05 INFO - 'TERM': 'linux', 17:35:05 INFO - 'TMOUT': '86400', 17:35:05 INFO - 'USER': 'cltbld', 17:35:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:05 INFO - '_': '/tools/buildbot/bin/python'} 17:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Running setup.py (path:/tmp/pip-X97_Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Running setup.py (path:/tmp/pip-rFbYkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:05 INFO - Running setup.py (path:/tmp/pip-fWv7q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:05 INFO - Running setup.py (path:/tmp/pip-WlxI03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:05 INFO - Running setup.py (path:/tmp/pip-Few7i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:05 INFO - Running setup.py (path:/tmp/pip-ehL3V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:05 INFO - Running setup.py (path:/tmp/pip-bTZPi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:05 INFO - Running setup.py (path:/tmp/pip-2MXtF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:05 INFO - Running setup.py (path:/tmp/pip-MxLiYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:05 INFO - Running setup.py (path:/tmp/pip-7acl1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:05 INFO - Running setup.py (path:/tmp/pip-tmUw_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Running setup.py (path:/tmp/pip-y6_Nvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:06 INFO - Running setup.py (path:/tmp/pip-hlRECp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:06 INFO - Running setup.py (path:/tmp/pip-W_ssbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:06 INFO - Running setup.py (path:/tmp/pip-xh9db5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:06 INFO - Running setup.py (path:/tmp/pip-Op5ZWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:06 INFO - Running setup.py (path:/tmp/pip-RPch9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:06 INFO - Running setup.py install for manifestparser 17:35:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:06 INFO - Running setup.py install for mozcrash 17:35:06 INFO - Running setup.py install for mozdebug 17:35:06 INFO - Running setup.py install for mozdevice 17:35:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:35:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:06 INFO - Running setup.py install for mozfile 17:35:06 INFO - Running setup.py install for mozhttpd 17:35:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozinfo 17:35:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozInstall 17:35:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozleak 17:35:07 INFO - Running setup.py install for mozlog 17:35:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for moznetwork 17:35:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozprocess 17:35:07 INFO - Running setup.py install for mozprofile 17:35:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozrunner 17:35:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:07 INFO - Running setup.py install for mozscreenshot 17:35:08 INFO - Running setup.py install for moztest 17:35:08 INFO - Running setup.py install for mozversion 17:35:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:08 INFO - Cleaning up... 17:35:08 INFO - Return code: 0 17:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:08 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')]} 17:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:08 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')]} 17:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:08 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35:08 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 17:35:08 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 17:35:08 INFO - Using env: {'DISPLAY': ':0', 17:35:08 INFO - 'HOME': '/home/cltbld', 17:35:08 INFO - 'LANG': 'en_US.UTF-8', 17:35:08 INFO - 'LANGUAGE': 'en_US:en', 17:35:08 INFO - 'LOGNAME': 'cltbld', 17:35:08 INFO - 'MAIL': '/var/mail/cltbld', 17:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:08 INFO - 'MOZ_NO_REMOTE': '1', 17:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:08 INFO - 'NO_EM_RESTART': '1', 17:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:08 INFO - 'PWD': '/builds/slave/test', 17:35:08 INFO - 'SHELL': '/bin/bash', 17:35:08 INFO - 'SHLVL': '1', 17:35:08 INFO - 'TERM': 'linux', 17:35:08 INFO - 'TMOUT': '86400', 17:35:08 INFO - 'USER': 'cltbld', 17:35:08 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:08 INFO - '_': '/tools/buildbot/bin/python'} 17:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:08 INFO - Running setup.py (path:/tmp/pip-vtzMce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:08 INFO - Running setup.py (path:/tmp/pip-EWgO6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:08 INFO - Running setup.py (path:/tmp/pip-GaXLSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:08 INFO - Running setup.py (path:/tmp/pip-FmQzSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:08 INFO - Running setup.py (path:/tmp/pip-NAbmZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:08 INFO - Running setup.py (path:/tmp/pip-TZ0r1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:08 INFO - Running setup.py (path:/tmp/pip-p4HrTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:08 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)) 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:08 INFO - Running setup.py (path:/tmp/pip-DtRL_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:09 INFO - Running setup.py (path:/tmp/pip-V3mZMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:09 INFO - Running setup.py (path:/tmp/pip-BD3n_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:09 INFO - Running setup.py (path:/tmp/pip-jYjIUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:09 INFO - Running setup.py (path:/tmp/pip-jdC_4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:09 INFO - Running setup.py (path:/tmp/pip-sBxQm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:09 INFO - Running setup.py (path:/tmp/pip-2X5pRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:09 INFO - Running setup.py (path:/tmp/pip-ssqSnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:09 INFO - Running setup.py (path:/tmp/pip-6jRuhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:09 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)) 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:09 INFO - Running setup.py (path:/tmp/pip-y4EuIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:09 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)) 17:35:09 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)) 17:35:09 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)) 17:35:09 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)) 17:35:09 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)) 17:35:09 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)) 17:35:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:11 INFO - Downloading blessings-1.6.tar.gz 17:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:11 INFO - Installing collected packages: blessings 17:35:11 INFO - Running setup.py install for blessings 17:35:11 INFO - Successfully installed blessings 17:35:11 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:15 INFO - Reading from file tmpfile_stdout 17:35:15 INFO - Current package versions: 17:35:15 INFO - argparse == 1.2.1 17:35:15 INFO - blessings == 1.6 17:35:15 INFO - blobuploader == 1.2.4 17:35:15 INFO - docopt == 0.6.1 17:35:15 INFO - functools32 == 3.2.3-2 17:35:15 INFO - jsonschema == 2.5.1 17:35:15 INFO - manifestparser == 1.1 17:35:15 INFO - mozInstall == 1.12 17:35:15 INFO - mozcrash == 0.17 17:35:15 INFO - mozdebug == 0.1 17:35:15 INFO - mozdevice == 0.48 17:35:15 INFO - mozfile == 1.2 17:35:15 INFO - mozhttpd == 0.7 17:35:15 INFO - mozinfo == 0.9 17:35:15 INFO - mozleak == 0.1 17:35:15 INFO - mozlog == 3.2 17:35:15 INFO - moznetwork == 0.27 17:35:15 INFO - mozprocess == 0.22 17:35:15 INFO - mozprofile == 0.28 17:35:15 INFO - mozrunner == 6.11 17:35:15 INFO - mozscreenshot == 0.1 17:35:15 INFO - mozsystemmonitor == 0.3 17:35:15 INFO - moztest == 0.7 17:35:15 INFO - mozversion == 1.4 17:35:15 INFO - psutil == 3.1.1 17:35:15 INFO - requests == 1.2.3 17:35:15 INFO - wsgiref == 0.1.2 17:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35:15 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 17:35:15 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 17:35:15 INFO - Using env: {'DISPLAY': ':0', 17:35:15 INFO - 'HOME': '/home/cltbld', 17:35:15 INFO - 'LANG': 'en_US.UTF-8', 17:35:15 INFO - 'LANGUAGE': 'en_US:en', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MAIL': '/var/mail/cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SHLVL': '1', 17:35:15 INFO - 'TERM': 'linux', 17:35:15 INFO - 'TMOUT': '86400', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - '_': '/tools/buildbot/bin/python'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35:15 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 17:35:15 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 17:35:15 INFO - Using env: {'DISPLAY': ':0', 17:35:15 INFO - 'HOME': '/home/cltbld', 17:35:15 INFO - 'LANG': 'en_US.UTF-8', 17:35:15 INFO - 'LANGUAGE': 'en_US:en', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MAIL': '/var/mail/cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SHLVL': '1', 17:35:15 INFO - 'TERM': 'linux', 17:35:15 INFO - 'TMOUT': '86400', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - '_': '/tools/buildbot/bin/python'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x7ffa9293af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, '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': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', '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 17:35:15 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 17:35:15 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 17:35:15 INFO - Using env: {'DISPLAY': ':0', 17:35:15 INFO - 'HOME': '/home/cltbld', 17:35:15 INFO - 'LANG': 'en_US.UTF-8', 17:35:15 INFO - 'LANGUAGE': 'en_US:en', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MAIL': '/var/mail/cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SHLVL': '1', 17:35:15 INFO - 'TERM': 'linux', 17:35:15 INFO - 'TMOUT': '86400', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - '_': '/tools/buildbot/bin/python'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 INFO - Downloading/unpacking flake8 17:35:15 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 17:35:15 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 17:35:15 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 17:35:15 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 17:35:15 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 17:35:15 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 17:35:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:35:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:35:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:35:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:35:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:35:18 INFO - no previously-included directories found matching 'docs/_build' 17:35:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:35:21 INFO - Running setup.py install for pep8 17:35:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:35:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:35:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:35:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:35:29 INFO - no previously-included directories found matching 'docs/_build' 17:35:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:35:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:35:29 INFO - Cleaning up... 17:35:35 INFO - Return code: 0 17:35:35 INFO - Running post-action listener: _resource_record_post_action 17:35:35 INFO - Running post-action listener: _start_resource_monitoring 17:35:35 INFO - Starting resource monitoring. 17:35:35 INFO - ##### 17:35:35 INFO - ##### Finished create-virtualenv step (success) 17:35:35 INFO - ##### 17:35:35 INFO - ##### 17:35:35 INFO - ##### Running install step. 17:35:35 INFO - ##### 17:35:35 INFO - Running pre-action listener: _resource_record_pre_action 17:35:35 INFO - Running main action method: install 17:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:35 INFO - Reading from file tmpfile_stdout 17:35:35 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:35 INFO - Reading from file tmpfile_stdout 17:35:36 INFO - Output received: 17:35:36 INFO - Usage: mozinstall [options] installer 17:35:36 INFO - Options: 17:35:36 INFO - -h, --help show this help message and exit 17:35:36 INFO - -d DEST, --destination=DEST 17:35:36 INFO - Directory to install application into. [default: 17:35:36 INFO - "/builds/slave/test"] 17:35:36 INFO - --app=APP Application being installed. [default: firefox] 17:35:36 INFO - mkdir: /builds/slave/test/build/application 17:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:35:51 INFO - Reading from file tmpfile_stdout 17:35:51 INFO - Output received: 17:35:51 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:51 INFO - Running post-action listener: _resource_record_post_action 17:35:51 INFO - ##### 17:35:51 INFO - ##### Finished install step (success) 17:35:51 INFO - ##### 17:35:51 INFO - ##### 17:35:51 INFO - ##### Running run-tests step. 17:35:51 INFO - ##### 17:35:51 INFO - Running pre-action listener: _resource_record_pre_action 17:35:51 INFO - Running main action method: run_tests 17:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:51 INFO - Python 2.7.3 17:35:51 INFO - Return code: 0 17:35:51 INFO - grabbing minidump binary from tooltool 17:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:51 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 0x15e01c0>, '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 0x15e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:51 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 17:35:51 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 17:35:51 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 17:35:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:51 INFO - Return code: 0 17:35:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:35:52 INFO - Return code: 0 17:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 17:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 17:35:52 INFO - Using env: {'DISPLAY': ':0', 17:35:52 INFO - 'HOME': '/home/cltbld', 17:35:52 INFO - 'LANG': 'en_US.UTF-8', 17:35:52 INFO - 'LANGUAGE': 'en_US:en', 17:35:52 INFO - 'LOGNAME': 'cltbld', 17:35:52 INFO - 'MAIL': '/var/mail/cltbld', 17:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:52 INFO - 'MOZ_NO_REMOTE': '1', 17:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:52 INFO - 'NO_EM_RESTART': '1', 17:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:52 INFO - 'PWD': '/builds/slave/test', 17:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:52 INFO - 'SHELL': '/bin/bash', 17:35:52 INFO - 'SHLVL': '1', 17:35:52 INFO - 'TERM': 'linux', 17:35:52 INFO - 'TMOUT': '86400', 17:35:52 INFO - 'USER': 'cltbld', 17:35:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178', 17:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:52 INFO - '_': '/tools/buildbot/bin/python'} 17:35:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 17:35:53 INFO - mozversion application_buildid: 20160615145724 17:35:53 INFO - mozversion application_changeset: 23c56144e51c56304df9620bb18fb8786e087e40 17:35:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:53 INFO - mozversion application_name: Firefox 17:35:53 INFO - mozversion application_remotingname: firefox-dev 17:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:35:53 INFO - mozversion application_vendor: Mozilla 17:35:53 INFO - mozversion application_version: 49.0a2 17:35:53 INFO - mozversion platform_buildid: 20160615145724 17:35:53 INFO - mozversion platform_changeset: 23c56144e51c56304df9620bb18fb8786e087e40 17:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:35:53 INFO - mozversion platform_version: 49.0a2 17:35:53 INFO - using testdate: 1466037353 17:35:53 INFO - actual date: 1466037353 17:35:53 INFO - starting webserver on 'localhost:56113' 17:35:53 INFO - SUITE-START | Running 2 tests 17:35:53 INFO - TEST-START | dromaeo_css 17:35:53 INFO - operating with platform_type : linux_ 17:35:53 INFO - Initialising browser for dromaeo_css test... 17:35:53 INFO - TEST-INFO | started process 26453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpooDlet/profile http://localhost:56113/getInfo.html) 17:35:59 INFO - PROCESS | 26453 | __metrics Screen width/height:1600/1200 17:35:59 INFO - PROCESS | 26453 | colorDepth:24 17:35:59 INFO - PROCESS | 26453 | Browser inner width/height: 1024/697 17:35:59 INFO - PROCESS | 26453 | __metrics 17:36:01 ERROR - PROCESS | 26453 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:36:01 INFO - PROCESS | 26453 | console.error: PushService: 17:36:01 INFO - PROCESS | 26453 | stateChangeProcessEnqueue: Error transitioning state 17:36:01 INFO - PROCESS | 26453 | UnknownError 17:36:02 INFO - TEST-INFO | 26453: exit 0 17:36:02 INFO - Browser initialized. 17:36:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:36:02 INFO - TEST-INFO | started process 26546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpooDlet/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:14 INFO - PROCESS | 26546 | RSS: Main: 148955136 17:36:14 INFO - PROCESS | 26546 | 17:37:05 INFO - PROCESS | 26546 | 1466037425621 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] 17:39:14 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56113/tests/dromaeo/cssquery-ext.html) 17:39:15 INFO - PROCESS | 26546 | RSS: Main: 245583872 17:39:15 INFO - PROCESS | 26546 | 17:42:18 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-ext.html (next: http://localhost:56113/tests/dromaeo/cssquery-jquery.html) 17:42:18 INFO - PROCESS | 26546 | RSS: Main: 224952320 17:42:18 INFO - PROCESS | 26546 | 17:45:20 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56113/tests/dromaeo/cssquery-mootools.html) 17:45:21 INFO - PROCESS | 26546 | RSS: Main: 222150656 17:45:21 INFO - PROCESS | 26546 | 17:48:23 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56113/tests/dromaeo/cssquery-prototype.html) 17:48:23 INFO - PROCESS | 26546 | RSS: Main: 219742208 17:48:23 INFO - PROCESS | 26546 | 17:51:26 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56113/tests/dromaeo/cssquery-yui.html) 17:51:27 INFO - PROCESS | 26546 | RSS: Main: 217464832 17:51:27 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | Cycle 1(1): loaded http://localhost:56113/tests/dromaeo/cssquery-yui.html (next: http://localhost:56113/tests/dromaeo/cssquery-dojo.html) 17:54:29 INFO - PROCESS | 26546 | RSS: Main: 259096576 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | __start_tp_report 17:54:29 INFO - PROCESS | 26546 | _x_x_mozilla_page_load 17:54:29 INFO - PROCESS | 26546 | _x_x_mozilla_page_load_details 17:54:29 INFO - PROCESS | 26546 | |i|pagename|runs| 17:54:29 INFO - PROCESS | 26546 | |0;dojo.html;3328.2345060636053;3342.1644588852787;3342.4484959981605;3368.2253081791205;3393.8981830545076;5540.667559946401;5634.830955071344;5660.264165658458;5660.518855897254;5672.574556908233;5596.692181929992;5636.915446268299;5645.491905728483;5645.633033852797;5653.180288858123;5000.499950005007;5067.695938243699;5078.187490001591;5117.641765076446;5146.588272938175;5031.572316353115;5132.640715149941;5177.119889618773;5178.844634660947;5179.015986962484;5082.0598189334905;5103.897922041557;5126.820561280356;5133.255677926699;5178.40448348441;5212.661177023481;5226.869328266805;5228;5240.68555886648;5272.209168624699;4940.036692844897;5036.5718913892;5083.79664813407;5140.1518749406305;5140.254663073833;5477.287952566181;5488.4237155098535;5494.340679118532;5495.477929596682;5539.473749993744;6058.182145410357;6071.119687645267;6087.4825639820665;6090.299615544181;6092.116643086772;5997.250343707036;6007.579469437142;6015.488683461911;6089.117078023662;6099.230750080917;5683.403242659544;5691.089425691911;5732.971335143339;5733.483986441157;5735.283089613798;5966.224390829165;6129.186698318328;6217.285012223652;6219.689015549205;6220.377962203744;5882.764689412375;5926.555508336892;5926.940730592725;5988.041913293852;6010.909836352458;5972.552058595623;5977.611455255482;6014.0377539593455;6018.638881667114;6021.187139736079;5670.858228544319;5925.792597259076;5950.196723442366;5951.3751056139345;5952.85117872048;5981.222441082718;6064.393560643988;6065.423784740443;6071.058985857199;6108.847278817976;4608.216603177468;4614.077184563101;4615.100055489147;4615.653825963066;4637.675362724644;3984.3425834737523;4024.5774193709826;4059.2693315203546;4074.7758873262255;4098;5695.658260504383;5715.257016587901;5718.1136923776885;5729.7708091676695;5735.11105778605;6011.729472173763;6047.334793172748;6053.8486537836025;6055.455009049207;6078.60489068218;5560.36055853582;5636.070048442043;5656.745446454919;5735.8852822944145;5736.713164341766;5227.712475813791;5228.08508511009;5228.9738551307;5255.868603284872;5257.106291930381;6277.748890044439;6293.465055470245;6293.716782744787;6294.118823364733;6294.937050629526;5889.646621202742;5897.7935772247765;5955.851103722442;6067.362926892789;6079.787207447718;6204.472619827366;6229.4393504584805;6234.501239900706;6247.625142491465;6253.874922501615;5896.823095307148;5913.733881975408;5922.585419020799;5923.170756094237;5947.762089516544;5768.653880767168;5962.791302304398;5965.731542080704;5976.073708575178;6020.548458865515;5905.91141132892;5917.349091600006;5923.644581325134;5926.585139040226;5946.048632218997;5887.735051922588;5889.352171261244;5900.085486749561;5901.616394934315;5904.409559044233;5647.096464565814;5674.943250567607;5706.457886500776;5709.115087161496;5814.04068328721;5832.825015249549;5878.853028674146;5886.823395298148;5891.1457838614015;5897;5723.284589426322;5723.42765723441;5727.31272247333;5734.5125664319;5738.454846789548 17:54:29 INFO - PROCESS | 26546 | |1;ext.html;605.0651743056976;632.7975047984645;643.0771842406148;654.9377809108134;670.3397153803505;33966.660333396656;46046.53953460464;46950;46952.76523617377;47199.528004719985;48344;48561.51438485614;48820;48857;49054.26418603724;8278.130796266396;8940.821183576325;9117.22503587196;9136.497492637902;10699.518521666505;10414;10830.296030757976;10842.295250808711;10848.945755271212;10849.728756781065;10879.347239165636;10965.067969222586;10965.067969222626;10970.067544258707;10970.232083754101;8422.11567785383;8665.090165532654;10732.356058636507;10774.946125269324;11044.889551104467;10564.630237941636;10960.451977401177;10984.06635435981;10988.670339889815;11006.119510439226;45336.3199552007;46062.769686151354;46114.308285375744;46117.30824037642;46167;3532.3994920863515;3591.712662986955;3624.1302087499075;3731.2724018816343;3988.9800550997347;35385.82307088474;35809.10477238064;35820.283594327964;35867.4619880702;36102.27795444103;4692.601128904047;4776.641751868624;4800.447948485934;4865.44047434546;4944;396941.01529492455;397949;401287;401298;401591;70656;71116.28883711097;71313.6434317825;71587.2841271591;71632.28367716256;40809;41802.163956721306;74824;74937.6253118731;75084.62457687677;18508;18630.53423664392;18686.906565467085;18692.25230990745;18695.90652046731;13335.599932002055;14071.2964351782;14251.429942802171;14326.856731432761;15047.774283385757;22818.31545053651;22825;22833.31500055001;22935.54128917412;23007.42481437944;8157.55133467665;8171.488274669086;8192.262696357357;8255;8305.626246818907;1075.7041813501194;1094.480121942071;1102.9594751983518;1133.795916734979;1155.7977353963022;33456.33087338288;34251.486227706606;34324.31351372958;34326;34439.82780086083;1147.2886810177743;1171.7305019845312;1174.653477224221;1200.099925056208;1203.296071798008;16654.250558724885;16654.333826646798;16940.57648558796;17014.48956531306;17047.829521704873;155993;156686;156721;157693;159328;64259.67870160619;64957.675211624584;64974;65203.67398163074;65248.67375663092;1316.7629826631298;1415.3913817058558;1444.1190873567116;1458.48223880523;1508.939642414313;32329.191770205933;32969.17577060593;33446.83276583699;34328.14179645529;34861;53959.19061214006;54421;54512.72743636256;54627.453725462234;54631.453685462635;383687;384621;386143;386238;387884;26547.734522655297;28716.856415718623;28763.137105886857;30222.69777302287;30290.69709302967;45948.54051459576;51085.23372149495;51087.48912510827;52627;56097;43821.34267986046;44458.777706111265;44699.55300447084;44875.775621121684;45403;44388;44392.778036109616;44527.33209001932;44807.55192448164;45847;43680.781596091816;43960.780196098814;44535.55464445314;44849.327260090475;45473;37175.81412092922;39767.80116099401;39924.40113398359;39975.40036899507;40387.5822392976;29300.413991720474;29510.96711615083;29701;29772.851135744182;29779.404411912074 17:54:29 INFO - PROCESS | 26546 | |2;jquery.html;433.58159376201957;434.3983582737907;440.73776103218574;441.56064715607965;454.0963482669489;18787;20377.184912603498;20423.795762042355;20938.581228375424;20964.58070838586;18975.515785481137;19669.901650491727;20177.697334539993;20330.186792528282;20372.388828335173;5669.064604340289;5841.415858414167;5899.174115623816;5920.940790592103;5947.078202878561;5734.713264336788;5780.913286300709;5878.470937615613;5901.881962360751;5902.527797776189;5847.181394604759;5848.853778655525;5851.970740146293;5854.531637469014;5872.0898260769645;5784.3058832940105;5837.620554663933;5839.445252700986;5840.532757379399;5841.240638716939;5126.384833819928;5126.6923984561045;5286.709230992333;5292.417834038252;5297.920531192035;23235.419114522272;23304.184353547713;23400.297991060124;23402;23419.297421077394;2437.8293519453646;2441.926742197737;2453.325335532725;2724.6594175728032;3052.725254727063;7318.5974771387555;13483.932580337134;14783.852161478355;14912.850871491255;15261.092363454569;2004.228372076761;2019.636465436221;2028.8884111373868;2071.6271071207175;2078.8752674839557;79220.60389698073;82444.58777706133;83652;84349.57825210835;85469;10606.56811330476;10789.406582637874;11379.334472866085;11398.715032124263;11458.770824583462;15328.773698104125;15439.22803859825;15513.534593962198;15527.611809704847;15612.3755049799;8470.32237421017;8790.516521591373;8853.911460885438;8952.910470895207;8970.82058358829;8670.826583468295;8681.479111253346;8717.476951382938;8798.38411311202;8829.823403532022;6881.7956857549725;7017.403520700797;7042;7081.398081163055;7095.325944035309;1786.3900559884466;2003.9799602003793;2062.7937206279253;2069.4929742213253;2097.2659569150674;943.9292053095908;1115.966521004371;1161.5469966712988;1202.5310129049678;1218.4029825385496;20428.18287268522;20527.58944821095;20539.794602054088;20666.586668266853;20760.377188684364;1067.1484973570848;1073.7476692977143;1080.1412876762836;1099.9230053896151;1123.4944275076248;10323.225758068174;10836.241463097507;11678.88321116778;11706.414679266003;11964.88035119655;478052;479771;483010;488814;490699;97716.51141744388;98843;99504.50247748716;99716;100805;1074.2265568790458;1121.1479275750326;1131.8302254661867;1136.5056200552785;1150.1661295560818;18160.909195454467;18241.908790455964;18564.81435185685;18617.255309787455;18728.157232924823;42888;42943.35584966165;43857.34213986857;44079.13485623424;45686.31470527878;55709.44290557205;55830;57243.71378143083;60037.298321576505;62824;9083.727488175366;9357.672481463116;9366.531673416439;9383.155516003593;9540.761480963032;10325.380477171393;13278;13472.191668499921;14092.32489417788;14101.788473172706;11114.833277501006;11662.416879156179;11757.823632645688;11761.411929403666;12013.819792702941;11231.775364492501;11589.768204635691;11851.881481185423;11852.52589896429;11976.16166868311;11465.656030319104;12535.997120230177;12788.296643684687;12927.935360323138;13000.479980800663;7858.803529911798;8322.41743078003;9463.479508627091;9545.809083818423;9560;11541.826872597087;11906.880931190577;11967.880321197024;12397.93801030989;12403.503859845505 17:54:29 INFO - PROCESS | 26546 | |3;mootools.html;1425.636462702012;1571.7799508068872;1603.7674537192108;1773.7162054071343;1912.4836294200575;8544.48733076016;9312.534373281334;9678.854817177738;9685.70942871715;10044.447555384451;9663.178629816457;9818.852717209247;9826.263030272723;9839.163671087948;9840.261980351466;2502.161775805103;2538.7842033427182;2540.326813394452;2545.618157276414;2553.5914253719407;2480.417101981042;2540.771330580247;2553.69355677319;2557.0794513975047;2559.2322303309024;2480.107161421896;2491.0533997081084;2579.1102069785893;2583.6253743207226;2584.6898372195365;2385.534820709971;2411.397150712322;2411.7347091819884;2412.0472413396787;2432.0393444589463;2365.976340236593;2395.6765836612008;2408.0608562660577;2408.987955060231;2460.2619214235838;9311.953440232755;9598.66404675833;9633.277504187214;9686.176674982635;9700.951495242549;5690.260266165414;5776.740046697909;5786.363500014995;5790.623609465413;5797.275340582427;3651.7991510466913;3678.2275722098393;3734.3838266685966;3735.0288924879455;3742.5883152853166;1162.5698491558178;1170.245191851251;1210.7760064388117;1214.908881833866;1227.8096894981293;13796.862031379758;13872.653183670389;13892.23592702401;13912.51306204288;13931.512397066053;4896.11869863428;4964.453910069889;4972.279019542146;4996.475370086161;5044.445111037783;10827.350358978487;10855.837162442569;10863.945680271549;10873.130149588014;10876.564937402574;5796.362400135981;5797.565182611321;5813.767449302065;5816.651000939957;5827.970860145672;4803.519648035239;4809.975950120227;5311.309529761106;5381.838544843661;5438.564914806806;4230.915381692349;4247.4265974093105;4282.678799090081;4321.092570560218;4326.978365108217;1228.8955438787802;1272.6182145356356;1277.9361031948365;1286.1125823182163;1298.4157129291857;821.3593397150232;901.8106197698426;1000.6397696829135;1022.1771473963531;1032.9793404131876;6428.389303016206;6634.966825165843;6683.532152749261;6683.966580167068;6804.489663275274;536.3483367708253;545.359202936548;548.4241546376289;552.95299899509;704.327367364166;4637.582617564435;4704.364910737075;4740.19416699162;4740.881477963078;4747.359106520645;12156.149069565046;12499.687507812378;12601.873981260253;12628.179168354027;12635.494580216871;11822;12405.565805196775;12486.250824950532;12502.562410315595;12522.68693282657;8533.189347012149;8833.514156721314;8857.3799834011;8874.689385871463;8916.598753056129;6471.288158302489;6635.734570617121;6659.900101498384;6692.364225398579;6701.899471508029;11382.94308528452;11411.714707132389;11417.143714221633;11480.94259528697;11535.596254131066;10014.94992525062;11659.067274618179;11676.70808229801;11820.23168494045;11830.467628956545;8421.284190843848;8725.127487251224;8762.29901607857;8970.327225457986;8992.86510702353;9495.43027418357;9552.713418597454;9642.566084526074;9648.083432073941;9653;8643.827123457622;8821.38250322497;8828.382013259266;8880.911190888266;8898.243649289883;8257.298129659046;8335;8421.368397370099;8488.193621605938;8576.228139467477;7809.570473624005;7825.765227043198;7872.01599800025;7907;7920.920790792018;5649.830505084854;5735.11105778605;5747.224124743107;5773.509251713652;5895.557833162444;5741.311042674739;5749.310082790092;5775.018246898121;5795.449432303924;5883.676397797991 17:54:29 INFO - PROCESS | 26546 | |4;prototype.html;352.4061955604806;353.19295409988183;357.57091490211735;359.3567514149672;359.50029459051916;5412.8632987072715;5519.798516860222;5532.557395408363;5542.868279422124;5543.25166102576;5512.125877201751;5532.2531458253125;5533;5540.778368865251;5544.695041772701;3891.630295121959;4132.855350062749;4320.589543993316;4320.697551171419;4329.264025115722;4306.849260275891;4331.112122014979;4332.415123958257;4345.69580129391;4349.782510874444;4105.938410923838;4306.827726890936;4312;4315.633171180453;4317.402561052415;4107.67138628909;4257.489101307863;4288.656907447396;4295.334223195409;4302.784860756965;3818.8472461101524;3827.4832897558754;3829.4447305140598;3838;3841.8847434577006;5308;5328.866778330534;5330.866728331784;5335.346042726728;5345.973270133663;4959.032988567231;4965.230389289666;4970.359781272172;4973.030259099477;4974.452810190876;5514.200440936042;5645.15322701594;5654.208410822488;5656.264685590847;5799.072148456226;4048.655864251542;4169.937450938239;4210.7473551587;4233.174530966463;4243.851465198734;5800.709964501758;5919.1713160157615;5925.2889653241455;5938.970305148489;5988.682489852225;4211.873643790691;4374.759388233614;4376.212281789245;4414.536473670219;4430.468343798765;4422.933655995163;4478;4478.462584489817;4481.215787237221;4488.753118578445;4986.977669577728;5024.814205820479;5031.22016087507;5035.748212589356;5068.695878247317;5661.688607126565;5729.739457319383;5746.166805813134;5763.242211125563;5771.826845194651;1516.9924150379177;1531.5481932829841;1532.4100221414835;1543.637245247366;1550.5658415643638;976.7118699983522;996.5814357969671;998.9051040151174;1010.0000999010927;1019.6940917724653;4964.35463389757;4991.276264941564;4994.8262158392745;5025.723585202776;5039.244113383022;5187.559057480156;5215.478452154754;5309.442508536626;5350.8127215547265;5357.946420535823;4833.742184095466;4893.4617192108835;5018.824341148043;5033.496650334937;5131.358580177478;2806.242314575053;2817.873195706198;2820.3795165063652;2821.1521453448026;2833.164216556121;5430.83707488776;5439.755211015514;5440.646357986719;5448.863778405572;5470.56235501159;5013.548780609763;5312.893742125213;5330.920036199383;5352.902654955803;5371.248025276464;5428.565714742811;5912.970435147797;6020.133758534868;6178.6601736904;6190.071489276645;5911.733971971357;5929.940700592939;5943.197668314722;5962.344142144448;5969.283685957713;5581.7209139543675;5863.73613187399;5865.266841644794;5874.471297583238;5953.553483488842;6124.234470691164;6135.969320153371;6141.7409431065635;6213.285472170577;6233.625982441068;4289.849855255051;4295.7876693503495;4315.525292217791;4324.956750432581;4329.718568293051;5782.942170578409;5947.910781338197;5953.7916172935475;5971.313298970674;6002.33974262822;5737.8565535861935;5804.2744656917885;5807.680577568105;5824.5340372770925;5841.32824725162;5502.504774570308;5810.721641238921;5842.795502157404;5844.883102338014;5854.390042738281;5709.257796486596;5726.742296596746;5730.570207234391;5792.652440853562;5798.971005145116;5774.653520788766;5860.94139058621;5863.970680146572;5878.911816322673;5888.735006924784;5547.667139971614;5686.180422264835;5734.655920644775;5773.3072031356505;5786.218860453785 17:54:29 INFO - PROCESS | 26546 | |5;yui.html;795.8007124500144;807.6446363600015;826.3348004856089;856.1438561438562;862.0732712334241;15974.440894568692;17723.645527089466;17747.556311092212;17796;17844.10779461028;15501.379944802222;15529.53411397657;15558;15562.221888905566;15576.532704018897;711.6157275071455;838.8154605986704;843.493903657805;861.3798065392907;865.965361385547;854.1458541458542;854.6026097864492;857.1685465098844;858.8926384201975;859.1108203009886;890.3722875372879;896.7982204004112;897.4211633496391;897.6409436225497;897.7306807957619;753.107567532473;865.1046167216932;887.9156480134377;889.795347070171;891.2468963725642;663.5454713521253;664.9368310010541;665.2283351312454;665.6605131382981;665.9700313485905;15942.123183224918;16058.116803575798;16073.437429689904;16098.03411795296;16100.19499025044;13593.116447430886;13614.795778063239;13733.176009439465;13871.583852484442;14028.719425611533;12551.227223397764;12799.282171431401;12801.679958001032;13038.21770693752;13078.149920255248;4455.108978204372;4479.820807167709;4510.526394728572;4573.49691533931;4708.670393072486;79593.60203199004;83123.5843820783;83177.16822831755;84013.57993210056;84055;12607.621771346874;12614.598816851345;12639.431225594686;12776.233425994284;12843.422046007765;23668.053277869036;23712.525749484914;23750.168744093873;23757.16849910245;23906.64140037901;8019.879701804478;8192.426530142951;8226;8349.624266908004;9203.723888283363;4792.520747925179;5181.222816577468;5232.372115346183;5291.074062039128;5386.434424385461;3837.769733815924;3998.2203470323007;3998.7200895937003;4001.8799436016966;4001.919961600752;704.6089420371641;705.7988473285192;708.0724251230802;716.9175544812414;721.1886627544013;771.221017016623;788.1409263902374;791.4222617489265;804.4288555125809;821.4783612406046;10217.489125543692;10595.417252051056;10653.201009924287;10669.626563070255;10701.732456688645;669.2671524680565;695.2769120115024;698.7763915547077;753.830388162659;791.6872835230051;5029.5221953914315;5039.4708555601865;5073.974630126826;5182.2485739567555;5264.736763161826;105830;114325;114393.42803286097;121542;122974;64194.35805641884;86449.1355086441;92317;101651;101792;73114.63442682753;74444.25555744482;75190;90389.54805225931;90970.54514727384;10464.769108280376;10745.462726863781;10764.838527421938;10998.230123891251;11033.944830275797;43203;50529.49470505248;51561.7421912888;56329;57912.131318031104;76012.61993689997;78246.6087669558;85367;86011;87291.56354218189;13761;13854.238016909167;14311.35598898073;14469.49356772508;14500.564983050524;16116.194190290204;16246.67506649884;16563.751543726612;16589.668206635557;16678.916605416896;15229.847701523286;15434.536963891102;15530.1458419788;15790.921045395158;15835.604109897346;14986.40054397812;15203;15255.694886102438;15437.305321260346;15511.612209694847;14306.499272525412;14315.928420357832;14567.344469498687;15007.474738384104;15069.698606028038;11995.580154694544;12052.216605920587;12263.93868030654;12511.56209532662;12667.176633518791;11979.34113623759;12202.578890421932;12309.26144431337;12334.383280835742;12581.245125292511 17:54:29 INFO - PROCESS | 26546 | __end_tp_report 17:54:29 INFO - PROCESS | 26546 | __start_cc_report 17:54:29 INFO - PROCESS | 26546 | _x_x_mozilla_cycle_collect,887 17:54:29 INFO - PROCESS | 26546 | __end_cc_report 17:54:29 INFO - PROCESS | 26546 | __startTimestamp1466038469698__endTimestamp 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | ------- Summary: start ------- 17:54:29 INFO - PROCESS | 26546 | Number of tests: 6 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#0] dojo.html Cycles:165 Average:5590.83 Median:5735.89 stddev:625.18 (10.9%) stddev-sans-first:601.37 17:54:29 INFO - PROCESS | 26546 | Values: 3328.2 3342.2 3342.4 3368.2 3393.9 5540.7 5634.8 5660.3 5660.5 5672.6 5596.7 5636.9 5645.5 5645.6 5653.2 5000.5 5067.7 5078.2 5117.6 5146.6 5031.6 5132.6 5177.1 5178.8 5179.0 5082.1 5103.9 5126.8 5133.3 5178.4 5212.7 5226.9 5228.0 5240.7 5272.2 4940.0 5036.6 5083.8 5140.2 5140.3 5477.3 5488.4 5494.3 5495.5 5539.5 6058.2 6071.1 6087.5 6090.3 6092.1 5997.3 6007.6 6015.5 6089.1 6099.2 5683.4 5691.1 5733.0 5733.5 5735.3 5966.2 6129.2 6217.3 6219.7 6220.4 5882.8 5926.6 5926.9 5988.0 6010.9 5972.6 5977.6 6014.0 6018.6 6021.2 5670.9 5925.8 5950.2 5951.4 5952.9 5981.2 6064.4 6065.4 6071.1 6108.8 4608.2 4614.1 4615.1 4615.7 4637.7 3984.3 4024.6 4059.3 4074.8 4098.0 5695.7 5715.3 5718.1 5729.8 5735.1 6011.7 6047.3 6053.8 6055.5 6078.6 5560.4 5636.1 5656.7 5735.9 5736.7 5227.7 5228.1 5229.0 5255.9 5257.1 6277.7 6293.5 6293.7 6294.1 6294.9 5889.6 5897.8 5955.9 6067.4 6079.8 6204.5 6229.4 6234.5 6247.6 6253.9 5896.8 5913.7 5922.6 5923.2 5947.8 5768.7 5962.8 5965.7 5976.1 6020.5 5905.9 5917.3 5923.6 5926.6 5946.0 5887.7 5889.4 5900.1 5901.6 5904.4 5647.1 5674.9 5706.5 5709.1 5814.0 5832.8 5878.9 5886.8 5891.1 5897.0 5723.3 5723.4 5727.3 5734.5 5738.5 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#1] ext.html Cycles:180 Average:51836.42 Median:384154.00 stddev:87947.69 (22.9%) stddev-sans-first:88110.29 17:54:29 INFO - PROCESS | 26546 | Values: 605.1 632.8 643.1 654.9 670.3 33966.7 46046.5 46950.0 46952.8 47199.5 48344.0 48561.5 48820.0 48857.0 49054.3 8278.1 8940.8 9117.2 9136.5 10699.5 10414.0 10830.3 10842.3 10848.9 10849.7 10879.3 10965.1 10965.1 10970.1 10970.2 8422.1 8665.1 10732.4 10774.9 11044.9 10564.6 10960.5 10984.1 10988.7 11006.1 45336.3 46062.8 46114.3 46117.3 46167.0 3532.4 3591.7 3624.1 3731.3 3989.0 35385.8 35809.1 35820.3 35867.5 36102.3 4692.6 4776.6 4800.4 4865.4 4944.0 396941.0 397949.0 401287.0 401298.0 401591.0 70656.0 71116.3 71313.6 71587.3 71632.3 40809.0 41802.2 74824.0 74937.6 75084.6 18508.0 18630.5 18686.9 18692.3 18695.9 13335.6 14071.3 14251.4 14326.9 15047.8 22818.3 22825.0 22833.3 22935.5 23007.4 8157.6 8171.5 8192.3 8255.0 8305.6 1075.7 1094.5 1103.0 1133.8 1155.8 33456.3 34251.5 34324.3 34326.0 34439.8 1147.3 1171.7 1174.7 1200.1 1203.3 16654.3 16654.3 16940.6 17014.5 17047.8 155993.0 156686.0 156721.0 157693.0 159328.0 64259.7 64957.7 64974.0 65203.7 65248.7 1316.8 1415.4 1444.1 1458.5 1508.9 32329.2 32969.2 33446.8 34328.1 34861.0 53959.2 54421.0 54512.7 54627.5 54631.5 383687.0 384621.0 386143.0 386238.0 387884.0 26547.7 28716.9 28763.1 30222.7 30290.7 45948.5 51085.2 51087.5 52627.0 56097.0 43821.3 44458.8 44699.6 44875.8 45403.0 44388.0 44392.8 44527.3 44807.6 45847.0 43680.8 43960.8 44535.6 44849.3 45473.0 37175.8 39767.8 39924.4 39975.4 40387.6 29300.4 29511.0 29701.0 29772.9 29779.4 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#2] jquery.html Cycles:180 Average:29589.56 Median:23352.24 stddev:79983.15 (342.5%) stddev-sans-first:80177.57 17:54:29 INFO - PROCESS | 26546 | Values: 433.6 434.4 440.7 441.6 454.1 18787.0 20377.2 20423.8 20938.6 20964.6 18975.5 19669.9 20177.7 20330.2 20372.4 5669.1 5841.4 5899.2 5920.9 5947.1 5734.7 5780.9 5878.5 5901.9 5902.5 5847.2 5848.9 5852.0 5854.5 5872.1 5784.3 5837.6 5839.4 5840.5 5841.2 5126.4 5126.7 5286.7 5292.4 5297.9 23235.4 23304.2 23400.3 23402.0 23419.3 2437.8 2441.9 2453.3 2724.7 3052.7 7318.6 13483.9 14783.9 14912.9 15261.1 2004.2 2019.6 2028.9 2071.6 2078.9 79220.6 82444.6 83652.0 84349.6 85469.0 10606.6 10789.4 11379.3 11398.7 11458.8 15328.8 15439.2 15513.5 15527.6 15612.4 8470.3 8790.5 8853.9 8952.9 8970.8 8670.8 8681.5 8717.5 8798.4 8829.8 6881.8 7017.4 7042.0 7081.4 7095.3 1786.4 2004.0 2062.8 2069.5 2097.3 943.9 1116.0 1161.5 1202.5 1218.4 20428.2 20527.6 20539.8 20666.6 20760.4 1067.1 1073.7 1080.1 1099.9 1123.5 10323.2 10836.2 11678.9 11706.4 11964.9 478052.0 479771.0 483010.0 488814.0 490699.0 97716.5 98843.0 99504.5 99716.0 100805.0 1074.2 1121.1 1131.8 1136.5 1150.2 18160.9 18241.9 18564.8 18617.3 18728.2 42888.0 42943.4 43857.3 44079.1 45686.3 55709.4 55830.0 57243.7 60037.3 62824.0 9083.7 9357.7 9366.5 9383.2 9540.8 10325.4 13278.0 13472.2 14092.3 14101.8 11114.8 11662.4 11757.8 11761.4 12013.8 11231.8 11589.8 11851.9 11852.5 11976.2 11465.7 12536.0 12788.3 12927.9 13000.5 7858.8 8322.4 9463.5 9545.8 9560.0 11541.8 11906.9 11967.9 12397.9 12403.5 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#3] mootools.html Cycles:180 Average:6413.36 Median:4853.05 stddev:3739.24 (77.0%) stddev-sans-first:3730.95 17:54:29 INFO - PROCESS | 26546 | Values: 1425.6 1571.8 1603.8 1773.7 1912.5 8544.5 9312.5 9678.9 9685.7 10044.4 9663.2 9818.9 9826.3 9839.2 9840.3 2502.2 2538.8 2540.3 2545.6 2553.6 2480.4 2540.8 2553.7 2557.1 2559.2 2480.1 2491.1 2579.1 2583.6 2584.7 2385.5 2411.4 2411.7 2412.0 2432.0 2366.0 2395.7 2408.1 2409.0 2460.3 9312.0 9598.7 9633.3 9686.2 9701.0 5690.3 5776.7 5786.4 5790.6 5797.3 3651.8 3678.2 3734.4 3735.0 3742.6 1162.6 1170.2 1210.8 1214.9 1227.8 13796.9 13872.7 13892.2 13912.5 13931.5 4896.1 4964.5 4972.3 4996.5 5044.4 10827.4 10855.8 10863.9 10873.1 10876.6 5796.4 5797.6 5813.8 5816.7 5828.0 4803.5 4810.0 5311.3 5381.8 5438.6 4230.9 4247.4 4282.7 4321.1 4327.0 1228.9 1272.6 1277.9 1286.1 1298.4 821.4 901.8 1000.6 1022.2 1033.0 6428.4 6635.0 6683.5 6684.0 6804.5 536.3 545.4 548.4 553.0 704.3 4637.6 4704.4 4740.2 4740.9 4747.4 12156.1 12499.7 12601.9 12628.2 12635.5 11822.0 12405.6 12486.3 12502.6 12522.7 8533.2 8833.5 8857.4 8874.7 8916.6 6471.3 6635.7 6659.9 6692.4 6701.9 11382.9 11411.7 11417.1 11480.9 11535.6 10014.9 11659.1 11676.7 11820.2 11830.5 8421.3 8725.1 8762.3 8970.3 8992.9 9495.4 9552.7 9642.6 9648.1 9653.0 8643.8 8821.4 8828.4 8880.9 8898.2 8257.3 8335.0 8421.4 8488.2 8576.2 7809.6 7825.8 7872.0 7907.0 7920.9 5649.8 5735.1 5747.2 5773.5 5895.6 5741.3 5749.3 5775.0 5795.4 5883.7 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#4] prototype.html Cycles:180 Average:4785.82 Median:5333.13 stddev:1386.65 (26.0%) stddev-sans-first:1350.02 17:54:29 INFO - PROCESS | 26546 | Values: 352.4 353.2 357.6 359.4 359.5 5412.9 5519.8 5532.6 5542.9 5543.3 5512.1 5532.3 5533.0 5540.8 5544.7 3891.6 4132.9 4320.6 4320.7 4329.3 4306.8 4331.1 4332.4 4345.7 4349.8 4105.9 4306.8 4312.0 4315.6 4317.4 4107.7 4257.5 4288.7 4295.3 4302.8 3818.8 3827.5 3829.4 3838.0 3841.9 5308.0 5328.9 5330.9 5335.3 5346.0 4959.0 4965.2 4970.4 4973.0 4974.5 5514.2 5645.2 5654.2 5656.3 5799.1 4048.7 4169.9 4210.7 4233.2 4243.9 5800.7 5919.2 5925.3 5939.0 5988.7 4211.9 4374.8 4376.2 4414.5 4430.5 4422.9 4478.0 4478.5 4481.2 4488.8 4987.0 5024.8 5031.2 5035.7 5068.7 5661.7 5729.7 5746.2 5763.2 5771.8 1517.0 1531.5 1532.4 1543.6 1550.6 976.7 996.6 998.9 1010.0 1019.7 4964.4 4991.3 4994.8 5025.7 5039.2 5187.6 5215.5 5309.4 5350.8 5357.9 4833.7 4893.5 5018.8 5033.5 5131.4 2806.2 2817.9 2820.4 2821.2 2833.2 5430.8 5439.8 5440.6 5448.9 5470.6 5013.5 5312.9 5330.9 5352.9 5371.2 5428.6 5913.0 6020.1 6178.7 6190.1 5911.7 5929.9 5943.2 5962.3 5969.3 5581.7 5863.7 5865.3 5874.5 5953.6 6124.2 6136.0 6141.7 6213.3 6233.6 4289.8 4295.8 4315.5 4325.0 4329.7 5782.9 5947.9 5953.8 5971.3 6002.3 5737.9 5804.3 5807.7 5824.5 5841.3 5502.5 5810.7 5842.8 5844.9 5854.4 5709.3 5726.7 5730.6 5792.7 5799.0 5774.7 5860.9 5864.0 5878.9 5888.7 5547.7 5686.2 5734.7 5773.3 5786.2 17:54:29 INFO - PROCESS | 26546 | 17:54:29 INFO - PROCESS | 26546 | [#5] yui.html Cycles:180 Average:21436.72 Median:4001.90 stddev:29817.23 (745.1%) stddev-sans-first:29860.59 17:54:29 INFO - PROCESS | 26546 | Values: 795.8 807.6 826.3 856.1 862.1 15974.4 17723.6 17747.6 17796.0 17844.1 15501.4 15529.5 15558.0 15562.2 15576.5 711.6 838.8 843.5 861.4 866.0 854.1 854.6 857.2 858.9 859.1 890.4 896.8 897.4 897.6 897.7 753.1 865.1 887.9 889.8 891.2 663.5 664.9 665.2 665.7 666.0 15942.1 16058.1 16073.4 16098.0 16100.2 13593.1 13614.8 13733.2 13871.6 14028.7 12551.2 12799.3 12801.7 13038.2 13078.1 4455.1 4479.8 4510.5 4573.5 4708.7 79593.6 83123.6 83177.2 84013.6 84055.0 12607.6 12614.6 12639.4 12776.2 12843.4 23668.1 23712.5 23750.2 23757.2 23906.6 8019.9 8192.4 8226.0 8349.6 9203.7 4792.5 5181.2 5232.4 5291.1 5386.4 3837.8 3998.2 3998.7 4001.9 4001.9 704.6 705.8 708.1 716.9 721.2 771.2 788.1 791.4 804.4 821.5 10217.5 10595.4 10653.2 10669.6 10701.7 669.3 695.3 698.8 753.8 791.7 5029.5 5039.5 5074.0 5182.2 5264.7 105830.0 114325.0 114393.4 121542.0 122974.0 64194.4 86449.1 92317.0 101651.0 101792.0 73114.6 74444.3 75190.0 90389.5 90970.5 10464.8 10745.5 10764.8 10998.2 11033.9 43203.0 50529.5 51561.7 56329.0 57912.1 76012.6 78246.6 85367.0 86011.0 87291.6 13761.0 13854.2 14311.4 14469.5 14500.6 16116.2 16246.7 16563.8 16589.7 16678.9 15229.8 15434.5 15530.1 15790.9 15835.6 14986.4 15203.0 15255.7 15437.3 15511.6 14306.5 14315.9 14567.3 15007.5 15069.7 11995.6 12052.2 12263.9 12511.6 12667.2 11979.3 12202.6 12309.3 12334.4 12581.2 17:54:29 INFO - PROCESS | 26546 | -------- Summary: end -------- 17:54:29 INFO - PROCESS | 26546 | 17:54:30 INFO - TEST-INFO | 26546: exit 0 17:54:30 INFO - TEST-OK | dromaeo_css | took 1117441ms 17:54:30 INFO - TEST-START | kraken 17:54:30 INFO - operating with platform_type : linux_ 17:54:30 INFO - Initialising browser for kraken test... 17:54:30 INFO - TEST-INFO | started process 26746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9P2_f_/profile http://localhost:56113/getInfo.html) 17:54:36 INFO - PROCESS | 26746 | __metrics Screen width/height:1600/1200 17:54:36 INFO - PROCESS | 26746 | colorDepth:24 17:54:36 INFO - PROCESS | 26746 | Browser inner width/height: 1024/697 17:54:36 INFO - PROCESS | 26746 | __metrics 17:54:38 ERROR - PROCESS | 26746 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:54:38 INFO - PROCESS | 26746 | console.error: PushService: 17:54:38 INFO - PROCESS | 26746 | stateChangeProcessEnqueue: Error transitioning state 17:54:38 INFO - PROCESS | 26746 | UnknownError 17:54:39 INFO - TEST-INFO | 26746: exit 0 17:54:39 INFO - Browser initialized. 17:54:39 INFO - Running cycle 1/1 for kraken test... 17:54:39 INFO - TEST-INFO | started process 26835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9P2_f_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:51 INFO - PROCESS | 26835 | RSS: Main: 149630976 17:54:51 INFO - PROCESS | 26835 | 17:54:53 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56113/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:54 INFO - PROCESS | 26835 | RSS: Main: 198594560 17:54:54 INFO - PROCESS | 26835 | 17:54:57 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56113/tests/kraken/driver.html?testName=audio-dft) 17:54:57 INFO - PROCESS | 26835 | RSS: Main: 196898816 17:54:57 INFO - PROCESS | 26835 | 17:55:00 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56113/tests/kraken/driver.html?testName=audio-fft) 17:55:01 INFO - PROCESS | 26835 | RSS: Main: 282619904 17:55:01 INFO - PROCESS | 26835 | 17:55:03 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56113/tests/kraken/driver.html?testName=audio-oscillator) 17:55:03 INFO - PROCESS | 26835 | RSS: Main: 191180800 17:55:03 INFO - PROCESS | 26835 | 17:55:05 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56113/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:55:06 INFO - PROCESS | 26835 | RSS: Main: 192532480 17:55:06 INFO - PROCESS | 26835 | 17:55:09 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56113/tests/kraken/driver.html?testName=imaging-darkroom) 17:55:10 INFO - PROCESS | 26835 | RSS: Main: 226504704 17:55:10 INFO - PROCESS | 26835 | 17:55:13 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56113/tests/kraken/driver.html?testName=imaging-desaturate) 17:55:14 INFO - PROCESS | 26835 | RSS: Main: 211046400 17:55:14 INFO - PROCESS | 26835 | 17:55:16 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56113/tests/kraken/driver.html?testName=json-parse-financial) 17:55:17 INFO - PROCESS | 26835 | RSS: Main: 213823488 17:55:17 INFO - PROCESS | 26835 | 17:55:19 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56113/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:55:19 INFO - PROCESS | 26835 | RSS: Main: 202014720 17:55:19 INFO - PROCESS | 26835 | 17:55:21 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:55:21 INFO - PROCESS | 26835 | RSS: Main: 205213696 17:55:21 INFO - PROCESS | 26835 | 17:55:23 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:24 INFO - PROCESS | 26835 | RSS: Main: 209514496 17:55:24 INFO - PROCESS | 26835 | 17:55:27 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:27 INFO - PROCESS | 26835 | RSS: Main: 214245376 17:55:27 INFO - PROCESS | 26835 | 17:55:30 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:30 INFO - PROCESS | 26835 | RSS: Main: 212946944 17:55:30 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | Cycle 1(1): loaded http://localhost:56113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56113/tests/kraken/driver.html?testName=ai-astar) 17:55:32 INFO - PROCESS | 26835 | RSS: Main: 255586304 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | __start_tp_report 17:55:32 INFO - PROCESS | 26835 | _x_x_mozilla_page_load 17:55:32 INFO - PROCESS | 26835 | _x_x_mozilla_page_load_details 17:55:32 INFO - PROCESS | 26835 | |i|pagename|runs| 17:55:32 INFO - PROCESS | 26835 | |0;ai-astar;112;102;110;109;111;110;109;112;109;111 17:55:32 INFO - PROCESS | 26835 | |1;audio-beat-detection;162;125;122;181;124;126;153;129;156;126 17:55:32 INFO - PROCESS | 26835 | |2;audio-dft;160;162;161;161;161;161;160;159;160;160 17:55:32 INFO - PROCESS | 26835 | |3;audio-fft;74;74;76;114;75;76;75;76;106;75 17:55:32 INFO - PROCESS | 26835 | |4;audio-oscillator;84;85;114;86;86;84;116;83;84;132 17:55:32 INFO - PROCESS | 26835 | |5;imaging-gaussian-blur;117;118;117;117;116;116;118;119;117;117 17:55:32 INFO - PROCESS | 26835 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 17:55:32 INFO - PROCESS | 26835 | |7;imaging-desaturate;95;94;95;95;95;96;95;95;94;95 17:55:32 INFO - PROCESS | 26835 | |8;json-parse-financial;51;51;51;50;54;51;53;51;50;51 17:55:32 INFO - PROCESS | 26835 | |9;json-stringify-tinderbox;60;61;60;60;61;61;61;60;60;60 17:55:32 INFO - PROCESS | 26835 | |10;stanford-crypto-aes;77;76;76;76;77;82;83;82;104;77 17:55:32 INFO - PROCESS | 26835 | |11;stanford-crypto-ccm;124;117;116;123;117;117;124;122;123;126 17:55:32 INFO - PROCESS | 26835 | |12;stanford-crypto-pbkdf2;155;154;154;153;154;158;155;157;152;153 17:55:32 INFO - PROCESS | 26835 | |13;stanford-crypto-sha256-iterative;67;62;62;61;61;63;63;63;60;61 17:55:32 INFO - PROCESS | 26835 | __end_tp_report 17:55:32 INFO - PROCESS | 26835 | __start_cc_report 17:55:32 INFO - PROCESS | 26835 | _x_x_mozilla_cycle_collect,1549 17:55:32 INFO - PROCESS | 26835 | __end_cc_report 17:55:32 INFO - PROCESS | 26835 | __startTimestamp1466038532867__endTimestamp 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | ------- Summary: start ------- 17:55:32 INFO - PROCESS | 26835 | Number of tests: 14 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:2.91 17:55:32 INFO - PROCESS | 26835 | Values: 112.0 102.0 110.0 109.0 111.0 110.0 109.0 112.0 109.0 111.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:141.00 stddev:20.83 (14.8%) stddev-sans-first:20.58 17:55:32 INFO - PROCESS | 26835 | Values: 162.0 125.0 122.0 181.0 124.0 126.0 153.0 129.0 156.0 126.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 17:55:32 INFO - PROCESS | 26835 | Values: 160.0 162.0 161.0 161.0 161.0 161.0 160.0 159.0 160.0 160.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.84 (19.8%) stddev-sans-first:15.45 17:55:32 INFO - PROCESS | 26835 | Values: 74.0 74.0 76.0 114.0 75.0 76.0 75.0 76.0 106.0 75.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.07 (21.5%) stddev-sans-first:18.69 17:55:32 INFO - PROCESS | 26835 | Values: 84.0 85.0 114.0 86.0 86.0 84.0 116.0 83.0 84.0 132.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:55:32 INFO - PROCESS | 26835 | Values: 117.0 118.0 117.0 117.0 116.0 116.0 118.0 119.0 117.0 117.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:55:32 INFO - PROCESS | 26835 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:55:32 INFO - PROCESS | 26835 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.25 (2.5%) stddev-sans-first:1.32 17:55:32 INFO - PROCESS | 26835 | Values: 51.0 51.0 51.0 50.0 54.0 51.0 53.0 51.0 50.0 51.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 17:55:32 INFO - PROCESS | 26835 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 61.0 60.0 60.0 60.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:77.00 stddev:8.55 (11.1%) stddev-sans-first:8.95 17:55:32 INFO - PROCESS | 26835 | Values: 77.0 76.0 76.0 76.0 77.0 82.0 83.0 82.0 104.0 77.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:123.00 stddev:3.73 (3.0%) stddev-sans-first:3.78 17:55:32 INFO - PROCESS | 26835 | Values: 124.0 117.0 116.0 123.0 117.0 117.0 124.0 122.0 123.0 126.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.50 stddev:1.84 (1.2%) stddev-sans-first:1.94 17:55:32 INFO - PROCESS | 26835 | Values: 155.0 154.0 154.0 153.0 154.0 158.0 155.0 157.0 152.0 153.0 17:55:32 INFO - PROCESS | 26835 | 17:55:32 INFO - PROCESS | 26835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.95 (3.1%) stddev-sans-first:1.09 17:55:32 INFO - PROCESS | 26835 | Values: 67.0 62.0 62.0 61.0 61.0 63.0 63.0 63.0 60.0 61.0 17:55:32 INFO - PROCESS | 26835 | -------- Summary: end -------- 17:55:32 INFO - PROCESS | 26835 | 17:55:33 INFO - TEST-INFO | 26835: exit 0 17:55:33 INFO - TEST-OK | kraken | took 63428ms 17:55:33 INFO - SUITE-END | took 1180s 17:55:34 INFO - Completed test suite (00:19:40) 17:55:34 INFO - javascript benchmark 17:55:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.2345060636053, 3342.1644588852787, 3342.4484959981605, 3368.2253081791205, 3393.8981830545076, 5540.667559946401, 5634.830955071344, 5660.264165658458, 5660.518855897254, 5672.574556908233, 5596.692181929992, 5636.915446268299, 5645.491905728483, 5645.633033852797, 5653.180288858123, 5000.499950005007, 5067.695938243699, 5078.187490001591, 5117.641765076446, 5146.588272938175, 5031.572316353115, 5132.640715149941, 5177.119889618773, 5178.844634660947, 5179.015986962484, 5082.0598189334905, 5103.897922041557, 5126.820561280356, 5133.255677926699, 5178.40448348441, 5212.661177023481, 5226.869328266805, 5228.0, 5240.68555886648, 5272.209168624699, 4940.036692844897, 5036.5718913892, 5083.79664813407, 5140.1518749406305, 5140.254663073833, 5477.287952566181, 5488.4237155098535, 5494.340679118532, 5495.477929596682, 5539.473749993744, 6058.182145410357, 6071.119687645267, 6087.4825639820665, 6090.299615544181, 6092.116643086772, 5997.250343707036, 6007.579469437142, 6015.488683461911, 6089.117078023662, 6099.230750080917, 5683.403242659544, 5691.089425691911, 5732.971335143339, 5733.483986441157, 5735.283089613798, 5966.224390829165, 6129.186698318328, 6217.285012223652, 6219.689015549205, 6220.377962203744, 5882.764689412375, 5926.555508336892, 5926.940730592725, 5988.041913293852, 6010.909836352458, 5972.552058595623, 5977.611455255482, 6014.0377539593455, 6018.638881667114, 6021.187139736079, 5670.858228544319, 5925.792597259076, 5950.196723442366, 5951.3751056139345, 5952.85117872048, 5981.222441082718, 6064.393560643988, 6065.423784740443, 6071.058985857199, 6108.847278817976, 4608.216603177468, 4614.077184563101, 4615.100055489147, 4615.653825963066, 4637.675362724644, 3984.3425834737523, 4024.5774193709826, 4059.2693315203546, 4074.7758873262255, 4098.0, 5695.658260504383, 5715.257016587901, 5718.1136923776885, 5729.7708091676695, 5735.11105778605, 6011.729472173763, 6047.334793172748, 6053.8486537836025, 6055.455009049207, 6078.60489068218, 5560.36055853582, 5636.070048442043, 5656.745446454919, 5735.8852822944145, 5736.713164341766, 5227.712475813791, 5228.08508511009, 5228.9738551307, 5255.868603284872, 5257.106291930381, 6277.748890044439, 6293.465055470245, 6293.716782744787, 6294.118823364733, 6294.937050629526, 5889.646621202742, 5897.7935772247765, 5955.851103722442, 6067.362926892789, 6079.787207447718, 6204.472619827366, 6229.4393504584805, 6234.501239900706, 6247.625142491465, 6253.874922501615, 5896.823095307148, 5913.733881975408, 5922.585419020799, 5923.170756094237, 5947.762089516544, 5768.653880767168, 5962.791302304398, 5965.731542080704, 5976.073708575178, 6020.548458865515, 5905.91141132892, 5917.349091600006, 5923.644581325134, 5926.585139040226, 5946.048632218997, 5887.735051922588, 5889.352171261244, 5900.085486749561, 5901.616394934315, 5904.409559044233, 5647.096464565814, 5674.943250567607, 5706.457886500776, 5709.115087161496, 5814.04068328721, 5832.825015249549, 5878.853028674146, 5886.823395298148, 5891.1457838614015, 5897.0, 5723.284589426322, 5723.42765723441, 5727.31272247333, 5734.5125664319, 5738.454846789548], "value": 5549.6576748668895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.0651743056976, 632.7975047984645, 643.0771842406148, 654.9377809108134, 670.3397153803505, 33966.660333396656, 46046.53953460464, 46950.0, 46952.76523617377, 47199.528004719985, 48344.0, 48561.51438485614, 48820.0, 48857.0, 49054.26418603724, 8278.130796266396, 8940.821183576325, 9117.22503587196, 9136.497492637902, 10699.518521666505, 10414.0, 10830.296030757976, 10842.295250808711, 10848.945755271212, 10849.728756781065, 10879.347239165636, 10965.067969222586, 10965.067969222626, 10970.067544258707, 10970.232083754101, 8422.11567785383, 8665.090165532654, 10732.356058636507, 10774.946125269324, 11044.889551104467, 10564.630237941636, 10960.451977401177, 10984.06635435981, 10988.670339889815, 11006.119510439226, 45336.3199552007, 46062.769686151354, 46114.308285375744, 46117.30824037642, 46167.0, 3532.3994920863515, 3591.712662986955, 3624.1302087499075, 3731.2724018816343, 3988.9800550997347, 35385.82307088474, 35809.10477238064, 35820.283594327964, 35867.4619880702, 36102.27795444103, 4692.601128904047, 4776.641751868624, 4800.447948485934, 4865.44047434546, 4944.0, 396941.01529492455, 397949.0, 401287.0, 401298.0, 401591.0, 70656.0, 71116.28883711097, 71313.6434317825, 71587.2841271591, 71632.28367716256, 40809.0, 41802.163956721306, 74824.0, 74937.6253118731, 75084.62457687677, 18508.0, 18630.53423664392, 18686.906565467085, 18692.25230990745, 18695.90652046731, 13335.599932002055, 14071.2964351782, 14251.429942802171, 14326.856731432761, 15047.774283385757, 22818.31545053651, 22825.0, 22833.31500055001, 22935.54128917412, 23007.42481437944, 8157.55133467665, 8171.488274669086, 8192.262696357357, 8255.0, 8305.626246818907, 1075.7041813501194, 1094.480121942071, 1102.9594751983518, 1133.795916734979, 1155.7977353963022, 33456.33087338288, 34251.486227706606, 34324.31351372958, 34326.0, 34439.82780086083, 1147.2886810177743, 1171.7305019845312, 1174.653477224221, 1200.099925056208, 1203.296071798008, 16654.250558724885, 16654.333826646798, 16940.57648558796, 17014.48956531306, 17047.829521704873, 155993.0, 156686.0, 156721.0, 157693.0, 159328.0, 64259.67870160619, 64957.675211624584, 64974.0, 65203.67398163074, 65248.67375663092, 1316.7629826631298, 1415.3913817058558, 1444.1190873567116, 1458.48223880523, 1508.939642414313, 32329.191770205933, 32969.17577060593, 33446.83276583699, 34328.14179645529, 34861.0, 53959.19061214006, 54421.0, 54512.72743636256, 54627.453725462234, 54631.453685462635, 383687.0, 384621.0, 386143.0, 386238.0, 387884.0, 26547.734522655297, 28716.856415718623, 28763.137105886857, 30222.69777302287, 30290.69709302967, 45948.54051459576, 51085.23372149495, 51087.48912510827, 52627.0, 56097.0, 43821.34267986046, 44458.777706111265, 44699.55300447084, 44875.775621121684, 45403.0, 44388.0, 44392.778036109616, 44527.33209001932, 44807.55192448164, 45847.0, 43680.781596091816, 43960.780196098814, 44535.55464445314, 44849.327260090475, 45473.0, 37175.81412092922, 39767.80116099401, 39924.40113398359, 39975.40036899507, 40387.5822392976, 29300.413991720474, 29510.96711615083, 29701.0, 29772.851135744182, 29779.404411912074], "value": 21134.19960112094, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.58159376201957, 434.3983582737907, 440.73776103218574, 441.56064715607965, 454.0963482669489, 18787.0, 20377.184912603498, 20423.795762042355, 20938.581228375424, 20964.58070838586, 18975.515785481137, 19669.901650491727, 20177.697334539993, 20330.186792528282, 20372.388828335173, 5669.064604340289, 5841.415858414167, 5899.174115623816, 5920.940790592103, 5947.078202878561, 5734.713264336788, 5780.913286300709, 5878.470937615613, 5901.881962360751, 5902.527797776189, 5847.181394604759, 5848.853778655525, 5851.970740146293, 5854.531637469014, 5872.0898260769645, 5784.3058832940105, 5837.620554663933, 5839.445252700986, 5840.532757379399, 5841.240638716939, 5126.384833819928, 5126.6923984561045, 5286.709230992333, 5292.417834038252, 5297.920531192035, 23235.419114522272, 23304.184353547713, 23400.297991060124, 23402.0, 23419.297421077394, 2437.8293519453646, 2441.926742197737, 2453.325335532725, 2724.6594175728032, 3052.725254727063, 7318.5974771387555, 13483.932580337134, 14783.852161478355, 14912.850871491255, 15261.092363454569, 2004.228372076761, 2019.636465436221, 2028.8884111373868, 2071.6271071207175, 2078.8752674839557, 79220.60389698073, 82444.58777706133, 83652.0, 84349.57825210835, 85469.0, 10606.56811330476, 10789.406582637874, 11379.334472866085, 11398.715032124263, 11458.770824583462, 15328.773698104125, 15439.22803859825, 15513.534593962198, 15527.611809704847, 15612.3755049799, 8470.32237421017, 8790.516521591373, 8853.911460885438, 8952.910470895207, 8970.82058358829, 8670.826583468295, 8681.479111253346, 8717.476951382938, 8798.38411311202, 8829.823403532022, 6881.7956857549725, 7017.403520700797, 7042.0, 7081.398081163055, 7095.325944035309, 1786.3900559884466, 2003.9799602003793, 2062.7937206279253, 2069.4929742213253, 2097.2659569150674, 943.9292053095908, 1115.966521004371, 1161.5469966712988, 1202.5310129049678, 1218.4029825385496, 20428.18287268522, 20527.58944821095, 20539.794602054088, 20666.586668266853, 20760.377188684364, 1067.1484973570848, 1073.7476692977143, 1080.1412876762836, 1099.9230053896151, 1123.4944275076248, 10323.225758068174, 10836.241463097507, 11678.88321116778, 11706.414679266003, 11964.88035119655, 478052.0, 479771.0, 483010.0, 488814.0, 490699.0, 97716.51141744388, 98843.0, 99504.50247748716, 99716.0, 100805.0, 1074.2265568790458, 1121.1479275750326, 1131.8302254661867, 1136.5056200552785, 1150.1661295560818, 18160.909195454467, 18241.908790455964, 18564.81435185685, 18617.255309787455, 18728.157232924823, 42888.0, 42943.35584966165, 43857.34213986857, 44079.13485623424, 45686.31470527878, 55709.44290557205, 55830.0, 57243.71378143083, 60037.298321576505, 62824.0, 9083.727488175366, 9357.672481463116, 9366.531673416439, 9383.155516003593, 9540.761480963032, 10325.380477171393, 13278.0, 13472.191668499921, 14092.32489417788, 14101.788473172706, 11114.833277501006, 11662.416879156179, 11757.823632645688, 11761.411929403666, 12013.819792702941, 11231.775364492501, 11589.768204635691, 11851.881481185423, 11852.52589896429, 11976.16166868311, 11465.656030319104, 12535.997120230177, 12788.296643684687, 12927.935360323138, 13000.479980800663, 7858.803529911798, 8322.41743078003, 9463.479508627091, 9545.809083818423, 9560.0, 11541.826872597087, 11906.880931190577, 11967.880321197024, 12397.93801030989, 12403.503859845505], "value": 9784.585284731225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.636462702012, 1571.7799508068872, 1603.7674537192108, 1773.7162054071343, 1912.4836294200575, 8544.48733076016, 9312.534373281334, 9678.854817177738, 9685.70942871715, 10044.447555384451, 9663.178629816457, 9818.852717209247, 9826.263030272723, 9839.163671087948, 9840.261980351466, 2502.161775805103, 2538.7842033427182, 2540.326813394452, 2545.618157276414, 2553.5914253719407, 2480.417101981042, 2540.771330580247, 2553.69355677319, 2557.0794513975047, 2559.2322303309024, 2480.107161421896, 2491.0533997081084, 2579.1102069785893, 2583.6253743207226, 2584.6898372195365, 2385.534820709971, 2411.397150712322, 2411.7347091819884, 2412.0472413396787, 2432.0393444589463, 2365.976340236593, 2395.6765836612008, 2408.0608562660577, 2408.987955060231, 2460.2619214235838, 9311.953440232755, 9598.66404675833, 9633.277504187214, 9686.176674982635, 9700.951495242549, 5690.260266165414, 5776.740046697909, 5786.363500014995, 5790.623609465413, 5797.275340582427, 3651.7991510466913, 3678.2275722098393, 3734.3838266685966, 3735.0288924879455, 3742.5883152853166, 1162.5698491558178, 1170.245191851251, 1210.7760064388117, 1214.908881833866, 1227.8096894981293, 13796.862031379758, 13872.653183670389, 13892.23592702401, 13912.51306204288, 13931.512397066053, 4896.11869863428, 4964.453910069889, 4972.279019542146, 4996.475370086161, 5044.445111037783, 10827.350358978487, 10855.837162442569, 10863.945680271549, 10873.130149588014, 10876.564937402574, 5796.362400135981, 5797.565182611321, 5813.767449302065, 5816.651000939957, 5827.970860145672, 4803.519648035239, 4809.975950120227, 5311.309529761106, 5381.838544843661, 5438.564914806806, 4230.915381692349, 4247.4265974093105, 4282.678799090081, 4321.092570560218, 4326.978365108217, 1228.8955438787802, 1272.6182145356356, 1277.9361031948365, 1286.1125823182163, 1298.4157129291857, 821.3593397150232, 901.8106197698426, 1000.6397696829135, 1022.1771473963531, 1032.9793404131876, 6428.389303016206, 6634.966825165843, 6683.532152749261, 6683.966580167068, 6804.489663275274, 536.3483367708253, 545.359202936548, 548.4241546376289, 552.95299899509, 704.327367364166, 4637.582617564435, 4704.364910737075, 4740.19416699162, 4740.881477963078, 4747.359106520645, 12156.149069565046, 12499.687507812378, 12601.873981260253, 12628.179168354027, 12635.494580216871, 11822.0, 12405.565805196775, 12486.250824950532, 12502.562410315595, 12522.68693282657, 8533.189347012149, 8833.514156721314, 8857.3799834011, 8874.689385871463, 8916.598753056129, 6471.288158302489, 6635.734570617121, 6659.900101498384, 6692.364225398579, 6701.899471508029, 11382.94308528452, 11411.714707132389, 11417.143714221633, 11480.94259528697, 11535.596254131066, 10014.94992525062, 11659.067274618179, 11676.70808229801, 11820.23168494045, 11830.467628956545, 8421.284190843848, 8725.127487251224, 8762.29901607857, 8970.327225457986, 8992.86510702353, 9495.43027418357, 9552.713418597454, 9642.566084526074, 9648.083432073941, 9653.0, 8643.827123457622, 8821.38250322497, 8828.382013259266, 8880.911190888266, 8898.243649289883, 8257.298129659046, 8335.0, 8421.368397370099, 8488.193621605938, 8576.228139467477, 7809.570473624005, 7825.765227043198, 7872.01599800025, 7907.0, 7920.920790792018, 5649.830505084854, 5735.11105778605, 5747.224124743107, 5773.509251713652, 5895.557833162444, 5741.311042674739, 5749.310082790092, 5775.018246898121, 5795.449432303924, 5883.676397797991], "value": 5000.9551767154035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.4061955604806, 353.19295409988183, 357.57091490211735, 359.3567514149672, 359.50029459051916, 5412.8632987072715, 5519.798516860222, 5532.557395408363, 5542.868279422124, 5543.25166102576, 5512.125877201751, 5532.2531458253125, 5533.0, 5540.778368865251, 5544.695041772701, 3891.630295121959, 4132.855350062749, 4320.589543993316, 4320.697551171419, 4329.264025115722, 4306.849260275891, 4331.112122014979, 4332.415123958257, 4345.69580129391, 4349.782510874444, 4105.938410923838, 4306.827726890936, 4312.0, 4315.633171180453, 4317.402561052415, 4107.67138628909, 4257.489101307863, 4288.656907447396, 4295.334223195409, 4302.784860756965, 3818.8472461101524, 3827.4832897558754, 3829.4447305140598, 3838.0, 3841.8847434577006, 5308.0, 5328.866778330534, 5330.866728331784, 5335.346042726728, 5345.973270133663, 4959.032988567231, 4965.230389289666, 4970.359781272172, 4973.030259099477, 4974.452810190876, 5514.200440936042, 5645.15322701594, 5654.208410822488, 5656.264685590847, 5799.072148456226, 4048.655864251542, 4169.937450938239, 4210.7473551587, 4233.174530966463, 4243.851465198734, 5800.709964501758, 5919.1713160157615, 5925.2889653241455, 5938.970305148489, 5988.682489852225, 4211.873643790691, 4374.759388233614, 4376.212281789245, 4414.536473670219, 4430.468343798765, 4422.933655995163, 4478.0, 4478.462584489817, 4481.215787237221, 4488.753118578445, 4986.977669577728, 5024.814205820479, 5031.22016087507, 5035.748212589356, 5068.695878247317, 5661.688607126565, 5729.739457319383, 5746.166805813134, 5763.242211125563, 5771.826845194651, 1516.9924150379177, 1531.5481932829841, 1532.4100221414835, 1543.637245247366, 1550.5658415643638, 976.7118699983522, 996.5814357969671, 998.9051040151174, 1010.0000999010927, 1019.6940917724653, 4964.35463389757, 4991.276264941564, 4994.8262158392745, 5025.723585202776, 5039.244113383022, 5187.559057480156, 5215.478452154754, 5309.442508536626, 5350.8127215547265, 5357.946420535823, 4833.742184095466, 4893.4617192108835, 5018.824341148043, 5033.496650334937, 5131.358580177478, 2806.242314575053, 2817.873195706198, 2820.3795165063652, 2821.1521453448026, 2833.164216556121, 5430.83707488776, 5439.755211015514, 5440.646357986719, 5448.863778405572, 5470.56235501159, 5013.548780609763, 5312.893742125213, 5330.920036199383, 5352.902654955803, 5371.248025276464, 5428.565714742811, 5912.970435147797, 6020.133758534868, 6178.6601736904, 6190.071489276645, 5911.733971971357, 5929.940700592939, 5943.197668314722, 5962.344142144448, 5969.283685957713, 5581.7209139543675, 5863.73613187399, 5865.266841644794, 5874.471297583238, 5953.553483488842, 6124.234470691164, 6135.969320153371, 6141.7409431065635, 6213.285472170577, 6233.625982441068, 4289.849855255051, 4295.7876693503495, 4315.525292217791, 4324.956750432581, 4329.718568293051, 5782.942170578409, 5947.910781338197, 5953.7916172935475, 5971.313298970674, 6002.33974262822, 5737.8565535861935, 5804.2744656917885, 5807.680577568105, 5824.5340372770925, 5841.32824725162, 5502.504774570308, 5810.721641238921, 5842.795502157404, 5844.883102338014, 5854.390042738281, 5709.257796486596, 5726.742296596746, 5730.570207234391, 5792.652440853562, 5798.971005145116, 5774.653520788766, 5860.94139058621, 5863.970680146572, 5878.911816322673, 5888.735006924784, 5547.667139971614, 5686.180422264835, 5734.655920644775, 5773.3072031356505, 5786.218860453785], "value": 4351.996652044431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.8007124500144, 807.6446363600015, 826.3348004856089, 856.1438561438562, 862.0732712334241, 15974.440894568692, 17723.645527089466, 17747.556311092212, 17796.0, 17844.10779461028, 15501.379944802222, 15529.53411397657, 15558.0, 15562.221888905566, 15576.532704018897, 711.6157275071455, 838.8154605986704, 843.493903657805, 861.3798065392907, 865.965361385547, 854.1458541458542, 854.6026097864492, 857.1685465098844, 858.8926384201975, 859.1108203009886, 890.3722875372879, 896.7982204004112, 897.4211633496391, 897.6409436225497, 897.7306807957619, 753.107567532473, 865.1046167216932, 887.9156480134377, 889.795347070171, 891.2468963725642, 663.5454713521253, 664.9368310010541, 665.2283351312454, 665.6605131382981, 665.9700313485905, 15942.123183224918, 16058.116803575798, 16073.437429689904, 16098.03411795296, 16100.19499025044, 13593.116447430886, 13614.795778063239, 13733.176009439465, 13871.583852484442, 14028.719425611533, 12551.227223397764, 12799.282171431401, 12801.679958001032, 13038.21770693752, 13078.149920255248, 4455.108978204372, 4479.820807167709, 4510.526394728572, 4573.49691533931, 4708.670393072486, 79593.60203199004, 83123.5843820783, 83177.16822831755, 84013.57993210056, 84055.0, 12607.621771346874, 12614.598816851345, 12639.431225594686, 12776.233425994284, 12843.422046007765, 23668.053277869036, 23712.525749484914, 23750.168744093873, 23757.16849910245, 23906.64140037901, 8019.879701804478, 8192.426530142951, 8226.0, 8349.624266908004, 9203.723888283363, 4792.520747925179, 5181.222816577468, 5232.372115346183, 5291.074062039128, 5386.434424385461, 3837.769733815924, 3998.2203470323007, 3998.7200895937003, 4001.8799436016966, 4001.919961600752, 704.6089420371641, 705.7988473285192, 708.0724251230802, 716.9175544812414, 721.1886627544013, 771.221017016623, 788.1409263902374, 791.4222617489265, 804.4288555125809, 821.4783612406046, 10217.489125543692, 10595.417252051056, 10653.201009924287, 10669.626563070255, 10701.732456688645, 669.2671524680565, 695.2769120115024, 698.7763915547077, 753.830388162659, 791.6872835230051, 5029.5221953914315, 5039.4708555601865, 5073.974630126826, 5182.2485739567555, 5264.736763161826, 105830.0, 114325.0, 114393.42803286097, 121542.0, 122974.0, 64194.35805641884, 86449.1355086441, 92317.0, 101651.0, 101792.0, 73114.63442682753, 74444.25555744482, 75190.0, 90389.54805225931, 90970.54514727384, 10464.769108280376, 10745.462726863781, 10764.838527421938, 10998.230123891251, 11033.944830275797, 43203.0, 50529.49470505248, 51561.7421912888, 56329.0, 57912.131318031104, 76012.61993689997, 78246.6087669558, 85367.0, 86011.0, 87291.56354218189, 13761.0, 13854.238016909167, 14311.35598898073, 14469.49356772508, 14500.564983050524, 16116.194190290204, 16246.67506649884, 16563.751543726612, 16589.668206635557, 16678.916605416896, 15229.847701523286, 15434.536963891102, 15530.1458419788, 15790.921045395158, 15835.604109897346, 14986.40054397812, 15203.0, 15255.694886102438, 15437.305321260346, 15511.612209694847, 14306.499272525412, 14315.928420357832, 14567.344469498687, 15007.474738384104, 15069.698606028038, 11995.580154694544, 12052.216605920587, 12263.93868030654, 12511.56209532662, 12667.176633518791, 11979.34113623759, 12202.578890421932, 12309.26144431337, 12334.383280835742, 12581.245125292511], "value": 8086.100013429636, "unit": "score"}], "name": "dromaeo_css", "value": 7659.840572606969, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 102.0, 110.0, 109.0, 111.0, 110.0, 109.0, 112.0, 109.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 122.0, 181.0, 124.0, 126.0, 153.0, 129.0, 156.0, 126.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 160.0, 159.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 114.0, 75.0, 76.0, 75.0, 76.0, 106.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 86.0, 86.0, 84.0, 116.0, 83.0, 84.0, 132.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 118.0, 119.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 50.0, 54.0, 51.0, 53.0, 51.0, 50.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 76.0, 77.0, 82.0, 83.0, 82.0, 104.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 116.0, 123.0, 117.0, 117.0, 124.0, 122.0, 123.0, 126.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 154.0, 153.0, 154.0, 158.0, 155.0, 157.0, 152.0, 153.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 62.0, 61.0, 61.0, 63.0, 63.0, 63.0, 60.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1476.2, "alertThreshold": 2.0}]} 17:55:34 INFO - Return code: 0 17:55:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:34 ERROR - # TBPL SUCCESS # 17:55:34 INFO - Running post-action listener: _resource_record_post_action 17:55:34 INFO - ##### 17:55:34 INFO - ##### Finished run-tests step (success) 17:55:34 INFO - ##### 17:55:34 INFO - Running post-run listener: _resource_record_post_run 17:55:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248184832; Read time: 44; Write time: 1050888 17:55:34 INFO - TinderboxPrint: CPU usage
13.3% 17:55:34 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 44 17:55:34 INFO - TinderboxPrint: I/O write bytes / time
248,184,832 / 1,050,888 17:55:34 INFO - TinderboxPrint: CPU idle
8,296.3 (86.7%) 17:55:34 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 17:55:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 10792960; Read time: 0; Write time: 17092 17:55:34 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 266240; Write bytes: 234487808; Read time: 44; Write time: 1026352 17:55:34 INFO - Running post-run listener: _upload_blobber_files 17:55:34 INFO - Blob upload gear active. 17:55:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:34 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 17:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:55:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:36 INFO - (blobuploader) - INFO - Done attempting. 17:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:40 INFO - (blobuploader) - INFO - Done attempting. 17:55:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:55:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:55:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:41 INFO - (blobuploader) - INFO - Done attempting. 17:55:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:41 INFO - Return code: 0 17:55:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1cf552a5c0ef9afe71a9183035da6680e13e1a893ff53716fb86c9a4a2c7055929f635ec176f8c37ff4848b8ec398e3b1768b1e1c3d6900f25f6f764f4a6caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a5a117aed06b564471a76b03de5d1f17b89d9bb7de728574d0313c2991abb46f6c193f75146c86e13c2790933ea0693b2eb0e1e3ad51833cc7e85a7db60d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ca84ec72583fe076b2c7afa7dc87225ce6b10a7d5673dad0c2ba4f63409ad082e710f2979c3a75c1b49a58704e7a8b2cfe4e5cb54596b6bc3e56872ab9e3ab"} 17:55:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:41 INFO - Contents: 17:55:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1cf552a5c0ef9afe71a9183035da6680e13e1a893ff53716fb86c9a4a2c7055929f635ec176f8c37ff4848b8ec398e3b1768b1e1c3d6900f25f6f764f4a6caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a5a117aed06b564471a76b03de5d1f17b89d9bb7de728574d0313c2991abb46f6c193f75146c86e13c2790933ea0693b2eb0e1e3ad51833cc7e85a7db60d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ca84ec72583fe076b2c7afa7dc87225ce6b10a7d5673dad0c2ba4f63409ad082e710f2979c3a75c1b49a58704e7a8b2cfe4e5cb54596b6bc3e56872ab9e3ab"} 17:55:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:41 INFO - Copying logs to upload dir... 17:55:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.840051 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-06-15 17:55:40.624898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:55:40.630159) ========= 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=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 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-Aurora/sha512/d1cf552a5c0ef9afe71a9183035da6680e13e1a893ff53716fb86c9a4a2c7055929f635ec176f8c37ff4848b8ec398e3b1768b1e1c3d6900f25f6f764f4a6caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a5a117aed06b564471a76b03de5d1f17b89d9bb7de728574d0313c2991abb46f6c193f75146c86e13c2790933ea0693b2eb0e1e3ad51833cc7e85a7db60d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ca84ec72583fe076b2c7afa7dc87225ce6b10a7d5673dad0c2ba4f63409ad082e710f2979c3a75c1b49a58704e7a8b2cfe4e5cb54596b6bc3e56872ab9e3ab"} build_url:https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/WLyNSQiSQoKt7OwQI5xdyg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1cf552a5c0ef9afe71a9183035da6680e13e1a893ff53716fb86c9a4a2c7055929f635ec176f8c37ff4848b8ec398e3b1768b1e1c3d6900f25f6f764f4a6caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51a5a117aed06b564471a76b03de5d1f17b89d9bb7de728574d0313c2991abb46f6c193f75146c86e13c2790933ea0693b2eb0e1e3ad51833cc7e85a7db60d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2ca84ec72583fe076b2c7afa7dc87225ce6b10a7d5673dad0c2ba4f63409ad082e710f2979c3a75c1b49a58704e7a8b2cfe4e5cb54596b6bc3e56872ab9e3ab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 17:55:40.655453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:55:40.655806) ========= 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=33d5923976266a1c518c4bf7000001ab-1466033379.762927-609779178 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 17:55:40.741545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:55:40.741854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 17:55:40.742143) ========= ========= Total master_lag: 0.16 =========