builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1465409344.5 results: success (0) buildid: 20160608083003 builduid: 4b7610b436f04373aacdc41b7aeba386 revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.498979) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.499614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.499929) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.520116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.520404) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 11:09:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.0M=0s 2016-06-08 11:09:04 (34.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.650957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.651342) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:04.707484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 11:09:04.707807) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daadc8567a11c6165986c05719fa44a7ed8af839 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev daadc8567a11c6165986c05719fa44a7ed8af839 --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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 11:09:04,978 truncating revision to first 12 chars 2016-06-08 11:09:04,978 Setting DEBUG logging. 2016-06-08 11:09:04,978 attempt 1/10 2016-06-08 11:09:04,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daadc8567a11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 11:09:06,146 unpacking tar archive at: fx-team-daadc8567a11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.518566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 11:09:06.242537) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:06.242849) ========= script_repo_revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:06.243256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:06.243530) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 11:09:06.252446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 11:09:06.252715) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:09:06 INFO - MultiFileLogger online at 20160608 11:09:06 in /builds/slave/test 11:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:06 INFO - {'append_to_log': False, 11:09:06 INFO - 'base_work_dir': '/builds/slave/test', 11:09:06 INFO - 'blob_upload_branch': 'Fx-Team', 11:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:06 INFO - 'branch': 'Fx-Team', 11:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:06 INFO - 'config_files': ('talos/linux_config.py',), 11:09:06 INFO - 'default_actions': ('clobber', 11:09:06 INFO - 'read-buildbot-config', 11:09:06 INFO - 'download-and-extract', 11:09:06 INFO - 'populate-webroot', 11:09:06 INFO - 'create-virtualenv', 11:09:06 INFO - 'install', 11:09:06 INFO - 'run-tests'), 11:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:06 INFO - 'download_minidump_stackwalk': True, 11:09:06 INFO - 'download_symbols': 'ondemand', 11:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:06 INFO - 'installer_path': 'installer.exe', 11:09:06 INFO - 'log_level': 'info', 11:09:06 INFO - 'log_name': 'talos', 11:09:06 INFO - 'log_to_console': True, 11:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:09:06 INFO - 'opt_config_files': (), 11:09:06 INFO - 'pip_index': False, 11:09:06 INFO - 'sps_profile': False, 11:09:06 INFO - 'sps_profile_interval': 0, 11:09:06 INFO - 'suite': 'dromaeojs', 11:09:06 INFO - 'system_bits': '32', 11:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:06 INFO - 'title': 'talos-linux64-ix-033', 11:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:06 INFO - 'use_talos_json': True, 11:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:06 INFO - 'work_dir': 'build'} 11:09:06 INFO - ##### 11:09:06 INFO - ##### Running clobber step. 11:09:06 INFO - ##### 11:09:06 INFO - Running pre-action listener: _resource_record_pre_action 11:09:06 INFO - Running main action method: clobber 11:09:06 INFO - rmtree: /builds/slave/test/build 11:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:07 INFO - Running post-action listener: _resource_record_post_action 11:09:07 INFO - ##### 11:09:07 INFO - ##### Finished clobber step (success) 11:09:07 INFO - ##### 11:09:07 INFO - ##### 11:09:07 INFO - ##### Running read-buildbot-config step. 11:09:07 INFO - ##### 11:09:07 INFO - Running pre-action listener: _resource_record_pre_action 11:09:07 INFO - Running main action method: read_buildbot_config 11:09:07 INFO - Using buildbot properties: 11:09:07 INFO - { 11:09:07 INFO - "project": "", 11:09:07 INFO - "product": "firefox", 11:09:07 INFO - "script_repo_revision": "production", 11:09:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:09:07 INFO - "repository": "", 11:09:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:09:07 INFO - "buildid": "20160608083003", 11:09:07 INFO - "pgo_build": "True", 11:09:07 INFO - "basedir": "/builds/slave/test", 11:09:07 INFO - "buildnumber": 782, 11:09:07 INFO - "slavename": "talos-linux64-ix-033", 11:09:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:09:07 INFO - "platform": "ubuntu64_hw", 11:09:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:09:07 INFO - "branch": "fx-team", 11:09:07 INFO - "repo_path": "integration/fx-team", 11:09:07 INFO - "revision": "daadc8567a11c6165986c05719fa44a7ed8af839", 11:09:07 INFO - "stage_platform": "linux64-pgo", 11:09:07 INFO - "builduid": "4b7610b436f04373aacdc41b7aeba386", 11:09:07 INFO - "slavebuilddir": "test" 11:09:07 INFO - } 11:09:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:09:07 INFO - Running post-action listener: _resource_record_post_action 11:09:07 INFO - ##### 11:09:07 INFO - ##### Finished read-buildbot-config step (success) 11:09:07 INFO - ##### 11:09:07 INFO - ##### 11:09:07 INFO - ##### Running download-and-extract step. 11:09:07 INFO - ##### 11:09:07 INFO - Running pre-action listener: _resource_record_pre_action 11:09:07 INFO - Running main action method: download_and_extract 11:09:07 INFO - mkdir: /builds/slave/test/build/tests 11:09:07 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')]} 11:09:07 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:09:10 INFO - Downloaded 1361 bytes. 11:09:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:09:10 INFO - Using the following test package requirements: 11:09:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:09:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:09:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:09:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'jsshell-linux-x86_64.zip'], 11:09:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:09:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:09:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:09:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:09:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:09:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:09:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:09:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:09:10 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')]} 11:09:10 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:15 INFO - Downloaded 24450436 bytes. 11:09:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:09:16 INFO - Return code: 0 11:09:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:16 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:22 INFO - Downloaded 24450436 bytes. 11:09:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:09:23 INFO - Return code: 0 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:23 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:09:25 INFO - Downloaded 10833369 bytes. 11:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:09:25 INFO - Return code: 0 11:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:25 INFO - https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:09:27 INFO - Downloaded 59308529 bytes. 11:09:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:09:27 INFO - mkdir: /builds/slave/test/properties 11:09:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:27 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:27 INFO - Contents: 11:09:27 INFO - build_url:https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:09:28 INFO - Running post-action listener: _resource_record_post_action 11:09:28 INFO - Running post-action listener: set_extra_try_arguments 11:09:28 INFO - ##### 11:09:28 INFO - ##### Finished download-and-extract step (success) 11:09:28 INFO - ##### 11:09:28 INFO - ##### 11:09:28 INFO - ##### Running populate-webroot step. 11:09:28 INFO - ##### 11:09:28 INFO - Running pre-action listener: _resource_record_pre_action 11:09:28 INFO - Running main action method: populate_webroot 11:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:28 INFO - '--tppagecycles', 11:09:28 INFO - '7'], 11:09:28 INFO - 'tests': ['tsvgm']}}, 11:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['damp', 'tps']}, 11:09:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'tests': ['damp', 'tps']}, 11:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['dromaeo_dom']}, 11:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['a11yr', 11:09:28 INFO - 'ts_paint', 11:09:28 INFO - 'tpaint', 11:09:28 INFO - 'sessionrestore', 11:09:28 INFO - 'sessionrestore_no_auto_restore', 11:09:28 INFO - 'tabpaint']}, 11:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['tsvgx', 11:09:28 INFO - 'tsvgr_opacity', 11:09:28 INFO - 'tart', 11:09:28 INFO - 'tscrollx', 11:09:28 INFO - 'cart']}, 11:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:28 INFO - 'tsvgr_opacity', 11:09:28 INFO - 'tart', 11:09:28 INFO - 'tscrollx', 11:09:28 INFO - 'cart']}, 11:09:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'talos_options': ['--disable-e10s'], 11:09:28 INFO - 'tests': ['tp5o']}, 11:09:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'tests': ['tp5o']}, 11:09:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'talos_options': ['--disable-e10s', 11:09:28 INFO - '--xperf_path', 11:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:28 INFO - 'tests': ['tp5n']}, 11:09:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:28 INFO - 'talos_options': ['--xperf_path', 11:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:28 INFO - 'tests': ['tp5n']}}, 11:09:28 INFO - 'talos.zip': {'path': '', 11:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:28 INFO - Running post-action listener: _resource_record_post_action 11:09:28 INFO - ##### 11:09:28 INFO - ##### Finished populate-webroot step (success) 11:09:28 INFO - ##### 11:09:28 INFO - ##### 11:09:28 INFO - ##### Running create-virtualenv step. 11:09:28 INFO - ##### 11:09:28 INFO - Running pre-action listener: _resource_record_pre_action 11:09:28 INFO - Running main action method: create_virtualenv 11:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:28 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 11:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:28 INFO - Using real prefix '/usr' 11:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:31 INFO - Installing pip.................done. 11:09:31 INFO - Return code: 0 11:09:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:31 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:31 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 11:09:31 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 11:09:31 INFO - Using env: {'DISPLAY': ':0', 11:09:31 INFO - 'HOME': '/home/cltbld', 11:09:31 INFO - 'LANG': 'en_US.UTF-8', 11:09:31 INFO - 'LANGUAGE': 'en_US:en', 11:09:31 INFO - 'LOGNAME': 'cltbld', 11:09:31 INFO - 'MAIL': '/var/mail/cltbld', 11:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:31 INFO - 'MOZ_NO_REMOTE': '1', 11:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:31 INFO - 'NO_EM_RESTART': '1', 11:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:31 INFO - 'PWD': '/builds/slave/test', 11:09:31 INFO - 'SHELL': '/bin/bash', 11:09:31 INFO - 'SHLVL': '1', 11:09:31 INFO - 'TERM': 'linux', 11:09:31 INFO - 'TMOUT': '86400', 11:09:31 INFO - 'USER': 'cltbld', 11:09:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:31 INFO - '_': '/tools/buildbot/bin/python'} 11:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:31 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 11:09:31 INFO - Cleaning up... 11:09:31 INFO - Return code: 0 11:09:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:31 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:31 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 11:09:31 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 11:09:31 INFO - Using env: {'DISPLAY': ':0', 11:09:31 INFO - 'HOME': '/home/cltbld', 11:09:31 INFO - 'LANG': 'en_US.UTF-8', 11:09:31 INFO - 'LANGUAGE': 'en_US:en', 11:09:31 INFO - 'LOGNAME': 'cltbld', 11:09:31 INFO - 'MAIL': '/var/mail/cltbld', 11:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:31 INFO - 'MOZ_NO_REMOTE': '1', 11:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:31 INFO - 'NO_EM_RESTART': '1', 11:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:31 INFO - 'PWD': '/builds/slave/test', 11:09:31 INFO - 'SHELL': '/bin/bash', 11:09:31 INFO - 'SHLVL': '1', 11:09:31 INFO - 'TERM': 'linux', 11:09:31 INFO - 'TMOUT': '86400', 11:09:31 INFO - 'USER': 'cltbld', 11:09:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:31 INFO - '_': '/tools/buildbot/bin/python'} 11:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:31 INFO - Downloading/unpacking psutil>=3.1.1 11:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:33 INFO - Installing collected packages: psutil 11:09:33 INFO - Running setup.py install for psutil 11:09:33 INFO - building 'psutil._psutil_linux' extension 11:09:33 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 11:09:33 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 11:09:33 INFO - building 'psutil._psutil_posix' extension 11:09:33 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 11:09:33 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 11:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:33 INFO - Successfully installed psutil 11:09:33 INFO - Cleaning up... 11:09:34 INFO - Return code: 0 11:09:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:34 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')]} 11:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:34 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')]} 11:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:34 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:34 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 11:09:34 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 11:09:34 INFO - Using env: {'DISPLAY': ':0', 11:09:34 INFO - 'HOME': '/home/cltbld', 11:09:34 INFO - 'LANG': 'en_US.UTF-8', 11:09:34 INFO - 'LANGUAGE': 'en_US:en', 11:09:34 INFO - 'LOGNAME': 'cltbld', 11:09:34 INFO - 'MAIL': '/var/mail/cltbld', 11:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:34 INFO - 'MOZ_NO_REMOTE': '1', 11:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:34 INFO - 'NO_EM_RESTART': '1', 11:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:34 INFO - 'PWD': '/builds/slave/test', 11:09:34 INFO - 'SHELL': '/bin/bash', 11:09:34 INFO - 'SHLVL': '1', 11:09:34 INFO - 'TERM': 'linux', 11:09:34 INFO - 'TMOUT': '86400', 11:09:34 INFO - 'USER': 'cltbld', 11:09:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:34 INFO - '_': '/tools/buildbot/bin/python'} 11:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:36 INFO - Installing collected packages: mozsystemmonitor 11:09:36 INFO - Running setup.py install for mozsystemmonitor 11:09:36 INFO - Successfully installed mozsystemmonitor 11:09:36 INFO - Cleaning up... 11:09:36 INFO - Return code: 0 11:09:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:36 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 11:09:36 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 11:09:36 INFO - Using env: {'DISPLAY': ':0', 11:09:36 INFO - 'HOME': '/home/cltbld', 11:09:36 INFO - 'LANG': 'en_US.UTF-8', 11:09:36 INFO - 'LANGUAGE': 'en_US:en', 11:09:36 INFO - 'LOGNAME': 'cltbld', 11:09:36 INFO - 'MAIL': '/var/mail/cltbld', 11:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:36 INFO - 'MOZ_NO_REMOTE': '1', 11:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:36 INFO - 'NO_EM_RESTART': '1', 11:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:36 INFO - 'PWD': '/builds/slave/test', 11:09:36 INFO - 'SHELL': '/bin/bash', 11:09:36 INFO - 'SHLVL': '1', 11:09:36 INFO - 'TERM': 'linux', 11:09:36 INFO - 'TMOUT': '86400', 11:09:36 INFO - 'USER': 'cltbld', 11:09:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:36 INFO - '_': '/tools/buildbot/bin/python'} 11:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:38 INFO - warning: no files found matching '*.txt' 11:09:38 INFO - no previously-included directories found matching 'build' 11:09:38 INFO - no previously-included directories found matching 'dist' 11:09:38 INFO - no previously-included directories found matching '.git*' 11:09:38 INFO - Installing collected packages: jsonschema, functools32 11:09:38 INFO - Running setup.py install for functools32 11:09:38 INFO - warning: no files found matching '*.txt' 11:09:38 INFO - no previously-included directories found matching 'build' 11:09:38 INFO - no previously-included directories found matching 'dist' 11:09:38 INFO - no previously-included directories found matching '.git*' 11:09:38 INFO - Successfully installed jsonschema functools32 11:09:38 INFO - Cleaning up... 11:09:38 INFO - Return code: 0 11:09:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:38 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:38 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 11:09:38 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 11:09:38 INFO - Using env: {'DISPLAY': ':0', 11:09:38 INFO - 'HOME': '/home/cltbld', 11:09:38 INFO - 'LANG': 'en_US.UTF-8', 11:09:38 INFO - 'LANGUAGE': 'en_US:en', 11:09:38 INFO - 'LOGNAME': 'cltbld', 11:09:38 INFO - 'MAIL': '/var/mail/cltbld', 11:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:38 INFO - 'MOZ_NO_REMOTE': '1', 11:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:38 INFO - 'NO_EM_RESTART': '1', 11:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:38 INFO - 'PWD': '/builds/slave/test', 11:09:38 INFO - 'SHELL': '/bin/bash', 11:09:38 INFO - 'SHLVL': '1', 11:09:38 INFO - 'TERM': 'linux', 11:09:38 INFO - 'TMOUT': '86400', 11:09:38 INFO - 'USER': 'cltbld', 11:09:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:38 INFO - '_': '/tools/buildbot/bin/python'} 11:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:41 INFO - Downloading docopt-0.6.1.tar.gz 11:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:42 INFO - Running setup.py install for blobuploader 11:09:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:42 INFO - Running setup.py install for requests 11:09:42 INFO - Running setup.py install for docopt 11:09:42 INFO - Successfully installed blobuploader requests docopt 11:09:42 INFO - Cleaning up... 11:09:42 INFO - Return code: 0 11:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:42 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:42 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 11:09:42 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 11:09:42 INFO - Using env: {'DISPLAY': ':0', 11:09:42 INFO - 'HOME': '/home/cltbld', 11:09:42 INFO - 'LANG': 'en_US.UTF-8', 11:09:42 INFO - 'LANGUAGE': 'en_US:en', 11:09:42 INFO - 'LOGNAME': 'cltbld', 11:09:42 INFO - 'MAIL': '/var/mail/cltbld', 11:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:42 INFO - 'MOZ_NO_REMOTE': '1', 11:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:42 INFO - 'NO_EM_RESTART': '1', 11:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:42 INFO - 'PWD': '/builds/slave/test', 11:09:42 INFO - 'SHELL': '/bin/bash', 11:09:42 INFO - 'SHLVL': '1', 11:09:42 INFO - 'TERM': 'linux', 11:09:42 INFO - 'TMOUT': '86400', 11:09:42 INFO - 'USER': 'cltbld', 11:09:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:42 INFO - '_': '/tools/buildbot/bin/python'} 11:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:42 INFO - Running setup.py (path:/tmp/pip-jcf2qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:42 INFO - Running setup.py (path:/tmp/pip-OZ0eAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:42 INFO - Running setup.py (path:/tmp/pip-cfzXq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:43 INFO - Running setup.py (path:/tmp/pip-yerzEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:43 INFO - Running setup.py (path:/tmp/pip-QBiUUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:43 INFO - Running setup.py (path:/tmp/pip-I2uAZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:43 INFO - Running setup.py (path:/tmp/pip-T3a8QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:43 INFO - Running setup.py (path:/tmp/pip-f5u5GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:43 INFO - Running setup.py (path:/tmp/pip-pZNqZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:43 INFO - Running setup.py (path:/tmp/pip-hFKIz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:43 INFO - Running setup.py (path:/tmp/pip-_clBg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:43 INFO - Running setup.py (path:/tmp/pip-VGOMPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:43 INFO - Running setup.py (path:/tmp/pip-w81kfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:43 INFO - Running setup.py (path:/tmp/pip-NKK8up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:43 INFO - Running setup.py (path:/tmp/pip-uuHy_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:43 INFO - Running setup.py (path:/tmp/pip-vDRmh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:43 INFO - Running setup.py (path:/tmp/pip-ENFFga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:44 INFO - Running setup.py install for manifestparser 11:09:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Running setup.py install for mozcrash 11:09:44 INFO - Running setup.py install for mozdebug 11:09:44 INFO - Running setup.py install for mozdevice 11:09:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Running setup.py install for mozfile 11:09:44 INFO - Running setup.py install for mozhttpd 11:09:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Running setup.py install for mozinfo 11:09:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Running setup.py install for mozInstall 11:09:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:44 INFO - Running setup.py install for mozleak 11:09:45 INFO - Running setup.py install for mozlog 11:09:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Running setup.py install for moznetwork 11:09:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Running setup.py install for mozprocess 11:09:45 INFO - Running setup.py install for mozprofile 11:09:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Running setup.py install for mozrunner 11:09:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Running setup.py install for mozscreenshot 11:09:45 INFO - Running setup.py install for moztest 11:09:45 INFO - Running setup.py install for mozversion 11:09:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:45 INFO - Cleaning up... 11:09:45 INFO - Return code: 0 11:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:45 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')]} 11:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:45 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')]} 11:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:45 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:45 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 11:09:45 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 11:09:45 INFO - Using env: {'DISPLAY': ':0', 11:09:45 INFO - 'HOME': '/home/cltbld', 11:09:45 INFO - 'LANG': 'en_US.UTF-8', 11:09:45 INFO - 'LANGUAGE': 'en_US:en', 11:09:45 INFO - 'LOGNAME': 'cltbld', 11:09:45 INFO - 'MAIL': '/var/mail/cltbld', 11:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:45 INFO - 'MOZ_NO_REMOTE': '1', 11:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:45 INFO - 'NO_EM_RESTART': '1', 11:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:45 INFO - 'PWD': '/builds/slave/test', 11:09:45 INFO - 'SHELL': '/bin/bash', 11:09:45 INFO - 'SHLVL': '1', 11:09:45 INFO - 'TERM': 'linux', 11:09:45 INFO - 'TMOUT': '86400', 11:09:45 INFO - 'USER': 'cltbld', 11:09:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:45 INFO - '_': '/tools/buildbot/bin/python'} 11:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:46 INFO - Running setup.py (path:/tmp/pip-lRyujR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:46 INFO - Running setup.py (path:/tmp/pip-9ABXEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:46 INFO - Running setup.py (path:/tmp/pip-nDUnt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:46 INFO - Running setup.py (path:/tmp/pip-GN8ozL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:46 INFO - Running setup.py (path:/tmp/pip-Eil76W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:46 INFO - Running setup.py (path:/tmp/pip-Np2v4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:46 INFO - Running setup.py (path:/tmp/pip-5yg5PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:46 INFO - Running setup.py (path:/tmp/pip-o3dOJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:46 INFO - Running setup.py (path:/tmp/pip-Rheihk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:46 INFO - Running setup.py (path:/tmp/pip-WB1xPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:46 INFO - Running setup.py (path:/tmp/pip-eqlRkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:46 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)) 11:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:46 INFO - Running setup.py (path:/tmp/pip-2OmA4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:47 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)) 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:47 INFO - Running setup.py (path:/tmp/pip-bCYq2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:47 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)) 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:47 INFO - Running setup.py (path:/tmp/pip-DvHnoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:47 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)) 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:47 INFO - Running setup.py (path:/tmp/pip-HmBfgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:47 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)) 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:47 INFO - Running setup.py (path:/tmp/pip-duJmey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:47 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)) 11:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:47 INFO - Running setup.py (path:/tmp/pip-uj2X9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:47 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)) 11:09:47 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)) 11:09:47 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)) 11:09:47 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)) 11:09:47 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)) 11:09:47 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)) 11:09:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:49 INFO - Downloading blessings-1.6.tar.gz 11:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:49 INFO - Installing collected packages: blessings 11:09:49 INFO - Running setup.py install for blessings 11:09:49 INFO - Successfully installed blessings 11:09:49 INFO - Cleaning up... 11:09:49 INFO - Return code: 0 11:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:49 INFO - Reading from file tmpfile_stdout 11:09:49 INFO - Current package versions: 11:09:49 INFO - argparse == 1.2.1 11:09:49 INFO - blessings == 1.6 11:09:49 INFO - blobuploader == 1.2.4 11:09:49 INFO - docopt == 0.6.1 11:09:49 INFO - functools32 == 3.2.3-2 11:09:49 INFO - jsonschema == 2.5.1 11:09:49 INFO - manifestparser == 1.1 11:09:49 INFO - mozInstall == 1.12 11:09:49 INFO - mozcrash == 0.17 11:09:49 INFO - mozdebug == 0.1 11:09:49 INFO - mozdevice == 0.48 11:09:49 INFO - mozfile == 1.2 11:09:49 INFO - mozhttpd == 0.7 11:09:49 INFO - mozinfo == 0.9 11:09:49 INFO - mozleak == 0.1 11:09:49 INFO - mozlog == 3.2 11:09:49 INFO - moznetwork == 0.27 11:09:49 INFO - mozprocess == 0.22 11:09:49 INFO - mozprofile == 0.28 11:09:49 INFO - mozrunner == 6.11 11:09:49 INFO - mozscreenshot == 0.1 11:09:49 INFO - mozsystemmonitor == 0.3 11:09:49 INFO - moztest == 0.7 11:09:49 INFO - mozversion == 1.4 11:09:49 INFO - psutil == 3.1.1 11:09:49 INFO - requests == 1.2.3 11:09:49 INFO - wsgiref == 0.1.2 11:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:49 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')]} 11:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:49 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')]} 11:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:49 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:49 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 11:09:49 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 11:09:49 INFO - Using env: {'DISPLAY': ':0', 11:09:49 INFO - 'HOME': '/home/cltbld', 11:09:49 INFO - 'LANG': 'en_US.UTF-8', 11:09:49 INFO - 'LANGUAGE': 'en_US:en', 11:09:49 INFO - 'LOGNAME': 'cltbld', 11:09:49 INFO - 'MAIL': '/var/mail/cltbld', 11:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:49 INFO - 'MOZ_NO_REMOTE': '1', 11:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:49 INFO - 'NO_EM_RESTART': '1', 11:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:49 INFO - 'PWD': '/builds/slave/test', 11:09:49 INFO - 'SHELL': '/bin/bash', 11:09:49 INFO - 'SHLVL': '1', 11:09:49 INFO - 'TERM': 'linux', 11:09:49 INFO - 'TMOUT': '86400', 11:09:49 INFO - 'USER': 'cltbld', 11:09:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:49 INFO - '_': '/tools/buildbot/bin/python'} 11:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 INFO - Cleaning up... 11:09:49 INFO - Return code: 0 11:09:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:49 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')]} 11:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:49 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')]} 11:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:49 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:49 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 11:09:49 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 11:09:49 INFO - Using env: {'DISPLAY': ':0', 11:09:49 INFO - 'HOME': '/home/cltbld', 11:09:49 INFO - 'LANG': 'en_US.UTF-8', 11:09:49 INFO - 'LANGUAGE': 'en_US:en', 11:09:49 INFO - 'LOGNAME': 'cltbld', 11:09:49 INFO - 'MAIL': '/var/mail/cltbld', 11:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:49 INFO - 'MOZ_NO_REMOTE': '1', 11:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:49 INFO - 'NO_EM_RESTART': '1', 11:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:49 INFO - 'PWD': '/builds/slave/test', 11:09:49 INFO - 'SHELL': '/bin/bash', 11:09:49 INFO - 'SHLVL': '1', 11:09:49 INFO - 'TERM': 'linux', 11:09:49 INFO - 'TMOUT': '86400', 11:09:49 INFO - 'USER': 'cltbld', 11:09:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:49 INFO - '_': '/tools/buildbot/bin/python'} 11:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:09:50 INFO - Cleaning up... 11:09:50 INFO - Return code: 0 11:09:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:09:50 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')]} 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:50 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')]} 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:50 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 0x7fcb5e38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2771350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', '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 11:09:50 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 11:09:50 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 11:09:50 INFO - Using env: {'DISPLAY': ':0', 11:09:50 INFO - 'HOME': '/home/cltbld', 11:09:50 INFO - 'LANG': 'en_US.UTF-8', 11:09:50 INFO - 'LANGUAGE': 'en_US:en', 11:09:50 INFO - 'LOGNAME': 'cltbld', 11:09:50 INFO - 'MAIL': '/var/mail/cltbld', 11:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:50 INFO - 'MOZ_NO_REMOTE': '1', 11:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:50 INFO - 'NO_EM_RESTART': '1', 11:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:50 INFO - 'PWD': '/builds/slave/test', 11:09:50 INFO - 'SHELL': '/bin/bash', 11:09:50 INFO - 'SHLVL': '1', 11:09:50 INFO - 'TERM': 'linux', 11:09:50 INFO - 'TMOUT': '86400', 11:09:50 INFO - 'USER': 'cltbld', 11:09:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:50 INFO - '_': '/tools/buildbot/bin/python'} 11:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:50 INFO - Downloading/unpacking flake8 11:09:50 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 11:09:50 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 11:09:50 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 11:09:50 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 11:09:50 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 11:09:50 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 11:09:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:09:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:09:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:09:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:52 INFO - no previously-included directories found matching 'docs/_build' 11:09:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:09:53 INFO - Running setup.py install for pep8 11:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:09:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:09:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:09:53 INFO - no previously-included directories found matching 'docs/_build' 11:09:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:09:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:09:53 INFO - Cleaning up... 11:09:53 INFO - Return code: 0 11:09:53 INFO - Running post-action listener: _resource_record_post_action 11:09:53 INFO - Running post-action listener: _start_resource_monitoring 11:09:53 INFO - Starting resource monitoring. 11:09:53 INFO - ##### 11:09:53 INFO - ##### Finished create-virtualenv step (success) 11:09:53 INFO - ##### 11:09:53 INFO - ##### 11:09:53 INFO - ##### Running install step. 11:09:53 INFO - ##### 11:09:53 INFO - Running pre-action listener: _resource_record_pre_action 11:09:53 INFO - Running main action method: install 11:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:53 INFO - Reading from file tmpfile_stdout 11:09:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:53 INFO - Reading from file tmpfile_stdout 11:09:53 INFO - Output received: 11:09:53 INFO - Usage: mozinstall [options] installer 11:09:53 INFO - Options: 11:09:53 INFO - -h, --help show this help message and exit 11:09:53 INFO - -d DEST, --destination=DEST 11:09:53 INFO - Directory to install application into. [default: 11:09:53 INFO - "/builds/slave/test"] 11:09:53 INFO - --app=APP Application being installed. [default: firefox] 11:09:53 INFO - mkdir: /builds/slave/test/build/application 11:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:10:10 INFO - Reading from file tmpfile_stdout 11:10:10 INFO - Output received: 11:10:10 INFO - /builds/slave/test/build/application/firefox/firefox 11:10:10 INFO - Running post-action listener: _resource_record_post_action 11:10:10 INFO - ##### 11:10:10 INFO - ##### Finished install step (success) 11:10:10 INFO - ##### 11:10:10 INFO - ##### 11:10:10 INFO - ##### Running run-tests step. 11:10:10 INFO - ##### 11:10:10 INFO - Running pre-action listener: _resource_record_pre_action 11:10:10 INFO - Running main action method: run_tests 11:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:10 INFO - Python 2.7.3 11:10:10 INFO - Return code: 0 11:10:10 INFO - grabbing minidump binary from tooltool 11:10:10 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')]} 11:10:10 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 0x28001c0>, '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 0x28010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2801550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:10 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 11:10:10 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 11:10:10 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 11:10:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:10 INFO - Return code: 0 11:10:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:10:11 INFO - Return code: 0 11:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 11:10:11 INFO - Using env: {'DISPLAY': ':0', 11:10:11 INFO - 'HOME': '/home/cltbld', 11:10:11 INFO - 'LANG': 'en_US.UTF-8', 11:10:11 INFO - 'LANGUAGE': 'en_US:en', 11:10:11 INFO - 'LOGNAME': 'cltbld', 11:10:11 INFO - 'MAIL': '/var/mail/cltbld', 11:10:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:11 INFO - 'MOZ_NO_REMOTE': '1', 11:10:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:11 INFO - 'NO_EM_RESTART': '1', 11:10:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:11 INFO - 'PWD': '/builds/slave/test', 11:10:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:11 INFO - 'SHELL': '/bin/bash', 11:10:11 INFO - 'SHLVL': '1', 11:10:11 INFO - 'TERM': 'linux', 11:10:11 INFO - 'TMOUT': '86400', 11:10:11 INFO - 'USER': 'cltbld', 11:10:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038', 11:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:11 INFO - '_': '/tools/buildbot/bin/python'} 11:10:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 11:10:11 INFO - mozversion application_buildid: 20160608083003 11:10:11 INFO - mozversion application_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 11:10:11 INFO - mozversion application_display_name: Nightly 11:10:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:11 INFO - mozversion application_name: Firefox 11:10:11 INFO - mozversion application_remotingname: firefox 11:10:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:10:11 INFO - mozversion application_vendor: Mozilla 11:10:11 INFO - mozversion application_version: 50.0a1 11:10:11 INFO - mozversion platform_buildid: 20160608083003 11:10:11 INFO - mozversion platform_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 11:10:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:10:11 INFO - mozversion platform_version: 50.0a1 11:10:11 INFO - using testdate: 1465409411 11:10:11 INFO - actual date: 1465409411 11:10:11 INFO - starting webserver on 'localhost:38670' 11:10:11 INFO - SUITE-START | Running 2 tests 11:10:11 INFO - TEST-START | dromaeo_css 11:10:11 INFO - operating with platform_type : linux_ 11:10:11 INFO - Initialising browser for dromaeo_css test... 11:10:11 INFO - TEST-INFO | started process 13849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM2YmEs/profile http://localhost:38670/getInfo.html) 11:10:16 INFO - PROCESS | 13849 | __metrics Screen width/height:1600/1200 11:10:16 INFO - PROCESS | 13849 | colorDepth:24 11:10:16 INFO - PROCESS | 13849 | Browser inner width/height: 1024/697 11:10:16 INFO - PROCESS | 13849 | __metrics 11:10:18 ERROR - PROCESS | 13849 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:10:18 INFO - PROCESS | 13849 | console.error: PushService: 11:10:18 INFO - PROCESS | 13849 | stateChangeProcessEnqueue: Error transitioning state 11:10:18 INFO - PROCESS | 13849 | UnknownError 11:10:19 INFO - TEST-INFO | 13849: exit 0 11:10:19 INFO - Browser initialized. 11:10:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:19 INFO - TEST-INFO | started process 13929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM2YmEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:31 INFO - PROCESS | 13929 | RSS: Main: 160112640 11:10:31 INFO - PROCESS | 13929 | 11:11:22 INFO - PROCESS | 13929 | 1465409482207 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] 11:13:30 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38670/tests/dromaeo/cssquery-ext.html) 11:13:31 INFO - PROCESS | 13929 | RSS: Main: 284659712 11:13:31 INFO - PROCESS | 13929 | 11:16:34 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-ext.html (next: http://localhost:38670/tests/dromaeo/cssquery-jquery.html) 11:16:34 INFO - PROCESS | 13929 | RSS: Main: 242810880 11:16:34 INFO - PROCESS | 13929 | 11:19:36 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38670/tests/dromaeo/cssquery-mootools.html) 11:19:37 INFO - PROCESS | 13929 | RSS: Main: 249991168 11:19:37 INFO - PROCESS | 13929 | 11:22:39 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38670/tests/dromaeo/cssquery-prototype.html) 11:22:40 INFO - PROCESS | 13929 | RSS: Main: 237383680 11:22:40 INFO - PROCESS | 13929 | 11:25:42 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38670/tests/dromaeo/cssquery-yui.html) 11:25:43 INFO - PROCESS | 13929 | RSS: Main: 224272384 11:25:43 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | Cycle 1(1): loaded http://localhost:38670/tests/dromaeo/cssquery-yui.html (next: http://localhost:38670/tests/dromaeo/cssquery-dojo.html) 11:28:46 INFO - PROCESS | 13929 | RSS: Main: 291758080 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | __start_tp_report 11:28:46 INFO - PROCESS | 13929 | _x_x_mozilla_page_load 11:28:46 INFO - PROCESS | 13929 | _x_x_mozilla_page_load_details 11:28:46 INFO - PROCESS | 13929 | |i|pagename|runs| 11:28:46 INFO - PROCESS | 13929 | |0;dojo.html;3124.8750049997993;3138.3723255348937;3144.701253380929;3171.191346206717;3195.3928753536843;5185.714785686786;5206.947930520693;5234.450382709808;5296;5317.734113294339;5237.240600112981;5286.947130528693;5300.549453296465;5340.385855626594;5341.439148889369;4771.761411929407;4829.830955916544;4937.111319962405;4988.925166122511;5039.017391608638;4923.9753801230945;4945.7774400152075;4961.479044700309;4961.950380496203;4970.776315065813;4591.242444996605;4658.627309815207;4754.762261886909;4853.3690620219495;4863.197572400567;4826.348442960226;4834.178189707723;4840.878978025542;4846.030793841246;4877.439094504142;4763.404574428197;4807.11068452334;4824.831130910401;4832.7825247863575;4873.951260487421;5052.646314757969;5091;5149.227615857614;5227.634065615409;5247.790088396459;5553.444655534414;5757.251557297566;5769.0192667246665;5770.307563092414;5777.88444231113;5804.65172089676;5811.535077193815;5824.126381042835;5829.795957141479;5830.621009634403;5122.948770512285;5308.734563271821;5386.245925570423;5398.082326004589;5426.186072089218;5922.703864806743;5923.022701254245;5936.643801371932;5937.2578427696535;5940.762369505258;5687.260656114761;5692.117721753135;5732.742026608813;5740.311162660424;5740.397258287903;5491.780328786884;5552.694601796859;5556.416576259516;5591.273134492571;5639.351474580394;5638.464345887134;5710.428957104256;5716.828495145152;5726.942730572724;5767.826965191051;5642;5715.199872017921;5723.885522289531;5730.713464326767;5731.713414329267;4227.091175397304;4243.596858298457;4343.978280108642;4374.803133858984;4419.513853476115;3868.574456809749;3875.1280961783937;3878.9224215516097;3904;3906.2187562487616;5323.387810401776;5325.813596524103;5403.081476149064;5408.648437851527;5436.184572314105;5436.401995780461;5590.636608620427;5653.9151912721345;5662.943370566241;5734.713264336767;5318.521333080042;5329.786808527616;5339.46605339463;5340.225667278223;5353.250544923714;4815.2054910939305;4817.542333478314;4834.033193361342;4835.709857408567;4875.5124487551675;5630.127330263816;5807;5893.734781934823;5913.881722365529;5930.199423077829;5763.394843541368;5793.15999180125;5801.506871915765;5801.680907550125;5808.244928159481;5653.349864765604;5912.556558258062;5933.732982015906;5940.108983652314;5948.821535353946;5499.560035197094;5562.3047119110115;5579.358373786904;5626.38109807929;5672.858178545404;5692.48767610917;5694.231278777478;5696.715164241688;5699.487046165865;5709.22925405065;5376.112941364631;5486;5548.916766248429;5557.583181261502;5561.499465048165;5397.487238712316;5444.972775136257;5447.346318441812;5497.835064948058;5503.669779813224;5366.865828354323;5397.892042159214;5398.379186393615;5398.568114550748;5401.945980540144;5403.297571315704;5469.808556700496;5538.972305138448;5577.888442231051;5589.580781441489;5407.188921661625;5432.103702888979;5434.673919564839;5458.6724796512335;5540.778368865362 11:28:46 INFO - PROCESS | 13929 | |1;ext.html;594.6342999055579;616.2635650397776;631.1227393922447;631.3686313686313;637.273508200651;30671.84664076679;43183;44074.33888491671;44206;44403;44982;45483.77258113705;45633.77183114088;45643.543564564345;45645.54354456454;8698.39111262212;8882;8884.200421962023;8887.066857979917;8888.866667;8773.078826723198;8935.77660558488;8936.151065648754;8938.776530586754;8941.329400294971;8998.910010899872;9064;9065.773355666095;9066.048064953184;9067.319951003668;8866.423682460652;8985.6855010075;8991.910080899173;8994;9005.77485562863;8705.303575713928;8810.69162579313;8812;8819.118088191193;8822.86765698515;41471.792641036904;41838.163236735396;41842.79078604618;41869;41889.79055104736;3322.5016247562817;3457.930841383158;3782.602826703184;4200.894977625553;4229.111886503838;31129;32697;32802.17994550132;33886.272510023875;34576.48135277973;4212.410262563244;4275.166342563201;4315.3095504719095;4326.805293761789;4382.233109205877;335436;335962;336855.3157234223;338265;340324;53638;59779.70110149421;59990.40009599936;60156.39843601508;60270.095948560804;53229;56844;56879.715601421725;60907.69546152241;62664.37335626585;16723.91638041802;17113.572160696083;17130.14349282556;17141.828581714024;17144.914275428542;13039.869601304055;13071.15037522558;13076.803847942288;13094.672633184247;13109.803352949713;17129.143542823058;18654.34709785151;19324.8067519323;19380.612387752448;19455.56805399325;7082.504224704221;7202.243764404767;7222.711091556279;7353.705851765976;7523.172451030382;979.2900147393083;1062.628080171949;1133.167122165208;1153.5270539078938;1160.3618010094415;32023.51964720531;32411;32608;32694.346113077605;33082.66917330796;1109.2013750099916;1125.2798209146154;1141.2068612314363;1183.7514122034297;1198.6823491774512;17201.31194752221;17358.91320543389;17418.303267869396;17420.390286339916;17524.824751752574;557503.549787014;557948;558623;562510;565834;57555;58149;58245;58291.708541457025;58298.41701583015;1338.9732205355838;1379.2138481065697;1379.6619828141968;1400.341839335531;1407.2260256858688;31056.68943310538;31135.84432077825;31397;31833.681663183073;31958.201044974063;49898.75050624869;50422.495775043244;50482.24276635927;50580.74709626575;50630.493695064055;455920;459799;460582;463066;464875;24284.635730463702;26517.60223596609;27245.455090898467;27562.173134805988;27772.722272777013;46465.303020455394;47279;47776;48284.517154828005;48718;41338.1732365345;41647;41741.37387939244;42683;42974;41191.7940410296;41476.1704765909;41526.584734152275;41847.37228941629;42088;41063.7946810276;41066;41566.37650435185;41823.163536729706;41994.37008444937;35235.82382088073;36378.98058955476;36477;37216;37614;27863.582046269727;27898.860505697343;27986.160415187576;27998;28239.717602823708 11:28:46 INFO - PROCESS | 13929 | |2;jquery.html;393.34311699461904;399.8780371986547;400.9138035322407;407.05969211122306;417.5841615584519;13926.164430134198;17724;18667;19168;19173.32893348733;18188.09059547024;18415.263389464406;18513.629727405445;18529.2588296468;18534.814651853478;5640.633358831673;5711.828645140652;5775.1337299405;5779.537636989031;5787.681677507735;4034.5360283567325;5515.896820635869;5694.487496125348;5702.77188912443;6151.907721384183;6380.170577824876;6404.263509696398;6411.0383442483535;6413.518986076039;6424.839379015515;6270.404311590391;6380.585261957958;6398.072279519467;6437.420632143129;6468.644224567671;5446.836594902159;5591.664500130005;5602.747876345574;5630.887382252332;5656.575756818214;21630.24294149713;22177.889110554344;22399.32802015942;22689.319320420414;22754.203602873986;2224.6996655451467;2326.732425771041;2392.605220138675;2413.8310318277727;2462.950740985188;13413.530526431528;13818.516351927634;13960.511382101678;14153.150810951376;14217;1815.7821061472575;1932.7294178814977;2000.0699674651212;2034.5727397246596;2074.2117995161893;80900.19099808985;82783.17216827815;83697.58151209205;84049.57975210146;84136.57931710302;10186.847197292047;10327.173826093895;10346;10682.465876706134;10740.087092597061;12803.743925121445;13441.529546465827;14314.713705726035;14667.266636668124;14676.3395647194;8023.4784738991775;8077.961019490255;8097.473664211808;8220.260176584135;8247.95876020616;7936.841263174704;7977.920220797718;8009.479383840032;8146.063202731643;8150.75547733569;6477.352264773485;6481.870362592722;6483.416492515602;6608.966955165193;6805.455563554904;1841.8894866308065;1888.1408958923657;1888.367396922019;1922.7596550431197;1952.375239923211;954.6420092465326;979.2410881566842;1018.180364806338;1074.570171931218;1091.0235339371218;18122.275108995756;18237.361692340703;18435.53911152232;18500.537486562942;18565;996.3772642098688;1000.8048430556117;1013.6654903881702;1037.4190453346;1046.9685909422576;10652.254342196127;10926.453677316102;11031.117510599133;11049.502772375263;11059.557617695202;461757;464800;466274;467107;469706;49953.25070123879;74952.62523687347;80885.59557202176;81465;81980;1047.910927571165;1072.0512346573182;1075.655790147161;1100.2078503477483;1105.9447027648584;16540.338386464406;16620.501384958472;16894.915525422293;16923;17176.484705458857;25664.615030774927;33865;34842.47736283907;37631.247375052895;40135.59864401319;50199.49800501948;52128.47871521236;52141.21788173256;52345.21482177694;52814.207786882456;8378.874316885374;8461.534615596202;8531.786705332417;8798.252148567188;8862.42394244372;12762.29807360604;12827.294498802656;12958.805617915927;13326.800097998732;13464.259465729087;11377.829332560184;11635;11723.35521546323;11890;11890.524379024742;11293.491792869176;11403.258788178742;11418.885811142114;11435.142364322543;11480.540778368771;11800.17398782077;11807.350595717318;11958.521659133885;12004.879951200377;12017.61797393276;8480.660773568989;8600.451918654702;8617.224449799549;8688.304935605263;8840;11703.414829258674;11708.590199342982;11716.531338746354;11798.882011179778;11941.46263418131 11:28:46 INFO - PROCESS | 13929 | |3;mootools.html;1383.4120498788025;1501.7822415749717;1509.622594351412;1695.9315631152372;1800.1359347513194;8350.540720260384;8590.699325523608;8602.09677983812;8615.009273933492;8762.21140097391;8037.598120094001;8277.793055173624;8396.664133434671;8397.370197235201;8399.370047246466;1953.7557805274341;2264.501809601893;2285.9771402286015;2319.93040208794;2347.0025239273327;2381.3927448500694;2381.6784734060852;2385.260569223546;2388.3073908566494;2388.9880550597222;2321.8374713770045;2378.1795280628244;2381.630562426603;2382.523495300938;2383.4518060846017;1949.892755898425;2267.444476103357;2338.5556744218543;2341.6955795746444;2362.6928499295154;2242.9551408971893;2244.708187935574;2249.80876625487;2257.7403598586206;2281.8744969026698;8691.478511289342;8780.64877404903;8804.383693141483;8813.338999574993;8827.602757875848;5205.297284866532;5349.545288650469;5357.142857142839;5357.571394288448;5358.946410535923;3183.586133802614;3283.3269179818317;3346.3474622448634;3352.2122301259183;3367.7979321240805;1162.96511104667;1166.4984056855549;1172.6657902497832;1189.5241903238687;1205.0957193164431;12149.088818338572;12474.81287780684;12484.313362765044;12498.687532811753;12535.059870509656;4531.22969095248;4690.624750019991;4763.785629646605;4774.95225047745;4781.976090119597;10515.42165180907;10519.789604207874;10529.736756581147;10552.736181595368;10608.628697995533;4592.563706447882;5389.164679474688;5402.729863506809;5405.648632838853;5407;4776.116418462596;4912.508749125131;4922.335484709519;4946.727929963887;4963.677360971526;4055.7363771354767;4084.1219137885496;4172.812223449952;4205.432266643964;4208.642265407413;1278.5834772280398;1319.706687446308;1325.357201757147;1327.9867201328057;1328.3823022294487;946.2808265718104;1040.8959104089681;1050.8266136087614;1055.3245922609535;1058.2116323339162;6171.228596425447;6205.751769929243;6271.466925311308;6272.874542509125;6484.865148598977;981.8870829854516;1018.511114664965;1028.4651980970004;1039.2777019971047;1056.4400867540216;4042.110735638155;4150.1284730207;4174.77038762871;4190.308599081118;4196.202721482909;10640.46797660114;10887.945560272306;10918.071963883;10935.125189984941;10947.233693641369;10376.584936602603;10796.244262901522;10838.945805270923;10872.293300935415;11109.166812488935;8134.877976830352;8212.425130240945;8294;8302.045264794626;8305.252527272454;6140.508759299335;6217.316095229431;6255.186825712628;6376.808695739135;6538.378854008862;10091.192704583762;10134.898651013396;10180.083792458714;10398.636047738293;10413.583456661649;10122.291439599452;10425.061744443037;10465;10471.057604815298;10485.108765754996;6915.412189963909;6991.965040174767;7091.503594748525;7953.880691789512;8108.918910810817;7883.881741773764;8370.916290837014;8390.790230244293;8589.742307730778;8634.30925525969;7699.307062364414;7873.291403773688;7894.644740986554;7907.288344049063;7943.682252709827;7630.847383052197;7695.615219238904;7749.535027898344;7757.612119394121;7974.641141148778;7156.570605763671;7190.532615379983;7225;7227.891581626174;7231.4937954342695;5164.535191832753;5305.098133317422;5356.303680521507;5448.891022179613;5516.806911758069;5249.842504724865;5304.814331498379;5435.782568697208;5597.412271711411;5664.122061080539 11:28:46 INFO - PROCESS | 13929 | |4;prototype.html;311.6851979500704;316.28361760612216;318.82783297019625;319.1844836442889;323.16300780977264;5226.137687281599;5237.47625237477;5250.396204436491;5251.422343542207;5273.261743355928;5152.51051150141;5174.508421699942;5187.170052791555;5190.896182076356;5194.71429071401;3815.9124649474907;3845.0771814764535;3994.800259986989;4007.5792041835625;4010.4786377770847;3986.3621820508724;3992.6207010333974;3993.381025940984;4020.5778393268724;4032.475778148851;3821.273957947995;3942.684585233189;3944.9408258876138;3984.342583473723;3984.346496204086;3893.279743247494;3990.8004599770043;4005.178938317638;4011;4012.979935100335;3504.5969713483023;3520.5423294971747;3524.84138213781;3526.664966828173;3526.783259775399;4949.851504454872;4972.941640890826;4978.6514943953935;4982.626303027288;4986.626003049786;4454.198244316021;4493.820247190109;4497.2129877271345;4538.3873177120995;4566.611837993774;5303.602229832778;5307.177387504943;5329.733513324319;5364.544013758835;5367.865803354908;3891.5330160380936;3912.628300311466;3913.902152446183;3914.667253283474;3917.334053210961;5483.972580137074;5489.917651235235;5506.697131657757;5633.239512665778;5636.49271565557;3963.6630886374405;3969.325214713506;3985.1830374773103;3987.2424239394422;3992.301347264217;3946.131850992777;3958.267720471722;3989.6608788252743;4001.3397789365013;4032.1734044520804;4394.538573449741;4562.498125206224;4573.382593349922;4575.58819706228;4591.219492686251;5381.90540439249;5396.730163491889;5416;5419.132938729863;5426.647267927572;1370.7532644124153;1373.3613869550707;1375.4910683047137;1380.8895288376905;1380.9792853107213;886.4769785826264;896.5248418338291;929.177677755178;955.1976339874539;959.4051687953513;5237.450067742909;5253.605979551549;5258.553022993088;5273.419923808378;5283.735813209324;5576.553875689935;5582.49757521825;5588.133839254922;5591.217229587861;5596.384397716248;5030.522100400529;5111.131107711698;5139.743012849342;5224;5250.873396274438;2908.75275601572;2915.454808951217;2932.765378769736;2937.7062293770878;2963.985180074129;5470.671759694431;5647.599770097774;5649.265595472562;5679.744411501492;5682.488576028095;5615;5634.408387119375;5638.210650508932;5642.887142257214;5649.265595472562;5625.71871406428;5656.575756818255;5663.830085097454;5678.829635110953;5689;5243.344581927259;5480.780768769205;5496.615236933376;5525.972370138124;5530.419305972976;5380.677159370451;5454.91817622728;5457.345118585795;5466.808661696821;5471.316085489314;5642.520385767256;5644.6613203207935;5696.857578560403;5697.173909782975;5714.342850572238;3862.845486180521;3928.489296391451;3947.1513624570857;3955.7428767130045;3964.5638979712785;5447.155690867922;5469.72651367438;5526.181647359795;5526.447355264441;5528;5332.013577488177;5343.385510666168;5355.410904800391;5376.946230537801;5382.327209098863;5180.585553155664;5415.702136382537;5428.755705993319;5429.104197807317;5437.646552974044;5150.613703972292;5287.937704295405;5323.243329701267;5333.333333333333;5344.438833922382;5486.902619476041;5514.338279406497;5531.834044978496;5532.944670553243;5535.3634332050715;5383.515483606494;5400.540954018952;5413.377461591967;5417.214503896992;5453.536449401845 11:28:46 INFO - PROCESS | 13929 | |5;yui.html;726.5858460677416;765.3150430364824;787.7085478373003;819.4018366592387;843.135785819535;14735.926320368397;15574.84425155748;15584.92207538962;15635;15659.921700391496;14903.552893413187;15009.399624015054;15022.849771502282;15046.473373431932;15047.473338433158;671.4225765841372;787.3858390455425;808.5552945879772;811.0186674124317;816.408104124508;805.9113497515298;810.7527204202715;813.4793732011517;813.9064007639138;814.0353680888137;845.1970627903486;852.5694524265238;854.662408348705;854.974350769478;856.4604299291437;701.8771714949889;836.7406104107715;857.789841488833;859.0250066174905;859.6260626627437;635.8601107756286;636.2651137935692;636.9299377068519;637.0285314894776;637.2703254773305;15334.386624535005;15387.615309617237;15388.15365154916;15409;15419.460318888898;13776.793348099687;13951.790723139162;13963.930180349033;14006.299685015709;14064.367103480368;12404.937975310157;12556.937215313865;12598.622041338775;12602.81095783564;13161.407736651874;4361.978190109029;4407.140607581523;4414.867553973386;4503.48209955856;4537.160625284333;72387.63806180988;72982.27017729808;73008;73134;73352.63323683401;10942.56229750817;11107.666769996913;11122.277051991594;11252.887471125185;11301.32192068462;20933.37199884006;20934.057967391505;20942.162313507288;20945;20974;8145.633446494922;8197.836043279101;8259.050209226016;8364.121767214476;8576.699815506427;4484.215262329079;4502.549745025472;4506.8103131851285;4610.792514336863;4629.513901040342;3174.1271150433354;3260.6576309487164;3262.4943133814295;3267.7222436092725;3286.5891763529557;519.2082074835905;613.141601757543;637.974481020754;647.5920170292779;651.9837004074936;670.9329067093349;754.2457542457543;766.8581312457213;770.1335997003371;780.980475488106;9928.979595882593;10099.987092033753;10189.439580822978;10325.070743633109;10452.581896724047;584.6725833533235;705.6507029020565;742.5730205132071;745.434587366526;746.4438992950287;4674.883127921761;4839.128956787812;4867.196912509467;4890.535399137077;4918.213085906238;50492.49507504878;50873.23690144651;50926.49073509291;59280;73332;65091.67454162699;66670.33329666738;81982;99441.50279248557;99617.50191248997;79698.6015069921;93254;95132;95698.52150739201;96021.51989240009;8993.325500587613;9331.206847418045;9360.672376466791;9466.810663786548;9524.95237523808;51489;52846.20730688966;52891;53435.122077047425;55114.448855510935;73161;81760.36479270262;82254;82541.17458825334;84708.57645711732;12766.936165319114;12807.551735689207;13096.017798665329;13103.344832758514;13120.60638180856;12621.305828179171;13051.869481305444;13108.2135071896;13415.731685366043;13823.654408639864;12662.810057848956;12707.80938285945;12815.807762883751;13017.804732928824;14582;13394.397252123872;13925.791113133513;14110.717785644025;14390.712185756436;14506.347214375168;13736.175829450265;13805.792913106512;13931.164130152223;13961.371738271599;14038.508652197532;11655.650330490098;11713.238639488405;11742.70643233926;11853.288802671867;12185.51257949672;11923.642290731292;11928.701782455508;12004.459799308877;12050.939745301568;12222.816657750318 11:28:46 INFO - PROCESS | 13929 | __end_tp_report 11:28:46 INFO - PROCESS | 13929 | __start_cc_report 11:28:46 INFO - PROCESS | 13929 | _x_x_mozilla_cycle_collect,1118 11:28:46 INFO - PROCESS | 13929 | __end_cc_report 11:28:46 INFO - PROCESS | 13929 | __startTimestamp1465410526575__endTimestamp 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | ------- Summary: start ------- 11:28:46 INFO - PROCESS | 13929 | Number of tests: 6 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#0] dojo.html Cycles:165 Average:5277.02 Median:5426.19 stddev:597.48 (11.0%) stddev-sans-first:574.96 11:28:46 INFO - PROCESS | 13929 | Values: 3124.9 3138.4 3144.7 3171.2 3195.4 5185.7 5206.9 5234.5 5296.0 5317.7 5237.2 5286.9 5300.5 5340.4 5341.4 4771.8 4829.8 4937.1 4988.9 5039.0 4924.0 4945.8 4961.5 4962.0 4970.8 4591.2 4658.6 4754.8 4853.4 4863.2 4826.3 4834.2 4840.9 4846.0 4877.4 4763.4 4807.1 4824.8 4832.8 4874.0 5052.6 5091.0 5149.2 5227.6 5247.8 5553.4 5757.3 5769.0 5770.3 5777.9 5804.7 5811.5 5824.1 5829.8 5830.6 5122.9 5308.7 5386.2 5398.1 5426.2 5922.7 5923.0 5936.6 5937.3 5940.8 5687.3 5692.1 5732.7 5740.3 5740.4 5491.8 5552.7 5556.4 5591.3 5639.4 5638.5 5710.4 5716.8 5726.9 5767.8 5642.0 5715.2 5723.9 5730.7 5731.7 4227.1 4243.6 4344.0 4374.8 4419.5 3868.6 3875.1 3878.9 3904.0 3906.2 5323.4 5325.8 5403.1 5408.6 5436.2 5436.4 5590.6 5653.9 5662.9 5734.7 5318.5 5329.8 5339.5 5340.2 5353.3 4815.2 4817.5 4834.0 4835.7 4875.5 5630.1 5807.0 5893.7 5913.9 5930.2 5763.4 5793.2 5801.5 5801.7 5808.2 5653.3 5912.6 5933.7 5940.1 5948.8 5499.6 5562.3 5579.4 5626.4 5672.9 5692.5 5694.2 5696.7 5699.5 5709.2 5376.1 5486.0 5548.9 5557.6 5561.5 5397.5 5445.0 5447.3 5497.8 5503.7 5366.9 5397.9 5398.4 5398.6 5401.9 5403.3 5469.8 5539.0 5577.9 5589.6 5407.2 5432.1 5434.7 5458.7 5540.8 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#1] ext.html Cycles:180 Average:61232.75 Median:23144.45 stddev:122677.82 (530.1%) stddev-sans-first:122937.48 11:28:46 INFO - PROCESS | 13929 | Values: 594.6 616.3 631.1 631.4 637.3 30671.8 43183.0 44074.3 44206.0 44403.0 44982.0 45483.8 45633.8 45643.5 45645.5 8698.4 8882.0 8884.2 8887.1 8888.9 8773.1 8935.8 8936.2 8938.8 8941.3 8998.9 9064.0 9065.8 9066.0 9067.3 8866.4 8985.7 8991.9 8994.0 9005.8 8705.3 8810.7 8812.0 8819.1 8822.9 41471.8 41838.2 41842.8 41869.0 41889.8 3322.5 3457.9 3782.6 4200.9 4229.1 31129.0 32697.0 32802.2 33886.3 34576.5 4212.4 4275.2 4315.3 4326.8 4382.2 335436.0 335962.0 336855.3 338265.0 340324.0 53638.0 59779.7 59990.4 60156.4 60270.1 53229.0 56844.0 56879.7 60907.7 62664.4 16723.9 17113.6 17130.1 17141.8 17144.9 13039.9 13071.2 13076.8 13094.7 13109.8 17129.1 18654.3 19324.8 19380.6 19455.6 7082.5 7202.2 7222.7 7353.7 7523.2 979.3 1062.6 1133.2 1153.5 1160.4 32023.5 32411.0 32608.0 32694.3 33082.7 1109.2 1125.3 1141.2 1183.8 1198.7 17201.3 17358.9 17418.3 17420.4 17524.8 557503.5 557948.0 558623.0 562510.0 565834.0 57555.0 58149.0 58245.0 58291.7 58298.4 1339.0 1379.2 1379.7 1400.3 1407.2 31056.7 31135.8 31397.0 31833.7 31958.2 49898.8 50422.5 50482.2 50580.7 50630.5 455920.0 459799.0 460582.0 463066.0 464875.0 24284.6 26517.6 27245.5 27562.2 27772.7 46465.3 47279.0 47776.0 48284.5 48718.0 41338.2 41647.0 41741.4 42683.0 42974.0 41191.8 41476.2 41526.6 41847.4 42088.0 41063.8 41066.0 41566.4 41823.2 41994.4 35235.8 36379.0 36477.0 37216.0 37614.0 27863.6 27898.9 27986.2 27998.0 28239.7 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#2] jquery.html Cycles:180 Average:27539.20 Median:22544.32 stddev:76560.66 (339.6%) stddev-sans-first:76748.30 11:28:46 INFO - PROCESS | 13929 | Values: 393.3 399.9 400.9 407.1 417.6 13926.2 17724.0 18667.0 19168.0 19173.3 18188.1 18415.3 18513.6 18529.3 18534.8 5640.6 5711.8 5775.1 5779.5 5787.7 4034.5 5515.9 5694.5 5702.8 6151.9 6380.2 6404.3 6411.0 6413.5 6424.8 6270.4 6380.6 6398.1 6437.4 6468.6 5446.8 5591.7 5602.7 5630.9 5656.6 21630.2 22177.9 22399.3 22689.3 22754.2 2224.7 2326.7 2392.6 2413.8 2463.0 13413.5 13818.5 13960.5 14153.2 14217.0 1815.8 1932.7 2000.1 2034.6 2074.2 80900.2 82783.2 83697.6 84049.6 84136.6 10186.8 10327.2 10346.0 10682.5 10740.1 12803.7 13441.5 14314.7 14667.3 14676.3 8023.5 8078.0 8097.5 8220.3 8248.0 7936.8 7977.9 8009.5 8146.1 8150.8 6477.4 6481.9 6483.4 6609.0 6805.5 1841.9 1888.1 1888.4 1922.8 1952.4 954.6 979.2 1018.2 1074.6 1091.0 18122.3 18237.4 18435.5 18500.5 18565.0 996.4 1000.8 1013.7 1037.4 1047.0 10652.3 10926.5 11031.1 11049.5 11059.6 461757.0 464800.0 466274.0 467107.0 469706.0 49953.3 74952.6 80885.6 81465.0 81980.0 1047.9 1072.1 1075.7 1100.2 1105.9 16540.3 16620.5 16894.9 16923.0 17176.5 25664.6 33865.0 34842.5 37631.2 40135.6 50199.5 52128.5 52141.2 52345.2 52814.2 8378.9 8461.5 8531.8 8798.3 8862.4 12762.3 12827.3 12958.8 13326.8 13464.3 11377.8 11635.0 11723.4 11890.0 11890.5 11293.5 11403.3 11418.9 11435.1 11480.5 11800.2 11807.4 11958.5 12004.9 12017.6 8480.7 8600.5 8617.2 8688.3 8840.0 11703.4 11708.6 11716.5 11798.9 11941.5 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#3] mootools.html Cycles:180 Average:5850.38 Median:4200.82 stddev:3292.20 (78.4%) stddev-sans-first:3284.32 11:28:46 INFO - PROCESS | 13929 | Values: 1383.4 1501.8 1509.6 1695.9 1800.1 8350.5 8590.7 8602.1 8615.0 8762.2 8037.6 8277.8 8396.7 8397.4 8399.4 1953.8 2264.5 2286.0 2319.9 2347.0 2381.4 2381.7 2385.3 2388.3 2389.0 2321.8 2378.2 2381.6 2382.5 2383.5 1949.9 2267.4 2338.6 2341.7 2362.7 2243.0 2244.7 2249.8 2257.7 2281.9 8691.5 8780.6 8804.4 8813.3 8827.6 5205.3 5349.5 5357.1 5357.6 5358.9 3183.6 3283.3 3346.3 3352.2 3367.8 1163.0 1166.5 1172.7 1189.5 1205.1 12149.1 12474.8 12484.3 12498.7 12535.1 4531.2 4690.6 4763.8 4775.0 4782.0 10515.4 10519.8 10529.7 10552.7 10608.6 4592.6 5389.2 5402.7 5405.6 5407.0 4776.1 4912.5 4922.3 4946.7 4963.7 4055.7 4084.1 4172.8 4205.4 4208.6 1278.6 1319.7 1325.4 1328.0 1328.4 946.3 1040.9 1050.8 1055.3 1058.2 6171.2 6205.8 6271.5 6272.9 6484.9 981.9 1018.5 1028.5 1039.3 1056.4 4042.1 4150.1 4174.8 4190.3 4196.2 10640.5 10887.9 10918.1 10935.1 10947.2 10376.6 10796.2 10838.9 10872.3 11109.2 8134.9 8212.4 8294.0 8302.0 8305.3 6140.5 6217.3 6255.2 6376.8 6538.4 10091.2 10134.9 10180.1 10398.6 10413.6 10122.3 10425.1 10465.0 10471.1 10485.1 6915.4 6992.0 7091.5 7953.9 8108.9 7883.9 8370.9 8390.8 8589.7 8634.3 7699.3 7873.3 7894.6 7907.3 7943.7 7630.8 7695.6 7749.5 7757.6 7974.6 7156.6 7190.5 7225.0 7227.9 7231.5 5164.5 5305.1 5356.3 5448.9 5516.8 5249.8 5304.8 5435.8 5597.4 5664.1 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#4] prototype.html Cycles:180 Average:4540.10 Median:5250.63 stddev:1336.93 (25.5%) stddev-sans-first:1302.46 11:28:46 INFO - PROCESS | 13929 | Values: 311.7 316.3 318.8 319.2 323.2 5226.1 5237.5 5250.4 5251.4 5273.3 5152.5 5174.5 5187.2 5190.9 5194.7 3815.9 3845.1 3994.8 4007.6 4010.5 3986.4 3992.6 3993.4 4020.6 4032.5 3821.3 3942.7 3944.9 3984.3 3984.3 3893.3 3990.8 4005.2 4011.0 4013.0 3504.6 3520.5 3524.8 3526.7 3526.8 4949.9 4972.9 4978.7 4982.6 4986.6 4454.2 4493.8 4497.2 4538.4 4566.6 5303.6 5307.2 5329.7 5364.5 5367.9 3891.5 3912.6 3913.9 3914.7 3917.3 5484.0 5489.9 5506.7 5633.2 5636.5 3963.7 3969.3 3985.2 3987.2 3992.3 3946.1 3958.3 3989.7 4001.3 4032.2 4394.5 4562.5 4573.4 4575.6 4591.2 5381.9 5396.7 5416.0 5419.1 5426.6 1370.8 1373.4 1375.5 1380.9 1381.0 886.5 896.5 929.2 955.2 959.4 5237.5 5253.6 5258.6 5273.4 5283.7 5576.6 5582.5 5588.1 5591.2 5596.4 5030.5 5111.1 5139.7 5224.0 5250.9 2908.8 2915.5 2932.8 2937.7 2964.0 5470.7 5647.6 5649.3 5679.7 5682.5 5615.0 5634.4 5638.2 5642.9 5649.3 5625.7 5656.6 5663.8 5678.8 5689.0 5243.3 5480.8 5496.6 5526.0 5530.4 5380.7 5454.9 5457.3 5466.8 5471.3 5642.5 5644.7 5696.9 5697.2 5714.3 3862.8 3928.5 3947.2 3955.7 3964.6 5447.2 5469.7 5526.2 5526.4 5528.0 5332.0 5343.4 5355.4 5376.9 5382.3 5180.6 5415.7 5428.8 5429.1 5437.6 5150.6 5287.9 5323.2 5333.3 5344.4 5486.9 5514.3 5531.8 5532.9 5535.4 5383.5 5400.5 5413.4 5417.2 5453.5 11:28:46 INFO - PROCESS | 13929 | 11:28:46 INFO - PROCESS | 13929 | [#5] yui.html Cycles:180 Average:19052.64 Median:4853.16 stddev:25705.59 (529.7%) stddev-sans-first:25740.87 11:28:46 INFO - PROCESS | 13929 | Values: 726.6 765.3 787.7 819.4 843.1 14735.9 15574.8 15584.9 15635.0 15659.9 14903.6 15009.4 15022.8 15046.5 15047.5 671.4 787.4 808.6 811.0 816.4 805.9 810.8 813.5 813.9 814.0 845.2 852.6 854.7 855.0 856.5 701.9 836.7 857.8 859.0 859.6 635.9 636.3 636.9 637.0 637.3 15334.4 15387.6 15388.2 15409.0 15419.5 13776.8 13951.8 13963.9 14006.3 14064.4 12404.9 12556.9 12598.6 12602.8 13161.4 4362.0 4407.1 4414.9 4503.5 4537.2 72387.6 72982.3 73008.0 73134.0 73352.6 10942.6 11107.7 11122.3 11252.9 11301.3 20933.4 20934.1 20942.2 20945.0 20974.0 8145.6 8197.8 8259.1 8364.1 8576.7 4484.2 4502.5 4506.8 4610.8 4629.5 3174.1 3260.7 3262.5 3267.7 3286.6 519.2 613.1 638.0 647.6 652.0 670.9 754.2 766.9 770.1 781.0 9929.0 10100.0 10189.4 10325.1 10452.6 584.7 705.7 742.6 745.4 746.4 4674.9 4839.1 4867.2 4890.5 4918.2 50492.5 50873.2 50926.5 59280.0 73332.0 65091.7 66670.3 81982.0 99441.5 99617.5 79698.6 93254.0 95132.0 95698.5 96021.5 8993.3 9331.2 9360.7 9466.8 9525.0 51489.0 52846.2 52891.0 53435.1 55114.4 73161.0 81760.4 82254.0 82541.2 84708.6 12766.9 12807.6 13096.0 13103.3 13120.6 12621.3 13051.9 13108.2 13415.7 13823.7 12662.8 12707.8 12815.8 13017.8 14582.0 13394.4 13925.8 14110.7 14390.7 14506.3 13736.2 13805.8 13931.2 13961.4 14038.5 11655.7 11713.2 11742.7 11853.3 12185.5 11923.6 11928.7 12004.5 12050.9 12222.8 11:28:46 INFO - PROCESS | 13929 | -------- Summary: end -------- 11:28:46 INFO - PROCESS | 13929 | 11:28:47 INFO - TEST-INFO | 13929: exit 0 11:28:47 INFO - TEST-OK | dromaeo_css | took 1115742ms 11:28:47 INFO - TEST-START | kraken 11:28:47 INFO - operating with platform_type : linux_ 11:28:47 INFO - Initialising browser for kraken test... 11:28:47 INFO - TEST-INFO | started process 14108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBe4OuB/profile http://localhost:38670/getInfo.html) 11:28:52 INFO - PROCESS | 14108 | __metrics Screen width/height:1600/1200 11:28:52 INFO - PROCESS | 14108 | colorDepth:24 11:28:52 INFO - PROCESS | 14108 | Browser inner width/height: 1024/697 11:28:52 INFO - PROCESS | 14108 | __metrics 11:28:53 ERROR - PROCESS | 14108 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:28:53 INFO - PROCESS | 14108 | console.error: PushService: 11:28:53 INFO - PROCESS | 14108 | stateChangeProcessEnqueue: Error transitioning state 11:28:53 INFO - PROCESS | 14108 | UnknownError 11:28:54 INFO - TEST-INFO | 14108: exit 0 11:28:54 INFO - Browser initialized. 11:28:54 INFO - Running cycle 1/1 for kraken test... 11:28:54 INFO - TEST-INFO | started process 14190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBe4OuB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:06 INFO - PROCESS | 14190 | RSS: Main: 160555008 11:29:06 INFO - PROCESS | 14190 | 11:29:08 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38670/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:09 INFO - PROCESS | 14190 | RSS: Main: 218537984 11:29:09 INFO - PROCESS | 14190 | 11:29:12 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38670/tests/kraken/driver.html?testName=audio-dft) 11:29:13 INFO - PROCESS | 14190 | RSS: Main: 201555968 11:29:13 INFO - PROCESS | 14190 | 11:29:16 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38670/tests/kraken/driver.html?testName=audio-fft) 11:29:16 INFO - PROCESS | 14190 | RSS: Main: 272203776 11:29:16 INFO - PROCESS | 14190 | 11:29:18 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38670/tests/kraken/driver.html?testName=audio-oscillator) 11:29:19 INFO - PROCESS | 14190 | RSS: Main: 182792192 11:29:19 INFO - PROCESS | 14190 | 11:29:21 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:22 INFO - PROCESS | 14190 | RSS: Main: 187174912 11:29:22 INFO - PROCESS | 14190 | 11:29:25 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38670/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:25 INFO - PROCESS | 14190 | RSS: Main: 221642752 11:29:25 INFO - PROCESS | 14190 | 11:29:29 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38670/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:29 INFO - PROCESS | 14190 | RSS: Main: 224059392 11:29:29 INFO - PROCESS | 14190 | 11:29:32 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38670/tests/kraken/driver.html?testName=json-parse-financial) 11:29:33 INFO - PROCESS | 14190 | RSS: Main: 224866304 11:29:33 INFO - PROCESS | 14190 | 11:29:34 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:35 INFO - PROCESS | 14190 | RSS: Main: 209485824 11:29:35 INFO - PROCESS | 14190 | 11:29:37 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:37 INFO - PROCESS | 14190 | RSS: Main: 213123072 11:29:37 INFO - PROCESS | 14190 | 11:29:39 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:40 INFO - PROCESS | 14190 | RSS: Main: 217501696 11:29:40 INFO - PROCESS | 14190 | 11:29:42 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:43 INFO - PROCESS | 14190 | RSS: Main: 222355456 11:29:43 INFO - PROCESS | 14190 | 11:29:46 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:46 INFO - PROCESS | 14190 | RSS: Main: 220688384 11:29:46 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | Cycle 1(1): loaded http://localhost:38670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38670/tests/kraken/driver.html?testName=ai-astar) 11:29:48 INFO - PROCESS | 14190 | RSS: Main: 263053312 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | __start_tp_report 11:29:48 INFO - PROCESS | 14190 | _x_x_mozilla_page_load 11:29:48 INFO - PROCESS | 14190 | _x_x_mozilla_page_load_details 11:29:48 INFO - PROCESS | 14190 | |i|pagename|runs| 11:29:48 INFO - PROCESS | 14190 | |0;ai-astar;109;104;110;109;110;109;109;109;109;108 11:29:48 INFO - PROCESS | 14190 | |1;audio-beat-detection;153;125;128;180;131;129;157;127;156;127 11:29:48 INFO - PROCESS | 14190 | |2;audio-dft;162;163;162;162;162;161;161;162;163;162 11:29:48 INFO - PROCESS | 14190 | |3;audio-fft;75;74;75;110;75;75;74;76;103;74 11:29:48 INFO - PROCESS | 14190 | |4;audio-oscillator;86;85;113;85;85;85;123;87;85;121 11:29:48 INFO - PROCESS | 14190 | |5;imaging-gaussian-blur;117;117;116;117;117;116;118;117;117;117 11:29:48 INFO - PROCESS | 14190 | |6;imaging-darkroom;146;146;145;146;146;145;146;147;146;145 11:29:48 INFO - PROCESS | 14190 | |7;imaging-desaturate;95;95;95;94;95;96;96;95;94;95 11:29:48 INFO - PROCESS | 14190 | |8;json-parse-financial;54;53;54;54;54;53;53;53;54;55 11:29:48 INFO - PROCESS | 14190 | |9;json-stringify-tinderbox;62;63;61;62;63;62;63;62;62;62 11:29:48 INFO - PROCESS | 14190 | |10;stanford-crypto-aes;80;79;83;82;80;87;84;81;112;80 11:29:48 INFO - PROCESS | 14190 | |11;stanford-crypto-ccm;122;122;123;119;123;122;129;121;128;130 11:29:48 INFO - PROCESS | 14190 | |12;stanford-crypto-pbkdf2;160;160;168;164;159;162;175;164;162;162 11:29:48 INFO - PROCESS | 14190 | |13;stanford-crypto-sha256-iterative;63;62;64;63;64;64;67;66;62;62 11:29:48 INFO - PROCESS | 14190 | __end_tp_report 11:29:48 INFO - PROCESS | 14190 | __start_cc_report 11:29:48 INFO - PROCESS | 14190 | _x_x_mozilla_cycle_collect,1620 11:29:48 INFO - PROCESS | 14190 | __end_cc_report 11:29:48 INFO - PROCESS | 14190 | __startTimestamp1465410588887__endTimestamp 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | ------- Summary: start ------- 11:29:48 INFO - PROCESS | 14190 | Number of tests: 14 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.71 (1.6%) stddev-sans-first:1.81 11:29:48 INFO - PROCESS | 14190 | Values: 109.0 104.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 108.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:142.00 stddev:18.87 (13.3%) stddev-sans-first:19.54 11:29:48 INFO - PROCESS | 14190 | Values: 153.0 125.0 128.0 180.0 131.0 129.0 157.0 127.0 156.0 127.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:29:48 INFO - PROCESS | 14190 | Values: 162.0 163.0 162.0 162.0 162.0 161.0 161.0 162.0 163.0 162.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.50 (18.0%) stddev-sans-first:14.14 11:29:48 INFO - PROCESS | 14190 | Values: 75.0 74.0 75.0 110.0 75.0 75.0 74.0 76.0 103.0 74.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.42 (19.3%) stddev-sans-first:17.05 11:29:48 INFO - PROCESS | 14190 | Values: 86.0 85.0 113.0 85.0 85.0 85.0 123.0 87.0 85.0 121.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:29:48 INFO - PROCESS | 14190 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 118.0 117.0 117.0 117.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:29:48 INFO - PROCESS | 14190 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:29:48 INFO - PROCESS | 14190 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 96.0 95.0 94.0 95.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 11:29:48 INFO - PROCESS | 14190 | Values: 54.0 53.0 54.0 54.0 54.0 53.0 53.0 53.0 54.0 55.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 11:29:48 INFO - PROCESS | 14190 | Values: 62.0 63.0 61.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.50 stddev:9.85 (12.1%) stddev-sans-first:10.30 11:29:48 INFO - PROCESS | 14190 | Values: 80.0 79.0 83.0 82.0 80.0 87.0 84.0 81.0 112.0 80.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:123.00 stddev:3.73 (3.0%) stddev-sans-first:3.89 11:29:48 INFO - PROCESS | 14190 | Values: 122.0 122.0 123.0 119.0 123.0 122.0 129.0 121.0 128.0 130.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.00 stddev:4.77 (2.9%) stddev-sans-first:4.87 11:29:48 INFO - PROCESS | 14190 | Values: 160.0 160.0 168.0 164.0 159.0 162.0 175.0 164.0 162.0 162.0 11:29:48 INFO - PROCESS | 14190 | 11:29:48 INFO - PROCESS | 14190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 11:29:48 INFO - PROCESS | 14190 | Values: 63.0 62.0 64.0 63.0 64.0 64.0 67.0 66.0 62.0 62.0 11:29:48 INFO - PROCESS | 14190 | -------- Summary: end -------- 11:29:48 INFO - PROCESS | 14190 | 11:29:49 INFO - TEST-INFO | 14190: exit 0 11:29:49 INFO - TEST-OK | kraken | took 62534ms 11:29:49 INFO - SUITE-END | took 1178s 11:29:50 INFO - Completed test suite (00:19:38) 11:29:50 INFO - javascript benchmark 11:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.8750049997993, 3138.3723255348937, 3144.701253380929, 3171.191346206717, 3195.3928753536843, 5185.714785686786, 5206.947930520693, 5234.450382709808, 5296.0, 5317.734113294339, 5237.240600112981, 5286.947130528693, 5300.549453296465, 5340.385855626594, 5341.439148889369, 4771.761411929407, 4829.830955916544, 4937.111319962405, 4988.925166122511, 5039.017391608638, 4923.9753801230945, 4945.7774400152075, 4961.479044700309, 4961.950380496203, 4970.776315065813, 4591.242444996605, 4658.627309815207, 4754.762261886909, 4853.3690620219495, 4863.197572400567, 4826.348442960226, 4834.178189707723, 4840.878978025542, 4846.030793841246, 4877.439094504142, 4763.404574428197, 4807.11068452334, 4824.831130910401, 4832.7825247863575, 4873.951260487421, 5052.646314757969, 5091.0, 5149.227615857614, 5227.634065615409, 5247.790088396459, 5553.444655534414, 5757.251557297566, 5769.0192667246665, 5770.307563092414, 5777.88444231113, 5804.65172089676, 5811.535077193815, 5824.126381042835, 5829.795957141479, 5830.621009634403, 5122.948770512285, 5308.734563271821, 5386.245925570423, 5398.082326004589, 5426.186072089218, 5922.703864806743, 5923.022701254245, 5936.643801371932, 5937.2578427696535, 5940.762369505258, 5687.260656114761, 5692.117721753135, 5732.742026608813, 5740.311162660424, 5740.397258287903, 5491.780328786884, 5552.694601796859, 5556.416576259516, 5591.273134492571, 5639.351474580394, 5638.464345887134, 5710.428957104256, 5716.828495145152, 5726.942730572724, 5767.826965191051, 5642.0, 5715.199872017921, 5723.885522289531, 5730.713464326767, 5731.713414329267, 4227.091175397304, 4243.596858298457, 4343.978280108642, 4374.803133858984, 4419.513853476115, 3868.574456809749, 3875.1280961783937, 3878.9224215516097, 3904.0, 3906.2187562487616, 5323.387810401776, 5325.813596524103, 5403.081476149064, 5408.648437851527, 5436.184572314105, 5436.401995780461, 5590.636608620427, 5653.9151912721345, 5662.943370566241, 5734.713264336767, 5318.521333080042, 5329.786808527616, 5339.46605339463, 5340.225667278223, 5353.250544923714, 4815.2054910939305, 4817.542333478314, 4834.033193361342, 4835.709857408567, 4875.5124487551675, 5630.127330263816, 5807.0, 5893.734781934823, 5913.881722365529, 5930.199423077829, 5763.394843541368, 5793.15999180125, 5801.506871915765, 5801.680907550125, 5808.244928159481, 5653.349864765604, 5912.556558258062, 5933.732982015906, 5940.108983652314, 5948.821535353946, 5499.560035197094, 5562.3047119110115, 5579.358373786904, 5626.38109807929, 5672.858178545404, 5692.48767610917, 5694.231278777478, 5696.715164241688, 5699.487046165865, 5709.22925405065, 5376.112941364631, 5486.0, 5548.916766248429, 5557.583181261502, 5561.499465048165, 5397.487238712316, 5444.972775136257, 5447.346318441812, 5497.835064948058, 5503.669779813224, 5366.865828354323, 5397.892042159214, 5398.379186393615, 5398.568114550748, 5401.945980540144, 5403.297571315704, 5469.808556700496, 5538.972305138448, 5577.888442231051, 5589.580781441489, 5407.188921661625, 5432.103702888979, 5434.673919564839, 5458.6724796512335, 5540.778368865362], "value": 5237.610826559556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.6342999055579, 616.2635650397776, 631.1227393922447, 631.3686313686313, 637.273508200651, 30671.84664076679, 43183.0, 44074.33888491671, 44206.0, 44403.0, 44982.0, 45483.77258113705, 45633.77183114088, 45643.543564564345, 45645.54354456454, 8698.39111262212, 8882.0, 8884.200421962023, 8887.066857979917, 8888.866667, 8773.078826723198, 8935.77660558488, 8936.151065648754, 8938.776530586754, 8941.329400294971, 8998.910010899872, 9064.0, 9065.773355666095, 9066.048064953184, 9067.319951003668, 8866.423682460652, 8985.6855010075, 8991.910080899173, 8994.0, 9005.77485562863, 8705.303575713928, 8810.69162579313, 8812.0, 8819.118088191193, 8822.86765698515, 41471.792641036904, 41838.163236735396, 41842.79078604618, 41869.0, 41889.79055104736, 3322.5016247562817, 3457.930841383158, 3782.602826703184, 4200.894977625553, 4229.111886503838, 31129.0, 32697.0, 32802.17994550132, 33886.272510023875, 34576.48135277973, 4212.410262563244, 4275.166342563201, 4315.3095504719095, 4326.805293761789, 4382.233109205877, 335436.0, 335962.0, 336855.3157234223, 338265.0, 340324.0, 53638.0, 59779.70110149421, 59990.40009599936, 60156.39843601508, 60270.095948560804, 53229.0, 56844.0, 56879.715601421725, 60907.69546152241, 62664.37335626585, 16723.91638041802, 17113.572160696083, 17130.14349282556, 17141.828581714024, 17144.914275428542, 13039.869601304055, 13071.15037522558, 13076.803847942288, 13094.672633184247, 13109.803352949713, 17129.143542823058, 18654.34709785151, 19324.8067519323, 19380.612387752448, 19455.56805399325, 7082.504224704221, 7202.243764404767, 7222.711091556279, 7353.705851765976, 7523.172451030382, 979.2900147393083, 1062.628080171949, 1133.167122165208, 1153.5270539078938, 1160.3618010094415, 32023.51964720531, 32411.0, 32608.0, 32694.346113077605, 33082.66917330796, 1109.2013750099916, 1125.2798209146154, 1141.2068612314363, 1183.7514122034297, 1198.6823491774512, 17201.31194752221, 17358.91320543389, 17418.303267869396, 17420.390286339916, 17524.824751752574, 557503.549787014, 557948.0, 558623.0, 562510.0, 565834.0, 57555.0, 58149.0, 58245.0, 58291.708541457025, 58298.41701583015, 1338.9732205355838, 1379.2138481065697, 1379.6619828141968, 1400.341839335531, 1407.2260256858688, 31056.68943310538, 31135.84432077825, 31397.0, 31833.681663183073, 31958.201044974063, 49898.75050624869, 50422.495775043244, 50482.24276635927, 50580.74709626575, 50630.493695064055, 455920.0, 459799.0, 460582.0, 463066.0, 464875.0, 24284.635730463702, 26517.60223596609, 27245.455090898467, 27562.173134805988, 27772.722272777013, 46465.303020455394, 47279.0, 47776.0, 48284.517154828005, 48718.0, 41338.1732365345, 41647.0, 41741.37387939244, 42683.0, 42974.0, 41191.7940410296, 41476.1704765909, 41526.584734152275, 41847.37228941629, 42088.0, 41063.7946810276, 41066.0, 41566.37650435185, 41823.163536729706, 41994.37008444937, 35235.82382088073, 36378.98058955476, 36477.0, 37216.0, 37614.0, 27863.582046269727, 27898.860505697343, 27986.160415187576, 27998.0, 28239.717602823708], "value": 20295.929710518994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.34311699461904, 399.8780371986547, 400.9138035322407, 407.05969211122306, 417.5841615584519, 13926.164430134198, 17724.0, 18667.0, 19168.0, 19173.32893348733, 18188.09059547024, 18415.263389464406, 18513.629727405445, 18529.2588296468, 18534.814651853478, 5640.633358831673, 5711.828645140652, 5775.1337299405, 5779.537636989031, 5787.681677507735, 4034.5360283567325, 5515.896820635869, 5694.487496125348, 5702.77188912443, 6151.907721384183, 6380.170577824876, 6404.263509696398, 6411.0383442483535, 6413.518986076039, 6424.839379015515, 6270.404311590391, 6380.585261957958, 6398.072279519467, 6437.420632143129, 6468.644224567671, 5446.836594902159, 5591.664500130005, 5602.747876345574, 5630.887382252332, 5656.575756818214, 21630.24294149713, 22177.889110554344, 22399.32802015942, 22689.319320420414, 22754.203602873986, 2224.6996655451467, 2326.732425771041, 2392.605220138675, 2413.8310318277727, 2462.950740985188, 13413.530526431528, 13818.516351927634, 13960.511382101678, 14153.150810951376, 14217.0, 1815.7821061472575, 1932.7294178814977, 2000.0699674651212, 2034.5727397246596, 2074.2117995161893, 80900.19099808985, 82783.17216827815, 83697.58151209205, 84049.57975210146, 84136.57931710302, 10186.847197292047, 10327.173826093895, 10346.0, 10682.465876706134, 10740.087092597061, 12803.743925121445, 13441.529546465827, 14314.713705726035, 14667.266636668124, 14676.3395647194, 8023.4784738991775, 8077.961019490255, 8097.473664211808, 8220.260176584135, 8247.95876020616, 7936.841263174704, 7977.920220797718, 8009.479383840032, 8146.063202731643, 8150.75547733569, 6477.352264773485, 6481.870362592722, 6483.416492515602, 6608.966955165193, 6805.455563554904, 1841.8894866308065, 1888.1408958923657, 1888.367396922019, 1922.7596550431197, 1952.375239923211, 954.6420092465326, 979.2410881566842, 1018.180364806338, 1074.570171931218, 1091.0235339371218, 18122.275108995756, 18237.361692340703, 18435.53911152232, 18500.537486562942, 18565.0, 996.3772642098688, 1000.8048430556117, 1013.6654903881702, 1037.4190453346, 1046.9685909422576, 10652.254342196127, 10926.453677316102, 11031.117510599133, 11049.502772375263, 11059.557617695202, 461757.0, 464800.0, 466274.0, 467107.0, 469706.0, 49953.25070123879, 74952.62523687347, 80885.59557202176, 81465.0, 81980.0, 1047.910927571165, 1072.0512346573182, 1075.655790147161, 1100.2078503477483, 1105.9447027648584, 16540.338386464406, 16620.501384958472, 16894.915525422293, 16923.0, 17176.484705458857, 25664.615030774927, 33865.0, 34842.47736283907, 37631.247375052895, 40135.59864401319, 50199.49800501948, 52128.47871521236, 52141.21788173256, 52345.21482177694, 52814.207786882456, 8378.874316885374, 8461.534615596202, 8531.786705332417, 8798.252148567188, 8862.42394244372, 12762.29807360604, 12827.294498802656, 12958.805617915927, 13326.800097998732, 13464.259465729087, 11377.829332560184, 11635.0, 11723.35521546323, 11890.0, 11890.524379024742, 11293.491792869176, 11403.258788178742, 11418.885811142114, 11435.142364322543, 11480.540778368771, 11800.17398782077, 11807.350595717318, 11958.521659133885, 12004.879951200377, 12017.61797393276, 8480.660773568989, 8600.451918654702, 8617.224449799549, 8688.304935605263, 8840.0, 11703.414829258674, 11708.590199342982, 11716.531338746354, 11798.882011179778, 11941.46263418131], "value": 9239.23475510642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.4120498788025, 1501.7822415749717, 1509.622594351412, 1695.9315631152372, 1800.1359347513194, 8350.540720260384, 8590.699325523608, 8602.09677983812, 8615.009273933492, 8762.21140097391, 8037.598120094001, 8277.793055173624, 8396.664133434671, 8397.370197235201, 8399.370047246466, 1953.7557805274341, 2264.501809601893, 2285.9771402286015, 2319.93040208794, 2347.0025239273327, 2381.3927448500694, 2381.6784734060852, 2385.260569223546, 2388.3073908566494, 2388.9880550597222, 2321.8374713770045, 2378.1795280628244, 2381.630562426603, 2382.523495300938, 2383.4518060846017, 1949.892755898425, 2267.444476103357, 2338.5556744218543, 2341.6955795746444, 2362.6928499295154, 2242.9551408971893, 2244.708187935574, 2249.80876625487, 2257.7403598586206, 2281.8744969026698, 8691.478511289342, 8780.64877404903, 8804.383693141483, 8813.338999574993, 8827.602757875848, 5205.297284866532, 5349.545288650469, 5357.142857142839, 5357.571394288448, 5358.946410535923, 3183.586133802614, 3283.3269179818317, 3346.3474622448634, 3352.2122301259183, 3367.7979321240805, 1162.96511104667, 1166.4984056855549, 1172.6657902497832, 1189.5241903238687, 1205.0957193164431, 12149.088818338572, 12474.81287780684, 12484.313362765044, 12498.687532811753, 12535.059870509656, 4531.22969095248, 4690.624750019991, 4763.785629646605, 4774.95225047745, 4781.976090119597, 10515.42165180907, 10519.789604207874, 10529.736756581147, 10552.736181595368, 10608.628697995533, 4592.563706447882, 5389.164679474688, 5402.729863506809, 5405.648632838853, 5407.0, 4776.116418462596, 4912.508749125131, 4922.335484709519, 4946.727929963887, 4963.677360971526, 4055.7363771354767, 4084.1219137885496, 4172.812223449952, 4205.432266643964, 4208.642265407413, 1278.5834772280398, 1319.706687446308, 1325.357201757147, 1327.9867201328057, 1328.3823022294487, 946.2808265718104, 1040.8959104089681, 1050.8266136087614, 1055.3245922609535, 1058.2116323339162, 6171.228596425447, 6205.751769929243, 6271.466925311308, 6272.874542509125, 6484.865148598977, 981.8870829854516, 1018.511114664965, 1028.4651980970004, 1039.2777019971047, 1056.4400867540216, 4042.110735638155, 4150.1284730207, 4174.77038762871, 4190.308599081118, 4196.202721482909, 10640.46797660114, 10887.945560272306, 10918.071963883, 10935.125189984941, 10947.233693641369, 10376.584936602603, 10796.244262901522, 10838.945805270923, 10872.293300935415, 11109.166812488935, 8134.877976830352, 8212.425130240945, 8294.0, 8302.045264794626, 8305.252527272454, 6140.508759299335, 6217.316095229431, 6255.186825712628, 6376.808695739135, 6538.378854008862, 10091.192704583762, 10134.898651013396, 10180.083792458714, 10398.636047738293, 10413.583456661649, 10122.291439599452, 10425.061744443037, 10465.0, 10471.057604815298, 10485.108765754996, 6915.412189963909, 6991.965040174767, 7091.503594748525, 7953.880691789512, 8108.918910810817, 7883.881741773764, 8370.916290837014, 8390.790230244293, 8589.742307730778, 8634.30925525969, 7699.307062364414, 7873.291403773688, 7894.644740986554, 7907.288344049063, 7943.682252709827, 7630.847383052197, 7695.615219238904, 7749.535027898344, 7757.612119394121, 7974.641141148778, 7156.570605763671, 7190.532615379983, 7225.0, 7227.891581626174, 7231.4937954342695, 5164.535191832753, 5305.098133317422, 5356.303680521507, 5448.891022179613, 5516.806911758069, 5249.842504724865, 5304.814331498379, 5435.782568697208, 5597.412271711411, 5664.122061080539], "value": 4704.855495128664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.6851979500704, 316.28361760612216, 318.82783297019625, 319.1844836442889, 323.16300780977264, 5226.137687281599, 5237.47625237477, 5250.396204436491, 5251.422343542207, 5273.261743355928, 5152.51051150141, 5174.508421699942, 5187.170052791555, 5190.896182076356, 5194.71429071401, 3815.9124649474907, 3845.0771814764535, 3994.800259986989, 4007.5792041835625, 4010.4786377770847, 3986.3621820508724, 3992.6207010333974, 3993.381025940984, 4020.5778393268724, 4032.475778148851, 3821.273957947995, 3942.684585233189, 3944.9408258876138, 3984.342583473723, 3984.346496204086, 3893.279743247494, 3990.8004599770043, 4005.178938317638, 4011.0, 4012.979935100335, 3504.5969713483023, 3520.5423294971747, 3524.84138213781, 3526.664966828173, 3526.783259775399, 4949.851504454872, 4972.941640890826, 4978.6514943953935, 4982.626303027288, 4986.626003049786, 4454.198244316021, 4493.820247190109, 4497.2129877271345, 4538.3873177120995, 4566.611837993774, 5303.602229832778, 5307.177387504943, 5329.733513324319, 5364.544013758835, 5367.865803354908, 3891.5330160380936, 3912.628300311466, 3913.902152446183, 3914.667253283474, 3917.334053210961, 5483.972580137074, 5489.917651235235, 5506.697131657757, 5633.239512665778, 5636.49271565557, 3963.6630886374405, 3969.325214713506, 3985.1830374773103, 3987.2424239394422, 3992.301347264217, 3946.131850992777, 3958.267720471722, 3989.6608788252743, 4001.3397789365013, 4032.1734044520804, 4394.538573449741, 4562.498125206224, 4573.382593349922, 4575.58819706228, 4591.219492686251, 5381.90540439249, 5396.730163491889, 5416.0, 5419.132938729863, 5426.647267927572, 1370.7532644124153, 1373.3613869550707, 1375.4910683047137, 1380.8895288376905, 1380.9792853107213, 886.4769785826264, 896.5248418338291, 929.177677755178, 955.1976339874539, 959.4051687953513, 5237.450067742909, 5253.605979551549, 5258.553022993088, 5273.419923808378, 5283.735813209324, 5576.553875689935, 5582.49757521825, 5588.133839254922, 5591.217229587861, 5596.384397716248, 5030.522100400529, 5111.131107711698, 5139.743012849342, 5224.0, 5250.873396274438, 2908.75275601572, 2915.454808951217, 2932.765378769736, 2937.7062293770878, 2963.985180074129, 5470.671759694431, 5647.599770097774, 5649.265595472562, 5679.744411501492, 5682.488576028095, 5615.0, 5634.408387119375, 5638.210650508932, 5642.887142257214, 5649.265595472562, 5625.71871406428, 5656.575756818255, 5663.830085097454, 5678.829635110953, 5689.0, 5243.344581927259, 5480.780768769205, 5496.615236933376, 5525.972370138124, 5530.419305972976, 5380.677159370451, 5454.91817622728, 5457.345118585795, 5466.808661696821, 5471.316085489314, 5642.520385767256, 5644.6613203207935, 5696.857578560403, 5697.173909782975, 5714.342850572238, 3862.845486180521, 3928.489296391451, 3947.1513624570857, 3955.7428767130045, 3964.5638979712785, 5447.155690867922, 5469.72651367438, 5526.181647359795, 5526.447355264441, 5528.0, 5332.013577488177, 5343.385510666168, 5355.410904800391, 5376.946230537801, 5382.327209098863, 5180.585553155664, 5415.702136382537, 5428.755705993319, 5429.104197807317, 5437.646552974044, 5150.613703972292, 5287.937704295405, 5323.243329701267, 5333.333333333333, 5344.438833922382, 5486.902619476041, 5514.338279406497, 5531.834044978496, 5532.944670553243, 5535.3634332050715, 5383.515483606494, 5400.540954018952, 5413.377461591967, 5417.214503896992, 5453.536449401845], "value": 4112.829682559803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.5858460677416, 765.3150430364824, 787.7085478373003, 819.4018366592387, 843.135785819535, 14735.926320368397, 15574.84425155748, 15584.92207538962, 15635.0, 15659.921700391496, 14903.552893413187, 15009.399624015054, 15022.849771502282, 15046.473373431932, 15047.473338433158, 671.4225765841372, 787.3858390455425, 808.5552945879772, 811.0186674124317, 816.408104124508, 805.9113497515298, 810.7527204202715, 813.4793732011517, 813.9064007639138, 814.0353680888137, 845.1970627903486, 852.5694524265238, 854.662408348705, 854.974350769478, 856.4604299291437, 701.8771714949889, 836.7406104107715, 857.789841488833, 859.0250066174905, 859.6260626627437, 635.8601107756286, 636.2651137935692, 636.9299377068519, 637.0285314894776, 637.2703254773305, 15334.386624535005, 15387.615309617237, 15388.15365154916, 15409.0, 15419.460318888898, 13776.793348099687, 13951.790723139162, 13963.930180349033, 14006.299685015709, 14064.367103480368, 12404.937975310157, 12556.937215313865, 12598.622041338775, 12602.81095783564, 13161.407736651874, 4361.978190109029, 4407.140607581523, 4414.867553973386, 4503.48209955856, 4537.160625284333, 72387.63806180988, 72982.27017729808, 73008.0, 73134.0, 73352.63323683401, 10942.56229750817, 11107.666769996913, 11122.277051991594, 11252.887471125185, 11301.32192068462, 20933.37199884006, 20934.057967391505, 20942.162313507288, 20945.0, 20974.0, 8145.633446494922, 8197.836043279101, 8259.050209226016, 8364.121767214476, 8576.699815506427, 4484.215262329079, 4502.549745025472, 4506.8103131851285, 4610.792514336863, 4629.513901040342, 3174.1271150433354, 3260.6576309487164, 3262.4943133814295, 3267.7222436092725, 3286.5891763529557, 519.2082074835905, 613.141601757543, 637.974481020754, 647.5920170292779, 651.9837004074936, 670.9329067093349, 754.2457542457543, 766.8581312457213, 770.1335997003371, 780.980475488106, 9928.979595882593, 10099.987092033753, 10189.439580822978, 10325.070743633109, 10452.581896724047, 584.6725833533235, 705.6507029020565, 742.5730205132071, 745.434587366526, 746.4438992950287, 4674.883127921761, 4839.128956787812, 4867.196912509467, 4890.535399137077, 4918.213085906238, 50492.49507504878, 50873.23690144651, 50926.49073509291, 59280.0, 73332.0, 65091.67454162699, 66670.33329666738, 81982.0, 99441.50279248557, 99617.50191248997, 79698.6015069921, 93254.0, 95132.0, 95698.52150739201, 96021.51989240009, 8993.325500587613, 9331.206847418045, 9360.672376466791, 9466.810663786548, 9524.95237523808, 51489.0, 52846.20730688966, 52891.0, 53435.122077047425, 55114.448855510935, 73161.0, 81760.36479270262, 82254.0, 82541.17458825334, 84708.57645711732, 12766.936165319114, 12807.551735689207, 13096.017798665329, 13103.344832758514, 13120.60638180856, 12621.305828179171, 13051.869481305444, 13108.2135071896, 13415.731685366043, 13823.654408639864, 12662.810057848956, 12707.80938285945, 12815.807762883751, 13017.804732928824, 14582.0, 13394.397252123872, 13925.791113133513, 14110.717785644025, 14390.712185756436, 14506.347214375168, 13736.175829450265, 13805.792913106512, 13931.164130152223, 13961.371738271599, 14038.508652197532, 11655.650330490098, 11713.238639488405, 11742.70643233926, 11853.288802671867, 12185.51257949672, 11923.642290731292, 11928.701782455508, 12004.459799308877, 12050.939745301568, 12222.816657750318], "value": 7432.256524480955, "unit": "score"}], "name": "dromaeo_css", "value": 7216.701503263061, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 108.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 128.0, 180.0, 131.0, 129.0, 157.0, 127.0, 156.0, 127.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 110.0, 75.0, 75.0, 74.0, 76.0, 103.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 113.0, 85.0, 85.0, 85.0, 123.0, 87.0, 85.0, 121.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 83.0, 82.0, 80.0, 87.0, 84.0, 81.0, 112.0, 80.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 123.0, 119.0, 123.0, 122.0, 129.0, 121.0, 128.0, 130.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 168.0, 164.0, 159.0, 162.0, 175.0, 164.0, 162.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 64.0, 64.0, 67.0, 66.0, 62.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1498.1000000000001, "alertThreshold": 2.0}]} 11:29:50 INFO - Return code: 0 11:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:29:50 ERROR - # TBPL SUCCESS # 11:29:50 INFO - Running post-action listener: _resource_record_post_action 11:29:50 INFO - ##### 11:29:50 INFO - ##### Finished run-tests step (success) 11:29:50 INFO - ##### 11:29:50 INFO - Running post-run listener: _resource_record_post_run 11:29:50 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541745152; Read time: 12; Write time: 1146340 11:29:50 INFO - TinderboxPrint: CPU usage
13.2% 11:29:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:29:50 INFO - TinderboxPrint: I/O write bytes / time
541,745,152 / 1,146,340 11:29:50 INFO - TinderboxPrint: CPU idle
8,285.2 (86.8%) 11:29:50 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 11:29:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:29:50 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 248262656; Read time: 0; Write time: 585484 11:29:50 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293482496; Read time: 12; Write time: 560856 11:29:50 INFO - Running post-run listener: _upload_blobber_files 11:29:50 INFO - Blob upload gear active. 11:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:50 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 11:29:50 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:50 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:55 INFO - (blobuploader) - INFO - Done attempting. 11:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:56 INFO - (blobuploader) - INFO - Done attempting. 11:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:56 INFO - (blobuploader) - INFO - Done attempting. 11:29:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:56 INFO - Return code: 0 11:29:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/591d4f6d5870edd1bf99650c8ea63fe7dccad84c632ded17127f4aadea287c77482f952e9eaa81023ca042e761ccf2f77f0c01d7157b41c396fef967313d6df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80571b85d719d3282650a0c4611a062d5fdb1bdf5302c221a0d05f55006a2063aa1d1bfb78497047c7fa0da7578f882ef50585289ebd81ccceb28170257ee5a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ae1f9d1dfdd3750d95dff43ca2ebd65e01055ad58894078a50d9570f831813954d0234fdd966be0a6da73c82cbe6f8f05abe4a2eae6e9caa6484f4aacd67f7"} 11:29:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:56 INFO - Contents: 11:29:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/591d4f6d5870edd1bf99650c8ea63fe7dccad84c632ded17127f4aadea287c77482f952e9eaa81023ca042e761ccf2f77f0c01d7157b41c396fef967313d6df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80571b85d719d3282650a0c4611a062d5fdb1bdf5302c221a0d05f55006a2063aa1d1bfb78497047c7fa0da7578f882ef50585289ebd81ccceb28170257ee5a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ae1f9d1dfdd3750d95dff43ca2ebd65e01055ad58894078a50d9570f831813954d0234fdd966be0a6da73c82cbe6f8f05abe4a2eae6e9caa6484f4aacd67f7"} 11:29:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:56 INFO - Copying logs to upload dir... 11:29:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.504050 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 11:29:56.780544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 11:29:56.783943) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/591d4f6d5870edd1bf99650c8ea63fe7dccad84c632ded17127f4aadea287c77482f952e9eaa81023ca042e761ccf2f77f0c01d7157b41c396fef967313d6df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80571b85d719d3282650a0c4611a062d5fdb1bdf5302c221a0d05f55006a2063aa1d1bfb78497047c7fa0da7578f882ef50585289ebd81ccceb28170257ee5a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ae1f9d1dfdd3750d95dff43ca2ebd65e01055ad58894078a50d9570f831813954d0234fdd966be0a6da73c82cbe6f8f05abe4a2eae6e9caa6484f4aacd67f7"} build_url:https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/RWdkINQuSoCL6xaNjhlcHg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/591d4f6d5870edd1bf99650c8ea63fe7dccad84c632ded17127f4aadea287c77482f952e9eaa81023ca042e761ccf2f77f0c01d7157b41c396fef967313d6df3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80571b85d719d3282650a0c4611a062d5fdb1bdf5302c221a0d05f55006a2063aa1d1bfb78497047c7fa0da7578f882ef50585289ebd81ccceb28170257ee5a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ae1f9d1dfdd3750d95dff43ca2ebd65e01055ad58894078a50d9570f831813954d0234fdd966be0a6da73c82cbe6f8f05abe4a2eae6e9caa6484f4aacd67f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 11:29:56.810882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:29:56.811231) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465408642.73507-1760665038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:29:56.896399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 11:29:56.896768) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 11:29:56.897123) ========= ========= Total master_lag: 0.19 =========