builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1465198441.47 results: success (0) buildid: 20160605214724 builduid: 5c69a20f14c041fc87a0e59ba479e668 revision: ce9080e6765e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.471347) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.471936) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.472223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.490788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.491316) ========= 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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 00:34:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-06 00:34:01 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.585188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.585527) ========= 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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014136 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.637647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:01.638008) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce9080e6765e --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 ce9080e6765e --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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 00:34:01,884 Setting DEBUG logging. 2016-06-06 00:34:01,884 attempt 1/10 2016-06-06 00:34:01,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce9080e6765e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 00:34:02,186 unpacking tar archive at: fx-team-ce9080e6765e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:02.287272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:02.287703) ========= script_repo_revision: ce9080e6765e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:02.288091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:02.288373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 00:34:02.297524) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 00:34:02.297833) ========= /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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:34:02 INFO - MultiFileLogger online at 20160606 00:34:02 in /builds/slave/test 00:34:02 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 00:34:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:34:02 INFO - {'append_to_log': False, 00:34:02 INFO - 'base_work_dir': '/builds/slave/test', 00:34:02 INFO - 'blob_upload_branch': 'Fx-Team', 00:34:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:34:02 INFO - 'branch': 'Fx-Team', 00:34:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:34:02 INFO - 'config_files': ('talos/linux_config.py',), 00:34:02 INFO - 'default_actions': ('clobber', 00:34:02 INFO - 'read-buildbot-config', 00:34:02 INFO - 'download-and-extract', 00:34:02 INFO - 'populate-webroot', 00:34:02 INFO - 'create-virtualenv', 00:34:02 INFO - 'install', 00:34:02 INFO - 'run-tests'), 00:34:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:34:02 INFO - 'download_minidump_stackwalk': True, 00:34:02 INFO - 'download_symbols': 'ondemand', 00:34:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:34:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:34:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:34:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:34:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:34:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:34:02 INFO - 'installer_path': 'installer.exe', 00:34:02 INFO - 'log_level': 'info', 00:34:02 INFO - 'log_name': 'talos', 00:34:02 INFO - 'log_to_console': True, 00:34:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:34:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:34:02 INFO - 'opt_config_files': (), 00:34:02 INFO - 'pip_index': False, 00:34:02 INFO - 'sps_profile': False, 00:34:02 INFO - 'sps_profile_interval': 0, 00:34:02 INFO - 'suite': 'dromaeojs', 00:34:02 INFO - 'system_bits': '32', 00:34:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:34:02 INFO - 'title': 'talos-linux64-ix-010', 00:34:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:34:02 INFO - 'use_talos_json': True, 00:34:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:34:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:34:02 INFO - 'work_dir': 'build'} 00:34:02 INFO - ##### 00:34:02 INFO - ##### Running clobber step. 00:34:02 INFO - ##### 00:34:02 INFO - Running pre-action listener: _resource_record_pre_action 00:34:02 INFO - Running main action method: clobber 00:34:02 INFO - rmtree: /builds/slave/test/build 00:34:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:34:03 INFO - Running post-action listener: _resource_record_post_action 00:34:03 INFO - ##### 00:34:03 INFO - ##### Finished clobber step (success) 00:34:03 INFO - ##### 00:34:03 INFO - ##### 00:34:03 INFO - ##### Running read-buildbot-config step. 00:34:03 INFO - ##### 00:34:03 INFO - Running pre-action listener: _resource_record_pre_action 00:34:03 INFO - Running main action method: read_buildbot_config 00:34:03 INFO - Using buildbot properties: 00:34:03 INFO - { 00:34:03 INFO - "project": "", 00:34:03 INFO - "product": "firefox", 00:34:03 INFO - "script_repo_revision": "production", 00:34:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:34:03 INFO - "repository": "", 00:34:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 00:34:03 INFO - "buildid": "20160605214724", 00:34:03 INFO - "pgo_build": "True", 00:34:03 INFO - "basedir": "/builds/slave/test", 00:34:03 INFO - "buildnumber": 158, 00:34:03 INFO - "slavename": "talos-linux64-ix-010", 00:34:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:34:03 INFO - "platform": "ubuntu64_hw", 00:34:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:34:03 INFO - "branch": "fx-team", 00:34:03 INFO - "repo_path": "integration/fx-team", 00:34:03 INFO - "revision": "ce9080e6765e", 00:34:03 INFO - "stage_platform": "linux64-pgo", 00:34:03 INFO - "builduid": "5c69a20f14c041fc87a0e59ba479e668", 00:34:03 INFO - "slavebuilddir": "test" 00:34:03 INFO - } 00:34:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:34:03 INFO - Running post-action listener: _resource_record_post_action 00:34:03 INFO - ##### 00:34:03 INFO - ##### Finished read-buildbot-config step (success) 00:34:03 INFO - ##### 00:34:03 INFO - ##### 00:34:03 INFO - ##### Running download-and-extract step. 00:34:03 INFO - ##### 00:34:03 INFO - Running pre-action listener: _resource_record_pre_action 00:34:03 INFO - Running main action method: download_and_extract 00:34:03 INFO - mkdir: /builds/slave/test/build/tests 00:34:03 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')]} 00:34:03 INFO - https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:34:04 INFO - Downloaded 1361 bytes. 00:34:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:34:04 INFO - Using the following test package requirements: 00:34:04 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:34:04 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:34:04 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:34:04 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'jsshell-linux-x86_64.zip'], 00:34:04 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:34:04 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:34:04 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:34:04 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:34:04 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:34:04 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:34:04 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:34:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:04 INFO - https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:34:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:34:05 INFO - Downloaded 24440521 bytes. 00:34:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:34:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:34:06 INFO - Return code: 0 00:34:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:06 INFO - https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:34:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:34:07 INFO - Downloaded 24440521 bytes. 00:34:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:34:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:34:09 INFO - Return code: 0 00:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:09 INFO - https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:34:10 INFO - Downloaded 10833369 bytes. 00:34:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:34:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 00:34:10 INFO - Return code: 0 00:34: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')]} 00:34:10 INFO - https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:34:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:34:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:34:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:34:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:34:11 INFO - Downloaded 59128707 bytes. 00:34:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:34:11 INFO - mkdir: /builds/slave/test/properties 00:34:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:34:11 INFO - Writing to file /builds/slave/test/properties/build_url 00:34:11 INFO - Contents: 00:34:11 INFO - build_url:https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:34:12 INFO - Running post-action listener: _resource_record_post_action 00:34:12 INFO - Running post-action listener: set_extra_try_arguments 00:34:12 INFO - ##### 00:34:12 INFO - ##### Finished download-and-extract step (success) 00:34:12 INFO - ##### 00:34:12 INFO - ##### 00:34:12 INFO - ##### Running populate-webroot step. 00:34:12 INFO - ##### 00:34:12 INFO - Running pre-action listener: _resource_record_pre_action 00:34:12 INFO - Running main action method: populate_webroot 00:34:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:34:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:34:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:34:12 INFO - '--tppagecycles', 00:34:12 INFO - '7'], 00:34:12 INFO - 'tests': ['tsvgm']}}, 00:34:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:34:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:34:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:34:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:34:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:34:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:34:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['damp', 'tps']}, 00:34:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'tests': ['damp', 'tps']}, 00:34:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['dromaeo_dom']}, 00:34:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:34:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'other-e10s': {'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['a11yr', 00:34:12 INFO - 'ts_paint', 00:34:12 INFO - 'tpaint', 00:34:12 INFO - 'sessionrestore', 00:34:12 INFO - 'sessionrestore_no_auto_restore', 00:34:12 INFO - 'tabpaint']}, 00:34:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['tsvgx', 00:34:12 INFO - 'tsvgr_opacity', 00:34:12 INFO - 'tart', 00:34:12 INFO - 'tscrollx', 00:34:12 INFO - 'cart']}, 00:34:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:34:12 INFO - 'tsvgr_opacity', 00:34:12 INFO - 'tart', 00:34:12 INFO - 'tscrollx', 00:34:12 INFO - 'cart']}, 00:34:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'talos_options': ['--disable-e10s'], 00:34:12 INFO - 'tests': ['tp5o']}, 00:34:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'tests': ['tp5o']}, 00:34:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'talos_options': ['--disable-e10s', 00:34:12 INFO - '--xperf_path', 00:34:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:34:12 INFO - 'tests': ['tp5n']}, 00:34:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:34:12 INFO - 'talos_options': ['--xperf_path', 00:34:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:34:12 INFO - 'tests': ['tp5n']}}, 00:34:12 INFO - 'talos.zip': {'path': '', 00:34:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:34:12 INFO - Running post-action listener: _resource_record_post_action 00:34:12 INFO - ##### 00:34:12 INFO - ##### Finished populate-webroot step (success) 00:34:12 INFO - ##### 00:34:12 INFO - ##### 00:34:12 INFO - ##### Running create-virtualenv step. 00:34:12 INFO - ##### 00:34:12 INFO - Running pre-action listener: _resource_record_pre_action 00:34:12 INFO - Running main action method: create_virtualenv 00:34:12 INFO - Creating virtualenv /builds/slave/test/build/venv 00:34:12 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 00:34:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:34:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:34:12 INFO - Using real prefix '/usr' 00:34:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:34:13 INFO - Installing distribute.............................................................................................................................................................................................done. 00:34:15 INFO - Installing pip.................done. 00:34:15 INFO - Return code: 0 00:34:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:34:15 INFO - Using env: {'DISPLAY': ':0', 00:34:15 INFO - 'HOME': '/home/cltbld', 00:34:15 INFO - 'LANG': 'en_US.UTF-8', 00:34:15 INFO - 'LANGUAGE': 'en_US:en', 00:34:15 INFO - 'LOGNAME': 'cltbld', 00:34:15 INFO - 'MAIL': '/var/mail/cltbld', 00:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:15 INFO - 'MOZ_NO_REMOTE': '1', 00:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:15 INFO - 'NO_EM_RESTART': '1', 00:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:15 INFO - 'PWD': '/builds/slave/test', 00:34:15 INFO - 'SHELL': '/bin/bash', 00:34:15 INFO - 'SHLVL': '1', 00:34:15 INFO - 'TERM': 'linux', 00:34:15 INFO - 'TMOUT': '86400', 00:34:15 INFO - 'USER': 'cltbld', 00:34:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:15 INFO - '_': '/tools/buildbot/bin/python'} 00:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:15 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 00:34:15 INFO - Cleaning up... 00:34:15 INFO - Return code: 0 00:34:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:34:15 INFO - Using env: {'DISPLAY': ':0', 00:34:15 INFO - 'HOME': '/home/cltbld', 00:34:15 INFO - 'LANG': 'en_US.UTF-8', 00:34:15 INFO - 'LANGUAGE': 'en_US:en', 00:34:15 INFO - 'LOGNAME': 'cltbld', 00:34:15 INFO - 'MAIL': '/var/mail/cltbld', 00:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:15 INFO - 'MOZ_NO_REMOTE': '1', 00:34:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:15 INFO - 'NO_EM_RESTART': '1', 00:34:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:15 INFO - 'PWD': '/builds/slave/test', 00:34:15 INFO - 'SHELL': '/bin/bash', 00:34:15 INFO - 'SHLVL': '1', 00:34:15 INFO - 'TERM': 'linux', 00:34:15 INFO - 'TMOUT': '86400', 00:34:15 INFO - 'USER': 'cltbld', 00:34:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:15 INFO - '_': '/tools/buildbot/bin/python'} 00:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:15 INFO - Downloading/unpacking psutil>=3.1.1 00:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:34:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:34:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:34:17 INFO - Installing collected packages: psutil 00:34:17 INFO - Running setup.py install for psutil 00:34:17 INFO - building 'psutil._psutil_linux' extension 00:34:17 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 00:34:18 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 00:34:18 INFO - building 'psutil._psutil_posix' extension 00:34:18 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 00:34:18 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 00:34:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:34:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:34:18 INFO - Successfully installed psutil 00:34:18 INFO - Cleaning up... 00:34:18 INFO - Return code: 0 00:34:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:34:18 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')]} 00:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:18 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')]} 00:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:18 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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:18 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 00:34:18 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 00:34:18 INFO - Using env: {'DISPLAY': ':0', 00:34:18 INFO - 'HOME': '/home/cltbld', 00:34:18 INFO - 'LANG': 'en_US.UTF-8', 00:34:18 INFO - 'LANGUAGE': 'en_US:en', 00:34:18 INFO - 'LOGNAME': 'cltbld', 00:34:18 INFO - 'MAIL': '/var/mail/cltbld', 00:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:18 INFO - 'MOZ_NO_REMOTE': '1', 00:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:18 INFO - 'NO_EM_RESTART': '1', 00:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:18 INFO - 'PWD': '/builds/slave/test', 00:34:18 INFO - 'SHELL': '/bin/bash', 00:34:18 INFO - 'SHLVL': '1', 00:34:18 INFO - 'TERM': 'linux', 00:34:18 INFO - 'TMOUT': '86400', 00:34:18 INFO - 'USER': 'cltbld', 00:34:18 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:18 INFO - '_': '/tools/buildbot/bin/python'} 00:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:34:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:34:20 INFO - Installing collected packages: mozsystemmonitor 00:34:20 INFO - Running setup.py install for mozsystemmonitor 00:34:20 INFO - Successfully installed mozsystemmonitor 00:34:20 INFO - Cleaning up... 00:34:20 INFO - Return code: 0 00:34:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:34:20 INFO - Using env: {'DISPLAY': ':0', 00:34:20 INFO - 'HOME': '/home/cltbld', 00:34:20 INFO - 'LANG': 'en_US.UTF-8', 00:34:20 INFO - 'LANGUAGE': 'en_US:en', 00:34:20 INFO - 'LOGNAME': 'cltbld', 00:34:20 INFO - 'MAIL': '/var/mail/cltbld', 00:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:20 INFO - 'MOZ_NO_REMOTE': '1', 00:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:20 INFO - 'NO_EM_RESTART': '1', 00:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:20 INFO - 'PWD': '/builds/slave/test', 00:34:20 INFO - 'SHELL': '/bin/bash', 00:34:20 INFO - 'SHLVL': '1', 00:34:20 INFO - 'TERM': 'linux', 00:34:20 INFO - 'TMOUT': '86400', 00:34:20 INFO - 'USER': 'cltbld', 00:34:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:20 INFO - '_': '/tools/buildbot/bin/python'} 00:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:20 INFO - Downloading/unpacking jsonschema==2.5.1 00:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:34:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:23 INFO - Downloading functools32-3.2.3-2.tar.gz 00:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:34:23 INFO - warning: no files found matching '*.txt' 00:34:23 INFO - no previously-included directories found matching 'build' 00:34:23 INFO - no previously-included directories found matching 'dist' 00:34:23 INFO - no previously-included directories found matching '.git*' 00:34:23 INFO - Installing collected packages: jsonschema, functools32 00:34:23 INFO - Running setup.py install for functools32 00:34:23 INFO - warning: no files found matching '*.txt' 00:34:23 INFO - no previously-included directories found matching 'build' 00:34:23 INFO - no previously-included directories found matching 'dist' 00:34:23 INFO - no previously-included directories found matching '.git*' 00:34:23 INFO - Successfully installed jsonschema functools32 00:34:23 INFO - Cleaning up... 00:34:23 INFO - Return code: 0 00:34:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:34: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')]} 00:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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')]} 00:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:34:23 INFO - Using env: {'DISPLAY': ':0', 00:34:23 INFO - 'HOME': '/home/cltbld', 00:34:23 INFO - 'LANG': 'en_US.UTF-8', 00:34:23 INFO - 'LANGUAGE': 'en_US:en', 00:34:23 INFO - 'LOGNAME': 'cltbld', 00:34:23 INFO - 'MAIL': '/var/mail/cltbld', 00:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:23 INFO - 'MOZ_NO_REMOTE': '1', 00:34:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:23 INFO - 'NO_EM_RESTART': '1', 00:34:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:23 INFO - 'PWD': '/builds/slave/test', 00:34:23 INFO - 'SHELL': '/bin/bash', 00:34:23 INFO - 'SHLVL': '1', 00:34:23 INFO - 'TERM': 'linux', 00:34:23 INFO - 'TMOUT': '86400', 00:34:23 INFO - 'USER': 'cltbld', 00:34:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:23 INFO - '_': '/tools/buildbot/bin/python'} 00:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:23 INFO - Downloading/unpacking blobuploader==1.2.4 00:34:23 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 00:34:23 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 00:34:23 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 00:34:23 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 00:34:23 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 00:34:23 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 00:34:25 INFO - Downloading blobuploader-1.2.4.tar.gz 00:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:34:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:34:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:34:26 INFO - Downloading docopt-0.6.1.tar.gz 00:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:34:26 INFO - Installing collected packages: blobuploader, requests, docopt 00:34:26 INFO - Running setup.py install for blobuploader 00:34:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:34:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:34:26 INFO - Running setup.py install for requests 00:34:26 INFO - Running setup.py install for docopt 00:34:26 INFO - Successfully installed blobuploader requests docopt 00:34:26 INFO - Cleaning up... 00:34:26 INFO - Return code: 0 00:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:26 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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:26 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 00:34:26 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 00:34:26 INFO - Using env: {'DISPLAY': ':0', 00:34:26 INFO - 'HOME': '/home/cltbld', 00:34:26 INFO - 'LANG': 'en_US.UTF-8', 00:34:26 INFO - 'LANGUAGE': 'en_US:en', 00:34:26 INFO - 'LOGNAME': 'cltbld', 00:34:26 INFO - 'MAIL': '/var/mail/cltbld', 00:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:26 INFO - 'MOZ_NO_REMOTE': '1', 00:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:26 INFO - 'NO_EM_RESTART': '1', 00:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:26 INFO - 'PWD': '/builds/slave/test', 00:34:26 INFO - 'SHELL': '/bin/bash', 00:34:26 INFO - 'SHLVL': '1', 00:34:26 INFO - 'TERM': 'linux', 00:34:26 INFO - 'TMOUT': '86400', 00:34:26 INFO - 'USER': 'cltbld', 00:34:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:26 INFO - '_': '/tools/buildbot/bin/python'} 00:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:34:27 INFO - Running setup.py (path:/tmp/pip-0fMIoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:34:27 INFO - Running setup.py (path:/tmp/pip-SvIJ5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:34:27 INFO - Running setup.py (path:/tmp/pip-qlkuja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:34:27 INFO - Running setup.py (path:/tmp/pip-5EBmng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:34:27 INFO - Running setup.py (path:/tmp/pip-2vN9xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:34:27 INFO - Running setup.py (path:/tmp/pip-3SSO3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:34:27 INFO - Running setup.py (path:/tmp/pip-wC71CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:34:27 INFO - Running setup.py (path:/tmp/pip-NFPL_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:34:27 INFO - Running setup.py (path:/tmp/pip-54y71c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:34:27 INFO - Running setup.py (path:/tmp/pip-8mUuXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:34:27 INFO - Running setup.py (path:/tmp/pip-t8rGSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:34:27 INFO - Running setup.py (path:/tmp/pip-LgxTPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:34:27 INFO - Running setup.py (path:/tmp/pip-n4wrY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:34:27 INFO - Running setup.py (path:/tmp/pip-9TMdVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:28 INFO - Running setup.py (path:/tmp/pip-4CZJy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:34:28 INFO - Running setup.py (path:/tmp/pip-nxdMmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:34:28 INFO - Running setup.py (path:/tmp/pip-uSIBgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:34:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:34:28 INFO - Running setup.py install for manifestparser 00:34:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:34:28 INFO - Running setup.py install for mozcrash 00:34:28 INFO - Running setup.py install for mozdebug 00:34:28 INFO - Running setup.py install for mozdevice 00:34:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:34:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:34:28 INFO - Running setup.py install for mozfile 00:34:28 INFO - Running setup.py install for mozhttpd 00:34:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:34:28 INFO - Running setup.py install for mozinfo 00:34:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:34:28 INFO - Running setup.py install for mozInstall 00:34:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Running setup.py install for mozleak 00:34:29 INFO - Running setup.py install for mozlog 00:34:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Running setup.py install for moznetwork 00:34:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Running setup.py install for mozprocess 00:34:29 INFO - Running setup.py install for mozprofile 00:34:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Running setup.py install for mozrunner 00:34:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:34:29 INFO - Running setup.py install for mozscreenshot 00:34:29 INFO - Running setup.py install for moztest 00:34:29 INFO - Running setup.py install for mozversion 00:34:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:34:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:34:30 INFO - Cleaning up... 00:34:30 INFO - Return code: 0 00:34:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:30 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')]} 00:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:30 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')]} 00:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:30 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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:30 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 00:34:30 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 00:34:30 INFO - Using env: {'DISPLAY': ':0', 00:34:30 INFO - 'HOME': '/home/cltbld', 00:34:30 INFO - 'LANG': 'en_US.UTF-8', 00:34:30 INFO - 'LANGUAGE': 'en_US:en', 00:34:30 INFO - 'LOGNAME': 'cltbld', 00:34:30 INFO - 'MAIL': '/var/mail/cltbld', 00:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:30 INFO - 'MOZ_NO_REMOTE': '1', 00:34:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:30 INFO - 'NO_EM_RESTART': '1', 00:34:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:30 INFO - 'PWD': '/builds/slave/test', 00:34:30 INFO - 'SHELL': '/bin/bash', 00:34:30 INFO - 'SHLVL': '1', 00:34:30 INFO - 'TERM': 'linux', 00:34:30 INFO - 'TMOUT': '86400', 00:34:30 INFO - 'USER': 'cltbld', 00:34:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:30 INFO - '_': '/tools/buildbot/bin/python'} 00:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:34:30 INFO - Running setup.py (path:/tmp/pip-PfwJkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:34:30 INFO - Running setup.py (path:/tmp/pip-iRDXX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:34:30 INFO - Running setup.py (path:/tmp/pip-gU4Wki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:34:30 INFO - Running setup.py (path:/tmp/pip-df26ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:34:30 INFO - Running setup.py (path:/tmp/pip-1qnpux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:34:30 INFO - Running setup.py (path:/tmp/pip-9IxQNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:34:30 INFO - Running setup.py (path:/tmp/pip-nUkd_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:34:30 INFO - Running setup.py (path:/tmp/pip-lwUKpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:34:30 INFO - Running setup.py (path:/tmp/pip-DwtL1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:34:30 INFO - Running setup.py (path:/tmp/pip-5Qf_DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:34:30 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)) 00:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:34:30 INFO - Running setup.py (path:/tmp/pip-AqDB6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:34:31 INFO - Running setup.py (path:/tmp/pip-UI_ikC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:34:31 INFO - Running setup.py (path:/tmp/pip-DEvDmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:34:31 INFO - Running setup.py (path:/tmp/pip-fZTB6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:31 INFO - Running setup.py (path:/tmp/pip-pLT5b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:34:31 INFO - Running setup.py (path:/tmp/pip-or5Wr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:34:31 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)) 00:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:34:31 INFO - Running setup.py (path:/tmp/pip-ZLwH1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:34:31 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)) 00:34:31 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)) 00:34:31 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)) 00:34:31 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)) 00:34:31 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)) 00:34:31 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)) 00:34:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:33 INFO - Downloading blessings-1.6.tar.gz 00:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:34:33 INFO - Installing collected packages: blessings 00:34:33 INFO - Running setup.py install for blessings 00:34:33 INFO - Successfully installed blessings 00:34:33 INFO - Cleaning up... 00:34:33 INFO - Return code: 0 00:34:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:34:33 INFO - Reading from file tmpfile_stdout 00:34:33 INFO - Current package versions: 00:34:33 INFO - argparse == 1.2.1 00:34:33 INFO - blessings == 1.6 00:34:33 INFO - blobuploader == 1.2.4 00:34:33 INFO - docopt == 0.6.1 00:34:33 INFO - functools32 == 3.2.3-2 00:34:33 INFO - jsonschema == 2.5.1 00:34:33 INFO - manifestparser == 1.1 00:34:33 INFO - mozInstall == 1.12 00:34:33 INFO - mozcrash == 0.17 00:34:33 INFO - mozdebug == 0.1 00:34:33 INFO - mozdevice == 0.48 00:34:33 INFO - mozfile == 1.2 00:34:33 INFO - mozhttpd == 0.7 00:34:33 INFO - mozinfo == 0.9 00:34:33 INFO - mozleak == 0.1 00:34:33 INFO - mozlog == 3.2 00:34:33 INFO - moznetwork == 0.27 00:34:33 INFO - mozprocess == 0.22 00:34:33 INFO - mozprofile == 0.28 00:34:33 INFO - mozrunner == 6.11 00:34:33 INFO - mozscreenshot == 0.1 00:34:33 INFO - mozsystemmonitor == 0.3 00:34:33 INFO - moztest == 0.7 00:34:33 INFO - mozversion == 1.4 00:34:33 INFO - psutil == 3.1.1 00:34:33 INFO - requests == 1.2.3 00:34:33 INFO - wsgiref == 0.1.2 00:34:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34:33 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 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34:33 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 00:34:33 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 00:34:33 INFO - Using env: {'DISPLAY': ':0', 00:34:33 INFO - 'HOME': '/home/cltbld', 00:34:33 INFO - 'LANG': 'en_US.UTF-8', 00:34:33 INFO - 'LANGUAGE': 'en_US:en', 00:34:33 INFO - 'LOGNAME': 'cltbld', 00:34:33 INFO - 'MAIL': '/var/mail/cltbld', 00:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:33 INFO - 'MOZ_NO_REMOTE': '1', 00:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:33 INFO - 'NO_EM_RESTART': '1', 00:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:33 INFO - 'PWD': '/builds/slave/test', 00:34:33 INFO - 'SHELL': '/bin/bash', 00:34:33 INFO - 'SHLVL': '1', 00:34:33 INFO - 'TERM': 'linux', 00:34:33 INFO - 'TMOUT': '86400', 00:34:33 INFO - 'USER': 'cltbld', 00:34:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:33 INFO - '_': '/tools/buildbot/bin/python'} 00:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 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)) 00:34:34 INFO - Cleaning up... 00:34:34 INFO - Return code: 0 00:34:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:34: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')]} 00:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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')]} 00:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34: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', 'jsonschema'] in /builds/slave/test/build 00:34: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 jsonschema 00:34:34 INFO - Using env: {'DISPLAY': ':0', 00:34:34 INFO - 'HOME': '/home/cltbld', 00:34:34 INFO - 'LANG': 'en_US.UTF-8', 00:34:34 INFO - 'LANGUAGE': 'en_US:en', 00:34:34 INFO - 'LOGNAME': 'cltbld', 00:34:34 INFO - 'MAIL': '/var/mail/cltbld', 00:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:34 INFO - 'MOZ_NO_REMOTE': '1', 00:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:34 INFO - 'NO_EM_RESTART': '1', 00:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:34 INFO - 'PWD': '/builds/slave/test', 00:34:34 INFO - 'SHELL': '/bin/bash', 00:34:34 INFO - 'SHLVL': '1', 00:34:34 INFO - 'TERM': 'linux', 00:34:34 INFO - 'TMOUT': '86400', 00:34:34 INFO - 'USER': 'cltbld', 00:34:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:34 INFO - '_': '/tools/buildbot/bin/python'} 00:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:34:34 INFO - Cleaning up... 00:34:34 INFO - Return code: 0 00:34:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:34: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')]} 00:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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')]} 00:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:34: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f17501fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', '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 00:34: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', 'flake8'] in /builds/slave/test/build 00:34: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 flake8 00:34:34 INFO - Using env: {'DISPLAY': ':0', 00:34:34 INFO - 'HOME': '/home/cltbld', 00:34:34 INFO - 'LANG': 'en_US.UTF-8', 00:34:34 INFO - 'LANGUAGE': 'en_US:en', 00:34:34 INFO - 'LOGNAME': 'cltbld', 00:34:34 INFO - 'MAIL': '/var/mail/cltbld', 00:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:34 INFO - 'MOZ_NO_REMOTE': '1', 00:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:34 INFO - 'NO_EM_RESTART': '1', 00:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:34 INFO - 'PWD': '/builds/slave/test', 00:34:34 INFO - 'SHELL': '/bin/bash', 00:34:34 INFO - 'SHLVL': '1', 00:34:34 INFO - 'TERM': 'linux', 00:34:34 INFO - 'TMOUT': '86400', 00:34:34 INFO - 'USER': 'cltbld', 00:34:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:34 INFO - '_': '/tools/buildbot/bin/python'} 00:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:34:34 INFO - Downloading/unpacking flake8 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:34:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:34:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34: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 00:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:34:37 INFO - no previously-included directories found matching 'docs/_build' 00:34:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:34:37 INFO - Running setup.py install for pep8 00:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:34:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:34:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:34:37 INFO - no previously-included directories found matching 'docs/_build' 00:34:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:34:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:34:37 INFO - Cleaning up... 00:34:37 INFO - Return code: 0 00:34:37 INFO - Running post-action listener: _resource_record_post_action 00:34:37 INFO - Running post-action listener: _start_resource_monitoring 00:34:37 INFO - Starting resource monitoring. 00:34:37 INFO - ##### 00:34:37 INFO - ##### Finished create-virtualenv step (success) 00:34:37 INFO - ##### 00:34:37 INFO - ##### 00:34:37 INFO - ##### Running install step. 00:34:37 INFO - ##### 00:34:37 INFO - Running pre-action listener: _resource_record_pre_action 00:34:37 INFO - Running main action method: install 00:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:34:37 INFO - Reading from file tmpfile_stdout 00:34:37 INFO - Detecting whether we're running mozinstall >=1.0... 00:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:34:37 INFO - Reading from file tmpfile_stdout 00:34:37 INFO - Output received: 00:34:37 INFO - Usage: mozinstall [options] installer 00:34:37 INFO - Options: 00:34:37 INFO - -h, --help show this help message and exit 00:34:37 INFO - -d DEST, --destination=DEST 00:34:37 INFO - Directory to install application into. [default: 00:34:37 INFO - "/builds/slave/test"] 00:34:37 INFO - --app=APP Application being installed. [default: firefox] 00:34:37 INFO - mkdir: /builds/slave/test/build/application 00:34:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:34:54 INFO - Reading from file tmpfile_stdout 00:34:54 INFO - Output received: 00:34:54 INFO - /builds/slave/test/build/application/firefox/firefox 00:34:54 INFO - Running post-action listener: _resource_record_post_action 00:34:54 INFO - ##### 00:34:54 INFO - ##### Finished install step (success) 00:34:54 INFO - ##### 00:34:54 INFO - ##### 00:34:54 INFO - ##### Running run-tests step. 00:34:54 INFO - ##### 00:34:54 INFO - Running pre-action listener: _resource_record_pre_action 00:34:54 INFO - Running main action method: run_tests 00:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:34:54 INFO - Python 2.7.3 00:34:54 INFO - Return code: 0 00:34:54 INFO - grabbing minidump binary from tooltool 00:34:54 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')]} 00:34:54 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 0x1c361c0>, '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 0x1c370c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c37550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:34:54 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 00:34:54 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 00:34:54 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 00:34:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:34:54 INFO - Return code: 0 00:34:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:34:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:34:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:34:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:34:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:34:55 INFO - Return code: 0 00:34:55 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/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 00:34:55 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/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 00:34:55 INFO - Using env: {'DISPLAY': ':0', 00:34:55 INFO - 'HOME': '/home/cltbld', 00:34:55 INFO - 'LANG': 'en_US.UTF-8', 00:34:55 INFO - 'LANGUAGE': 'en_US:en', 00:34:55 INFO - 'LOGNAME': 'cltbld', 00:34:55 INFO - 'MAIL': '/var/mail/cltbld', 00:34:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:34:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:34:55 INFO - 'MOZ_NO_REMOTE': '1', 00:34:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:34:55 INFO - 'NO_EM_RESTART': '1', 00:34:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:34:55 INFO - 'PWD': '/builds/slave/test', 00:34:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:34:55 INFO - 'SHELL': '/bin/bash', 00:34:55 INFO - 'SHLVL': '1', 00:34:55 INFO - 'TERM': 'linux', 00:34:55 INFO - 'TMOUT': '86400', 00:34:55 INFO - 'USER': 'cltbld', 00:34:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552', 00:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:34:55 INFO - '_': '/tools/buildbot/bin/python'} 00:34:55 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/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 00:34:55 INFO - mozversion application_buildid: 20160605214724 00:34:55 INFO - mozversion application_changeset: ce9080e6765eb54ba1d65df446e4d917edb18677 00:34:55 INFO - mozversion application_display_name: Nightly 00:34:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:34:55 INFO - mozversion application_name: Firefox 00:34:55 INFO - mozversion application_remotingname: firefox 00:34:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:34:55 INFO - mozversion application_vendor: Mozilla 00:34:55 INFO - mozversion application_version: 49.0a1 00:34:55 INFO - mozversion platform_buildid: 20160605214724 00:34:55 INFO - mozversion platform_changeset: ce9080e6765eb54ba1d65df446e4d917edb18677 00:34:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:34:55 INFO - mozversion platform_version: 49.0a1 00:34:55 INFO - using testdate: 1465198495 00:34:55 INFO - actual date: 1465198495 00:34:55 INFO - starting webserver on 'localhost:32802' 00:34:55 INFO - SUITE-START | Running 2 tests 00:34:55 INFO - TEST-START | dromaeo_css 00:34:55 INFO - operating with platform_type : linux_ 00:34:55 INFO - Initialising browser for dromaeo_css test... 00:34:55 INFO - TEST-INFO | started process 4101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6zlDoz/profile http://localhost:32802/getInfo.html) 00:34:59 INFO - PROCESS | 4101 | __metrics Screen width/height:1600/1200 00:34:59 INFO - PROCESS | 4101 | colorDepth:24 00:34:59 INFO - PROCESS | 4101 | Browser inner width/height: 1024/697 00:34:59 INFO - PROCESS | 4101 | __metrics 00:35:01 ERROR - PROCESS | 4101 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:35:01 INFO - TEST-INFO | 4101: exit 0 00:35:01 INFO - Browser initialized. 00:35:01 INFO - Running cycle 1/1 for dromaeo_css test... 00:35:01 INFO - TEST-INFO | started process 4183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6zlDoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:35:13 INFO - PROCESS | 4183 | RSS: Main: 156299264 00:35:13 INFO - PROCESS | 4183 | 00:36:04 INFO - PROCESS | 4183 | 1465198564903 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] 00:38:12 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32802/tests/dromaeo/cssquery-ext.html) 00:38:13 INFO - PROCESS | 4183 | RSS: Main: 258457600 00:38:13 INFO - PROCESS | 4183 | 00:41:16 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-ext.html (next: http://localhost:32802/tests/dromaeo/cssquery-jquery.html) 00:41:16 INFO - PROCESS | 4183 | RSS: Main: 237785088 00:41:16 INFO - PROCESS | 4183 | 00:44:18 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32802/tests/dromaeo/cssquery-mootools.html) 00:44:19 INFO - PROCESS | 4183 | RSS: Main: 244895744 00:44:19 INFO - PROCESS | 4183 | 00:47:21 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32802/tests/dromaeo/cssquery-prototype.html) 00:47:21 INFO - PROCESS | 4183 | RSS: Main: 234438656 00:47:21 INFO - PROCESS | 4183 | 00:50:24 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32802/tests/dromaeo/cssquery-yui.html) 00:50:25 INFO - PROCESS | 4183 | RSS: Main: 224677888 00:50:25 INFO - PROCESS | 4183 | 00:53:27 INFO - PROCESS | 4183 | Cycle 1(1): loaded http://localhost:32802/tests/dromaeo/cssquery-yui.html (next: http://localhost:32802/tests/dromaeo/cssquery-dojo.html) 00:53:28 INFO - PROCESS | 4183 | RSS: Main: 295100416 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | __start_tp_report 00:53:28 INFO - PROCESS | 4183 | _x_x_mozilla_page_load 00:53:28 INFO - PROCESS | 4183 | _x_x_mozilla_page_load_details 00:53:28 INFO - PROCESS | 4183 | |i|pagename|runs| 00:53:28 INFO - PROCESS | 4183 | |0;dojo.html;3086.1204556701337;3113.112762862584;3114.081346002929;3153.9369212615734;3171.3657268546294;5292.550133238679;5357.276767636368;5365.356157261129;5464.945350546498;5494.2582751328555;5358;5366;5396.973015134919;5459.454054594548;5495.368032676243;4824.951750482494;4901.2648102784515;4913.189323761575;4934.087193869128;5115.232715092748;5001.649884508086;5017.799288028493;5049.747512624373;5068.645194836363;5080.74596270185;4798.376211092553;4872.951270487285;4873.195922672755;4900.681455705403;4955;4875.414950205963;4894.2903279024695;4964.8758781030765;4966.453690094087;5019.021290848286;4776.355192049064;4913.778879950411;4923.827666031708;4928.556429921325;4939.753012349368;5264.6314757966575;5311.601629877736;5313.920291195596;5394.298741163663;5399.1091469907415;5834.2998840139035;5845.327787304472;5850.23946886902;5850.76596936122;5850.97074514629;5671.9716401418145;5782.97108514459;5870.11948207768;5880.206172166745;5885.176075349455;5445.264889239941;5531.3362396512275;5533.03171944908;5534.252875861747;5534.916976245319;6028.517718582503;6043.879122417615;6045.697715114315;6045.758169673164;6051.878962420815;5545.085060964896;5582.24639673647;5679.460451257124;5780.653160810365;5787.479126878601;5742.942570574241;5749.798757043567;5757.424257574293;5759.22250496186;5789.45000224978;5677.205191273225;5686.2039314496005;5708.65748055118;5713.257276554022;5714.342850572154;5620.156976453564;5704.172894930211;5713.628614140068;5729.140628905698;5748.19525266463;4379.1241751649795;4384.386185933972;4387.27609944362;4392.604665580113;4420.668449866273;3891.20230352777;3911.9217615647526;3927.3127202739406;3950.0322421007036;3979.1245925896255;5340.385855626575;5418.295621569249;5439.728013599304;5451.509364157245;5459.563234941195;5821.301443826768;5825.097109947965;5828.708564571754;5834.649921004753;5868.706564671749;5336.839894803162;5502.5597952163735;5502.642328248731;5504.532114770209;5521.254630624894;4787.234042553175;4827.565519103297;4840.564349208588;4853.708777473293;4868.707877527359;6004.459598636144;6014.0377539593455;6018.368071352533;6020.397960203944;6023.186869772525;5688.146777983336;5785.739641716049;5845.298564172326;5856.0630299151935;5867.383924688017;5984.8803023940145;6021.54838387114;6029.78895738647;6049.485793707584;6074.939250607437;5723.227364305765;5733.8566535836935;5734.311882574118;5737.5983681141915;5751.367349591458;5652;5781.392953739797;5782.681952492653;5831.591788574929;5840.094785308284;5733.455321744427;5738.254026976467;5743.396943321059;5760.395158508464;5781.017227071492;5650;5680.914786278292;5686.2323586315315;5694.288213973254;5713.971430142823;5447.1829225616475;5486.890262194814;5491.780328786804;5532.3637781654015;5613.494785469164;5670.603057785916;5677.5457963362005;5682.062459694104;5703.486686198262;5767.567432442667;5581.441855814386;5585.497305242548;5588.524975377139;5591.245181900392;5592.748326325243 00:53:28 INFO - PROCESS | 4183 | |1;ext.html;572.2789285500269;592.623683960685;605.0802779774742;614.6189362595192;632.010902936904;31009;31625;34375.82812085942;34483.482747758804;34504.827475862614;48590.51409485904;49605.25592116121;49619.25571116436;49658;49708;8572.228499435065;8697.391182617219;8697.95651021744;8701.17338852808;8707.216350528452;8760.956195219047;8854.601542930552;8867.68963086292;8868.911310886873;8875;8632.697855575056;8663.610137543825;8666.223424198055;8670;8681.088485708973;8832.20510154086;8880.289576833839;8898.86651700225;8902.243309318683;8906.42108262964;8865.645374185026;8948.328875334311;8949;8949.284057275467;8951.910480895172;43018;43309.78345108254;43435.78282108569;43449.782751086044;43531.78234108841;3093.535969604555;3321.667833216683;3340.498925161221;3622.4204127339763;4034.132661477767;32913.177170570685;33028.83485582581;33054;33398.3320333592;33492.832535837406;4319.438472998521;4323.265044942367;4367.388565600819;4391.934120988188;4407.3609326647775;362469;362751;363595;364027.17986410164;364624;60199.699001505585;60426.395736042956;60756.696216518634;60791.08813367715;60908.69545652244;45240.77379613147;66994.33005669978;68524.6573767128;68698.65650671815;68736;16119.919400403158;16208.75686864698;16249.593760155854;16295.103769292802;16327.428540001281;10666.733331666615;12087;12195.634130975908;12331.198472099284;12333.568325108577;17976.19107140182;18239.452816415527;18479;18855.622887542173;18870.339538116375;5648.49163575272;5683.760256653668;5698.430156984268;5730.914036289459;5776.797812076557;880.124276345028;914.9222316103205;917.6925729880564;918.536139249688;948.0186410402155;29217;33309.50035749466;34961.82519087388;35135.64864351375;37099.443508347395;1046.3774054437597;1092.257265059751;1118.8433619293305;1146.48408216303;1210.4855436439477;17282.914005258037;17451.73822392665;17463.38878139259;17546.473605791845;17553.47339579789;589714;592752.217433469;596142;596240;597507;59419.40580594225;59714.43141254459;59811.10283345753;59905.70047149823;59934;1299.4347458855239;1394.4073768648284;1396.3576754692956;1407.9648008799657;1438.8129543159323;32692.34615307633;33963.830180848934;34175.487367689006;34478.65521344855;34543.4818477718;51035;51162.488375115776;51687.48312516977;51755.482445176574;51800.222996654324;409639;414031;414101;415808;416094;45871.541284586725;46245.76877115593;46954.29568556406;47070.52929470661;48382.27426588674;47397;48800;52238.73880630572;53035.73482132565;53817.192742109684;42106.7894660537;42950.35574466323;43462.56537434585;43774.34338484862;44356.778216108716;41624.58375416207;42395.57604423916;42445.57554424416;45180.548194518946;45401.31898021466;43946.78026609847;44678;44815;44985.550144498135;45182.774086130674;38278.61721382862;38956.971066321654;39363;39731.80134099311;40174.79912600418;29097.272568185967;29595.412711029825;29880.85059574688;30233.395332093674;30384 00:53:28 INFO - PROCESS | 4183 | |2;jquery.html;373.1138545953361;378.5495260639838;384.2411237805335;388.60556535116876;398.9182217645383;15174.54476365708;16683.499495015138;17659.823401765978;20212.19151233951;20251.898740506294;17460.30158793647;17858.464246072606;18411.447656570323;18970;18976.810231897678;5420.566354691615;5446.074167391533;5531.059719847615;5586.497215250627;5594;3756.248750249947;5220.8694782630355;5230.895382092356;5503.504684578387;5522.144067669517;5467.17992301156;5542.75057622408;5565.721713914309;5570.944290557083;5603.383627800959;5426.593005524602;5498.890022199554;5582.692951887645;5616.129499927497;5629.60592758507;5367.35591728995;5396.676199428047;5399.568034557226;5399.946000540023;5405.567554595623;21184.682229766568;22151.44621384478;22221.666674999888;22225.110995560157;22470.32589022332;2189.9671504927437;2217.7671344508753;2224.3994121587243;2378.28846401378;2692.6364940732947;8909.777255568597;9511.096445837635;9549.713508594754;9617.807643847154;9862.45756483393;1744.2848432142887;1796.490947604006;1828.286968082449;1835.7246413038017;1871.9719204211947;52737.47262527402;60275.69862150661;62605.060924086174;76161.61919190425;81138.9999999994;10594.15246780271;10680.145588352912;10785.514651840685;10964.835527467094;10980.505877235544;15066.472673456376;15179.772303415457;15190.164540950133;15190.164540950354;15191.62020949463;7748.457607967388;7938.682452701827;7978.202179782092;8069.193080691884;8141.796455088552;7708.460407771514;7724.3434308083315;7737.381009519225;7750.418718596128;7858.214178582096;4616.60758835496;4654.232051711498;4689.132510485571;4708.693934894221;4768.713877167381;1681.1678219281534;1770.6547223291334;1778.5197996540862;1896.7534220551515;1909.9781616835205;1002.9498525073717;1011.7420057885192;1025.190099821133;1026.609888242463;1032.256775121911;18274.725879111826;18915.90542047281;18972.525686857938;19024.143913523923;19273.325433609756;975.4829940131741;977.0913050862624;980.2305190425482;1010.9949450252849;1033.813913495563;8480.660773568989;9972.950135249423;10479.738006549896;10599.311044782064;10603.787924241626;515216;516195;518755;524097;524786;55696.72151639216;88415.55792220998;89315;89470;89807.55096224477;864.9308055355682;874.6413970272158;880.5465185429509;883.8541640629225;887.843715591067;15253.635686468615;15297.923510382378;15765.29056192497;15790;15842;38918;39207.80396098001;40217.59782402139;40551.797241013606;40570.1885962285;54220.91558168893;54568;57027.42972570221;62848;63111;7141.785746427616;7403.407727381689;7453.40372770188;7857.567833769198;8355.415120941476;8807.339449541181;11318.547258109584;12211.145219834882;12254.87745122573;12374.195677280948;10664.573417063231;10676.83984740214;10806.837897431702;10862.945685271523;10890.346579205274;10318.690439286833;10689.144868410353;10741.301815381976;10799.784004319712;10881.673549793519;8684.522351270489;10179.931107233633;10412.427316497666;10714.25000249975;11105;7365.337119659256;7418.258174182754;7429.628518574158;7458.440616953641;7534.962325188339;10301.484925753832;10359.482025898524;10409.42748148859;10501.579936802442;10509.264351495322 00:53:28 INFO - PROCESS | 4183 | |3;mootools.html;1318.6373747219513;1371.2663724907177;1423.5658124272097;1484.7327481053405;1791.8476929460994;8555.10171432;8892.555372231387;8918.241949434298;9140.085991400872;9141.908580914189;8832;9034.548272586377;9035.367524273304;9038.367314288002;9042.638294468214;2039.88780617066;2267.353804165813;2341.496578235679;2354.5997180479276;2374.8931298091543;2356.0340260493203;2361.6929799126174;2363.2437619961534;2365.2431222008963;2365.5741966446035;2283.668868014137;2306.169778879602;2334.5914464968564;2337.731160916491;2341.063574570177;2019.1923230707687;2268.2968279833303;2345.8827058647084;2349.0251545608553;2350.764923507653;2320.6983092197906;2322.953540929189;2340.9180678676166;2343.8945247463903;2344.5545346384133;8859;8911.821763564758;8953.462792232487;8970.058143894928;8973.41672791273;5038.345015148007;5184.948150518484;5186.922196167023;5191.325127733408;5195;3104.28601421672;3191.680831916813;3244.4484437645656;3263.608366995952;3264.657210992835;1047.61238341814;1077.5097330714507;1080.8324709670014;1081.8052750504905;1102.608573956242;12797.872021279854;12802.16785908913;12815.935920320431;12821.294828784414;12828.358582070952;4346.869593912188;4406.757628330409;4464.15181115587;4520.299353600197;4539.795709193094;10720.142388608892;10720.46397680113;10727.088197503299;10740.624078157227;10740.838887416696;5112.667676601009;5113.233015047698;5114.053900028507;5114.053900028507;5117.488251174853;4041.6362527372676;4604.263317869125;4721.220998535203;4729.4797572267025;4778.880527986828;3991.3613821788376;4008.7193896427552;4067.7966101694797;4103.9179216415505;4124.4019617155345;1264.4689230523202;1274.4265080713717;1274.7832868412393;1284.877936596022;1286.4082522039967;836.7029704454952;948.5873644964463;954.1841725324886;977.2328721953232;978.0708327089152;5675.5459563234845;5846.678432686158;5849.590528663038;5934.554908381889;6192.752289908443;417.17815902671686;433.91538649962956;434.03210839827364;434.5068347425695;439.1392869974885;3846.480725102131;3861.8455261789777;3898.3957486589056;3898.688104951597;3936.0356712605594;10998.34009959405;11116.555337786398;11373;11389.772204555862;11423.657290281139;11190.552377904956;11272;11282.661520154408;11288.492017859217;11317.377544234982;8226.629801658939;8286.212809783061;8362.749117526484;8433.156684331518;8433.325333973391;5664.688442135557;5793.739281732248;5826.883462330645;5856.648601083949;5870.295564532113;10114.241431892491;10368.637097701545;10436.739081523023;10479.318844275098;10498.370097794157;10242.436665983145;10481.161507079263;10542.103921166787;10708.625198118028;10718.839217411589;6872.209695884837;7678.424118191047;7689.50018248812;7763.0684317882215;7844.921550784419;8551.1448855114;8551.486910785372;8578.828423431622;8613;8650.697225597074;7322.304381083789;7492.550446973199;7534.510256833289;7538.886916696364;7567.697292108254;7551.8867216992885;7677.808054798675;7694.345980591713;7795.64919578609;7942.761717148494;6963.1644202696;7053.858922821618;7093.361597456254;7098.041764361745;7099.148102227766;5102.566281865935;5220.791168353223;5232.476752324737;5355.3305836770405;5358.571314294769;4804.95195048045;4835.032993401263;4908.141075311878;5097.158968770112;5277.868053298698 00:53:28 INFO - PROCESS | 4183 | |4;prototype.html;300.82401794949953;315.60234105027666;319.39474695452134;322.78696060600004;325.95436638870564;4931.506849315067;5177.352830896138;5331.626786124973;5394.676319420838;5396.325459317585;5297.841064768054;5317.149256119022;5318.9202161967505;5361.892762144755;5372.274742909716;4182.351735480997;4208.263553878074;4209.768462734548;4214.536400995888;4223.556526564713;3984.5218573771044;4079.102597428561;4180.979095104521;4189.413482112506;4191.413202151702;4130.958690413103;4133.731307465006;4161.105362347094;4163.979180104096;4170.082581831992;4100.138970816132;4106.445629839978;4136.772477513736;4155.210510003089;4159.00735294118;3338.2488939988552;3677.2829298286847;3680.9815950920342;3683.771318352385;3710.2394009228315;5086.643934924557;5123.615728820353;5148.279240906276;5152.896942061176;5158.509941555546;4672.906541869178;4675.4155730533685;4679.812807487697;4680.204365257914;4691.812327506896;5400.486953739389;5427.887283106954;5453.972730136324;5535.509020940553;5547.389787123413;3904.3557812960826;3913.66733827625;3917.5494818096;3925.8625948091967;3931.0761970936805;5491.643043202179;5664.716764161775;5752.223449834302;5784.623999440023;5807;3897.707671924617;3929.9171439137303;3941;3943.8225279862477;4021.2761702893176;4026;4045.4943132108488;4047.5547689754103;4047.8785636430953;4072.6538244248977;4538.228501154812;4631.583157515773;4654.697444666086;4666.673332866667;4671.1358398695675;5469.206964990054;5483.698396588146;5527.53015993637;5564.1931919871395;5571.442855714477;1343.2813444807177;1378.2144177818748;1378.63466181462;1381.9447222111003;1382.6266907935003;824.8721448175543;852.1435956863437;861.4831101339272;866.5147517390155;873.0004145253649;4766.45185803637;4772.3557319762085;4802.927956080662;4829.773947795678;4851.320815085891;5011.724355160428;5037.471065538139;5069.239614057847;5069.7465126744255;5082.567981721595;4805.447373552016;4823.3729615150505;4828.710277383298;4859.829905953275;4959.70241785494;3040.9239769005953;3065.402246561899;3069.8004629699444;3071.508558630608;3075.9692403075683;5845.152452894306;5846.970765146147;5870.324912635102;5963.7912673056235;5978.133170690226;5591.7483713233005;5844.26946631671;5848.590598658138;5853.795117170878;5856.912146317809;5857.853553661193;5872.882542349129;5889.5582831286965;5898.616589921641;5913.319968203626;5623.2127502148915;5654.667091430497;5714.485696287354;5757.827265182052;5765.818007308576;5629.718514074362;5646.2942132233475;5659.490645841894;5687.77248910039;5741;5628.718564071698;5705.258316418839;5828.154917537018;5895.492182151613;5912.349641539513;3983.3029219885825;4000.1599664070873;4000.7999600020466;4015.277250095011;4017.91964160721;5666.376698563073;5690.231818704422;5714.342850572238;5729.885402292014;5732.197492351158;5284.867878303073;5589.021921163861;5607.102863541813;5615.3823079462045;5638.971805140948;5584.636998595079;5592.189132575835;5601.579881508822;5602.383737788921;5628.60599758013;5262.263283140287;5491.176323551499;5495.477929596682;5547.1679248111495;5592.804251851166;5589.692566908859;5628.74670639814;5641.548676105984;5666.744996475086;5699.945510080648;5457.0627427264335;5507.586930980113;5521.944780552143;5529.474699903502;5533.889322213614 00:53:28 INFO - PROCESS | 4183 | |5;yui.html;584.4885724990635;626.4988009592327;658.8451713847245;678.1760161403896;722.7181399254289;11373.829392559119;11938.283702977827;13836.792448113274;14033.087849289788;14157.646058848533;13008;13713.520026799064;13737.519186828464;13742.931285343584;13748.931255343708;672.2907332763932;791.8218400859789;798.4291231769283;799.9880001799978;801.1027649033091;797.0554892452434;798.022422532399;801.5911884938665;801.6592947997107;804.6620419423856;841.4614646626134;846.1115828380207;847.3052097280232;847.4449235750562;848.5417874347845;830.8753686946945;831.6049876308765;840.5671079394117;840.7309660908512;840.794005468661;607.2955371768727;607.6172011632643;608.4675908579992;608.7777961044231;609.3297372889785;12395.690107747378;12479.126461147724;12487.812682809765;12501.56244531437;12510.562130325487;13618.727625447535;13636.386362613706;13951.232682202475;14221.644458888508;14362.13827170373;11003;11032.44837758117;11074.889251107466;11198.888011119867;11401.48693308803;3781.640744129303;3800.7529510582;3813.275477659236;3829.157585331223;3877.9917221522323;50300.245496317584;61045;63928.360716393174;64457.67771161161;70898;10417.843732344021;10540.420276884844;10569.471526423647;10690.585648610771;10727.034566889017;19284.8071519283;19586.31447899317;19824.90087549553;19861.205551778057;19863.702044469344;7860;7914.841703166019;7924.20757924203;7992.600369981477;8121.228483294078;4279.614834664895;4453.198424283595;4486.865394038184;4510.594046535762;4619.491855895849;3258.3971965186515;3316.1378041708845;3366.5286859839644;3406.131436483681;3407.795532268072;646.7930262316107;647.9125318082093;659.986800263992;661.8940969444866;663.4360793325731;494.9331840201599;657.4477438951304;672.7981605518324;688.8760023195773;689.1454596300651;9044.317455242908;9397.671081512115;9489.715308540755;9496.43021418717;9518.47648379332;603.5533705058225;638.9712462939179;696.084648686975;708.4190963409955;717.3185473799911;4101.85643502476;4196.853110141131;4345.261305578059;4394.604485596312;4399.824007039747;76965.61517192378;119116;125431;128395;129208.3539582296;87760;109646.32475726782;110797.44601276942;111269;111552.44223778829;59298;75651.43485651391;76220.61889690516;81189.59405203054;87128.12871871327;8767.780805479913;9090.454572725657;9101.226395756436;9108.544572771467;9116.453012819253;52034.479655202966;52767.20849187188;52975.73512132415;53151.468485314654;55694.152114029064;50258;66181.37458316097;72694.27305726874;74315;77745;11702.180847340946;12014.579489717818;12250.448729807358;12332.938335308267;12739.808902866649;13322.866771332163;13427.19436833793;13549.390277437737;13569.86430135686;13916.860831391556;11777.411129443322;11801.173917826014;11808.232464889754;11954.282743035097;12100.45547950362;12601.306928119042;12697.238165710087;12716.173448725804;12722.427490763122;13434.328283585977;11688.123390745897;11698.590549331073;11783.293002419883;12980.740385192432;12981.935090324489;10054.89945100569;10142.391456512632;10163.644272450725;10284.177265818866;10449.111825494918;10152.847707284544;10297.279190456597;10345.327553708985;10358.326708763907;10399.688009359732 00:53:28 INFO - PROCESS | 4183 | __end_tp_report 00:53:28 INFO - PROCESS | 4183 | __start_cc_report 00:53:28 INFO - PROCESS | 4183 | _x_x_mozilla_cycle_collect,925 00:53:28 INFO - PROCESS | 4183 | __end_cc_report 00:53:28 INFO - PROCESS | 4183 | __startTimestamp1465199608149__endTimestamp 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | ------- Summary: start ------- 00:53:28 INFO - PROCESS | 4183 | Number of tests: 6 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#0] dojo.html Cycles:165 Average:5379.95 Median:5585.50 stddev:622.71 (11.1%) stddev-sans-first:598.06 00:53:28 INFO - PROCESS | 4183 | Values: 3086.1 3113.1 3114.1 3153.9 3171.4 5292.6 5357.3 5365.4 5464.9 5494.3 5358.0 5366.0 5397.0 5459.5 5495.4 4825.0 4901.3 4913.2 4934.1 5115.2 5001.6 5017.8 5049.7 5068.6 5080.7 4798.4 4873.0 4873.2 4900.7 4955.0 4875.4 4894.3 4964.9 4966.5 5019.0 4776.4 4913.8 4923.8 4928.6 4939.8 5264.6 5311.6 5313.9 5394.3 5399.1 5834.3 5845.3 5850.2 5850.8 5851.0 5672.0 5783.0 5870.1 5880.2 5885.2 5445.3 5531.3 5533.0 5534.3 5534.9 6028.5 6043.9 6045.7 6045.8 6051.9 5545.1 5582.2 5679.5 5780.7 5787.5 5742.9 5749.8 5757.4 5759.2 5789.5 5677.2 5686.2 5708.7 5713.3 5714.3 5620.2 5704.2 5713.6 5729.1 5748.2 4379.1 4384.4 4387.3 4392.6 4420.7 3891.2 3911.9 3927.3 3950.0 3979.1 5340.4 5418.3 5439.7 5451.5 5459.6 5821.3 5825.1 5828.7 5834.6 5868.7 5336.8 5502.6 5502.6 5504.5 5521.3 4787.2 4827.6 4840.6 4853.7 4868.7 6004.5 6014.0 6018.4 6020.4 6023.2 5688.1 5785.7 5845.3 5856.1 5867.4 5984.9 6021.5 6029.8 6049.5 6074.9 5723.2 5733.9 5734.3 5737.6 5751.4 5652.0 5781.4 5782.7 5831.6 5840.1 5733.5 5738.3 5743.4 5760.4 5781.0 5650.0 5680.9 5686.2 5694.3 5714.0 5447.2 5486.9 5491.8 5532.4 5613.5 5670.6 5677.5 5682.1 5703.5 5767.6 5581.4 5585.5 5588.5 5591.2 5592.7 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#1] ext.html Cycles:180 Average:62742.46 Median:24169.36 stddev:124235.98 (514.0%) stddev-sans-first:124496.80 00:53:28 INFO - PROCESS | 4183 | Values: 572.3 592.6 605.1 614.6 632.0 31009.0 31625.0 34375.8 34483.5 34504.8 48590.5 49605.3 49619.3 49658.0 49708.0 8572.2 8697.4 8698.0 8701.2 8707.2 8761.0 8854.6 8867.7 8868.9 8875.0 8632.7 8663.6 8666.2 8670.0 8681.1 8832.2 8880.3 8898.9 8902.2 8906.4 8865.6 8948.3 8949.0 8949.3 8951.9 43018.0 43309.8 43435.8 43449.8 43531.8 3093.5 3321.7 3340.5 3622.4 4034.1 32913.2 33028.8 33054.0 33398.3 33492.8 4319.4 4323.3 4367.4 4391.9 4407.4 362469.0 362751.0 363595.0 364027.2 364624.0 60199.7 60426.4 60756.7 60791.1 60908.7 45240.8 66994.3 68524.7 68698.7 68736.0 16119.9 16208.8 16249.6 16295.1 16327.4 10666.7 12087.0 12195.6 12331.2 12333.6 17976.2 18239.5 18479.0 18855.6 18870.3 5648.5 5683.8 5698.4 5730.9 5776.8 880.1 914.9 917.7 918.5 948.0 29217.0 33309.5 34961.8 35135.6 37099.4 1046.4 1092.3 1118.8 1146.5 1210.5 17282.9 17451.7 17463.4 17546.5 17553.5 589714.0 592752.2 596142.0 596240.0 597507.0 59419.4 59714.4 59811.1 59905.7 59934.0 1299.4 1394.4 1396.4 1408.0 1438.8 32692.3 33963.8 34175.5 34478.7 34543.5 51035.0 51162.5 51687.5 51755.5 51800.2 409639.0 414031.0 414101.0 415808.0 416094.0 45871.5 46245.8 46954.3 47070.5 48382.3 47397.0 48800.0 52238.7 53035.7 53817.2 42106.8 42950.4 43462.6 43774.3 44356.8 41624.6 42395.6 42445.6 45180.5 45401.3 43946.8 44678.0 44815.0 44985.6 45182.8 38278.6 38957.0 39363.0 39731.8 40174.8 29097.3 29595.4 29880.9 30233.4 30384.0 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#2] jquery.html Cycles:180 Average:28634.03 Median:20308.26 stddev:85308.68 (420.1%) stddev-sans-first:85521.61 00:53:28 INFO - PROCESS | 4183 | Values: 373.1 378.5 384.2 388.6 398.9 15174.5 16683.5 17659.8 20212.2 20251.9 17460.3 17858.5 18411.4 18970.0 18976.8 5420.6 5446.1 5531.1 5586.5 5594.0 3756.2 5220.9 5230.9 5503.5 5522.1 5467.2 5542.8 5565.7 5570.9 5603.4 5426.6 5498.9 5582.7 5616.1 5629.6 5367.4 5396.7 5399.6 5399.9 5405.6 21184.7 22151.4 22221.7 22225.1 22470.3 2190.0 2217.8 2224.4 2378.3 2692.6 8909.8 9511.1 9549.7 9617.8 9862.5 1744.3 1796.5 1828.3 1835.7 1872.0 52737.5 60275.7 62605.1 76161.6 81139.0 10594.2 10680.1 10785.5 10964.8 10980.5 15066.5 15179.8 15190.2 15190.2 15191.6 7748.5 7938.7 7978.2 8069.2 8141.8 7708.5 7724.3 7737.4 7750.4 7858.2 4616.6 4654.2 4689.1 4708.7 4768.7 1681.2 1770.7 1778.5 1896.8 1910.0 1002.9 1011.7 1025.2 1026.6 1032.3 18274.7 18915.9 18972.5 19024.1 19273.3 975.5 977.1 980.2 1011.0 1033.8 8480.7 9973.0 10479.7 10599.3 10603.8 515216.0 516195.0 518755.0 524097.0 524786.0 55696.7 88415.6 89315.0 89470.0 89807.6 864.9 874.6 880.5 883.9 887.8 15253.6 15297.9 15765.3 15790.0 15842.0 38918.0 39207.8 40217.6 40551.8 40570.2 54220.9 54568.0 57027.4 62848.0 63111.0 7141.8 7403.4 7453.4 7857.6 8355.4 8807.3 11318.5 12211.1 12254.9 12374.2 10664.6 10676.8 10806.8 10862.9 10890.3 10318.7 10689.1 10741.3 10799.8 10881.7 8684.5 10179.9 10412.4 10714.3 11105.0 7365.3 7418.3 7429.6 7458.4 7535.0 10301.5 10359.5 10409.4 10501.6 10509.3 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#3] mootools.html Cycles:180 Average:5828.16 Median:2393.00 stddev:3448.85 (144.1%) stddev-sans-first:3441.87 00:53:28 INFO - PROCESS | 4183 | Values: 1318.6 1371.3 1423.6 1484.7 1791.8 8555.1 8892.6 8918.2 9140.1 9141.9 8832.0 9034.5 9035.4 9038.4 9042.6 2039.9 2267.4 2341.5 2354.6 2374.9 2356.0 2361.7 2363.2 2365.2 2365.6 2283.7 2306.2 2334.6 2337.7 2341.1 2019.2 2268.3 2345.9 2349.0 2350.8 2320.7 2323.0 2340.9 2343.9 2344.6 8859.0 8911.8 8953.5 8970.1 8973.4 5038.3 5184.9 5186.9 5191.3 5195.0 3104.3 3191.7 3244.4 3263.6 3264.7 1047.6 1077.5 1080.8 1081.8 1102.6 12797.9 12802.2 12815.9 12821.3 12828.4 4346.9 4406.8 4464.2 4520.3 4539.8 10720.1 10720.5 10727.1 10740.6 10740.8 5112.7 5113.2 5114.1 5114.1 5117.5 4041.6 4604.3 4721.2 4729.5 4778.9 3991.4 4008.7 4067.8 4103.9 4124.4 1264.5 1274.4 1274.8 1284.9 1286.4 836.7 948.6 954.2 977.2 978.1 5675.5 5846.7 5849.6 5934.6 6192.8 417.2 433.9 434.0 434.5 439.1 3846.5 3861.8 3898.4 3898.7 3936.0 10998.3 11116.6 11373.0 11389.8 11423.7 11190.6 11272.0 11282.7 11288.5 11317.4 8226.6 8286.2 8362.7 8433.2 8433.3 5664.7 5793.7 5826.9 5856.6 5870.3 10114.2 10368.6 10436.7 10479.3 10498.4 10242.4 10481.2 10542.1 10708.6 10718.8 6872.2 7678.4 7689.5 7763.1 7844.9 8551.1 8551.5 8578.8 8613.0 8650.7 7322.3 7492.6 7534.5 7538.9 7567.7 7551.9 7677.8 7694.3 7795.6 7942.8 6963.2 7053.9 7093.4 7098.0 7099.1 5102.6 5220.8 5232.5 5355.3 5358.6 4805.0 4835.0 4908.1 5097.2 5277.9 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#4] prototype.html Cycles:180 Average:4623.42 Median:5167.93 stddev:1371.77 (26.5%) stddev-sans-first:1336.70 00:53:28 INFO - PROCESS | 4183 | Values: 300.8 315.6 319.4 322.8 326.0 4931.5 5177.4 5331.6 5394.7 5396.3 5297.8 5317.1 5318.9 5361.9 5372.3 4182.4 4208.3 4209.8 4214.5 4223.6 3984.5 4079.1 4181.0 4189.4 4191.4 4131.0 4133.7 4161.1 4164.0 4170.1 4100.1 4106.4 4136.8 4155.2 4159.0 3338.2 3677.3 3681.0 3683.8 3710.2 5086.6 5123.6 5148.3 5152.9 5158.5 4672.9 4675.4 4679.8 4680.2 4691.8 5400.5 5427.9 5454.0 5535.5 5547.4 3904.4 3913.7 3917.5 3925.9 3931.1 5491.6 5664.7 5752.2 5784.6 5807.0 3897.7 3929.9 3941.0 3943.8 4021.3 4026.0 4045.5 4047.6 4047.9 4072.7 4538.2 4631.6 4654.7 4666.7 4671.1 5469.2 5483.7 5527.5 5564.2 5571.4 1343.3 1378.2 1378.6 1381.9 1382.6 824.9 852.1 861.5 866.5 873.0 4766.5 4772.4 4802.9 4829.8 4851.3 5011.7 5037.5 5069.2 5069.7 5082.6 4805.4 4823.4 4828.7 4859.8 4959.7 3040.9 3065.4 3069.8 3071.5 3076.0 5845.2 5847.0 5870.3 5963.8 5978.1 5591.7 5844.3 5848.6 5853.8 5856.9 5857.9 5872.9 5889.6 5898.6 5913.3 5623.2 5654.7 5714.5 5757.8 5765.8 5629.7 5646.3 5659.5 5687.8 5741.0 5628.7 5705.3 5828.2 5895.5 5912.3 3983.3 4000.2 4000.8 4015.3 4017.9 5666.4 5690.2 5714.3 5729.9 5732.2 5284.9 5589.0 5607.1 5615.4 5639.0 5584.6 5592.2 5601.6 5602.4 5628.6 5262.3 5491.2 5495.5 5547.2 5592.8 5589.7 5628.7 5641.5 5666.7 5699.9 5457.1 5507.6 5521.9 5529.5 5533.9 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - PROCESS | 4183 | [#5] yui.html Cycles:180 Average:19671.44 Median:4312.44 stddev:29531.03 (684.8%) stddev-sans-first:29579.09 00:53:28 INFO - PROCESS | 4183 | Values: 584.5 626.5 658.8 678.2 722.7 11373.8 11938.3 13836.8 14033.1 14157.6 13008.0 13713.5 13737.5 13742.9 13748.9 672.3 791.8 798.4 800.0 801.1 797.1 798.0 801.6 801.7 804.7 841.5 846.1 847.3 847.4 848.5 830.9 831.6 840.6 840.7 840.8 607.3 607.6 608.5 608.8 609.3 12395.7 12479.1 12487.8 12501.6 12510.6 13618.7 13636.4 13951.2 14221.6 14362.1 11003.0 11032.4 11074.9 11198.9 11401.5 3781.6 3800.8 3813.3 3829.2 3878.0 50300.2 61045.0 63928.4 64457.7 70898.0 10417.8 10540.4 10569.5 10690.6 10727.0 19284.8 19586.3 19824.9 19861.2 19863.7 7860.0 7914.8 7924.2 7992.6 8121.2 4279.6 4453.2 4486.9 4510.6 4619.5 3258.4 3316.1 3366.5 3406.1 3407.8 646.8 647.9 660.0 661.9 663.4 494.9 657.4 672.8 688.9 689.1 9044.3 9397.7 9489.7 9496.4 9518.5 603.6 639.0 696.1 708.4 717.3 4101.9 4196.9 4345.3 4394.6 4399.8 76965.6 119116.0 125431.0 128395.0 129208.4 87760.0 109646.3 110797.4 111269.0 111552.4 59298.0 75651.4 76220.6 81189.6 87128.1 8767.8 9090.5 9101.2 9108.5 9116.5 52034.5 52767.2 52975.7 53151.5 55694.2 50258.0 66181.4 72694.3 74315.0 77745.0 11702.2 12014.6 12250.4 12332.9 12739.8 13322.9 13427.2 13549.4 13569.9 13916.9 11777.4 11801.2 11808.2 11954.3 12100.5 12601.3 12697.2 12716.2 12722.4 13434.3 11688.1 11698.6 11783.3 12980.7 12981.9 10054.9 10142.4 10163.6 10284.2 10449.1 10152.8 10297.3 10345.3 10358.3 10399.7 00:53:28 INFO - PROCESS | 4183 | -------- Summary: end -------- 00:53:28 INFO - PROCESS | 4183 | 00:53:28 INFO - TEST-INFO | 4183: exit 0 00:53:28 INFO - TEST-OK | dromaeo_css | took 1113182ms 00:53:28 INFO - TEST-START | kraken 00:53:28 INFO - operating with platform_type : linux_ 00:53:28 INFO - Initialising browser for kraken test... 00:53:28 INFO - TEST-INFO | started process 4363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1eXzhu/profile http://localhost:32802/getInfo.html) 00:53:33 INFO - PROCESS | 4363 | __metrics Screen width/height:1600/1200 00:53:33 INFO - PROCESS | 4363 | colorDepth:24 00:53:33 INFO - PROCESS | 4363 | Browser inner width/height: 1024/697 00:53:33 INFO - PROCESS | 4363 | __metrics 00:53:34 ERROR - PROCESS | 4363 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:53:34 INFO - TEST-INFO | 4363: exit 0 00:53:34 INFO - Browser initialized. 00:53:34 INFO - Running cycle 1/1 for kraken test... 00:53:34 INFO - TEST-INFO | started process 4446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1eXzhu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:53:46 INFO - PROCESS | 4446 | RSS: Main: 156078080 00:53:46 INFO - PROCESS | 4446 | 00:53:49 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32802/tests/kraken/driver.html?testName=audio-beat-detection) 00:53:50 INFO - PROCESS | 4446 | RSS: Main: 215113728 00:53:50 INFO - PROCESS | 4446 | 00:53:52 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32802/tests/kraken/driver.html?testName=audio-dft) 00:53:53 INFO - PROCESS | 4446 | RSS: Main: 201527296 00:53:53 INFO - PROCESS | 4446 | 00:53:56 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32802/tests/kraken/driver.html?testName=audio-fft) 00:53:57 INFO - PROCESS | 4446 | RSS: Main: 268267520 00:53:57 INFO - PROCESS | 4446 | 00:53:59 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32802/tests/kraken/driver.html?testName=audio-oscillator) 00:53:59 INFO - PROCESS | 4446 | RSS: Main: 180084736 00:53:59 INFO - PROCESS | 4446 | 00:54:02 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:54:02 INFO - PROCESS | 4446 | RSS: Main: 183558144 00:54:02 INFO - PROCESS | 4446 | 00:54:05 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32802/tests/kraken/driver.html?testName=imaging-darkroom) 00:54:06 INFO - PROCESS | 4446 | RSS: Main: 219267072 00:54:06 INFO - PROCESS | 4446 | 00:54:09 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32802/tests/kraken/driver.html?testName=imaging-desaturate) 00:54:10 INFO - PROCESS | 4446 | RSS: Main: 220323840 00:54:10 INFO - PROCESS | 4446 | 00:54:13 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32802/tests/kraken/driver.html?testName=json-parse-financial) 00:54:13 INFO - PROCESS | 4446 | RSS: Main: 220291072 00:54:13 INFO - PROCESS | 4446 | 00:54:15 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:54:15 INFO - PROCESS | 4446 | RSS: Main: 205717504 00:54:15 INFO - PROCESS | 4446 | 00:54:17 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:54:18 INFO - PROCESS | 4446 | RSS: Main: 209596416 00:54:18 INFO - PROCESS | 4446 | 00:54:20 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:54:20 INFO - PROCESS | 4446 | RSS: Main: 218349568 00:54:20 INFO - PROCESS | 4446 | 00:54:23 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:54:24 INFO - PROCESS | 4446 | RSS: Main: 223166464 00:54:24 INFO - PROCESS | 4446 | 00:54:26 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:54:27 INFO - PROCESS | 4446 | RSS: Main: 223162368 00:54:27 INFO - PROCESS | 4446 | 00:54:28 INFO - PROCESS | 4446 | Cycle 1(1): loaded http://localhost:32802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32802/tests/kraken/driver.html?testName=ai-astar) 00:54:29 INFO - PROCESS | 4446 | RSS: Main: 265318400 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | __start_tp_report 00:54:29 INFO - PROCESS | 4446 | _x_x_mozilla_page_load 00:54:29 INFO - PROCESS | 4446 | _x_x_mozilla_page_load_details 00:54:29 INFO - PROCESS | 4446 | |i|pagename|runs| 00:54:29 INFO - PROCESS | 4446 | |0;ai-astar;111;105;110;110;110;110;109;111;111;110 00:54:29 INFO - PROCESS | 4446 | |1;audio-beat-detection;156;124;127;177;126;128;158;124;153;124 00:54:29 INFO - PROCESS | 4446 | |2;audio-dft;161;161;161;161;160;161;163;161;161;161 00:54:29 INFO - PROCESS | 4446 | |3;audio-fft;74;75;77;123;76;75;73;73;97;74 00:54:29 INFO - PROCESS | 4446 | |4;audio-oscillator;84;85;109;84;84;86;116;84;86;120 00:54:29 INFO - PROCESS | 4446 | |5;imaging-gaussian-blur;116;118;116;117;117;117;117;117;116;116 00:54:29 INFO - PROCESS | 4446 | |6;imaging-darkroom;146;146;146;145;146;147;146;145;145;144 00:54:29 INFO - PROCESS | 4446 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 00:54:29 INFO - PROCESS | 4446 | |8;json-parse-financial;53;55;54;54;52;54;54;54;54;53 00:54:29 INFO - PROCESS | 4446 | |9;json-stringify-tinderbox;62;62;62;63;63;63;62;63;63;62 00:54:29 INFO - PROCESS | 4446 | |10;stanford-crypto-aes;85;79;79;79;79;81;82;86;105;80 00:54:29 INFO - PROCESS | 4446 | |11;stanford-crypto-ccm;122;123;143;119;131;121;120;121;128;127 00:54:29 INFO - PROCESS | 4446 | |12;stanford-crypto-pbkdf2;158;157;158;158;159;159;156;156;158;158 00:54:29 INFO - PROCESS | 4446 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;63;62;61;71;60 00:54:29 INFO - PROCESS | 4446 | __end_tp_report 00:54:29 INFO - PROCESS | 4446 | __start_cc_report 00:54:29 INFO - PROCESS | 4446 | _x_x_mozilla_cycle_collect,1637 00:54:29 INFO - PROCESS | 4446 | __end_cc_report 00:54:29 INFO - PROCESS | 4446 | __startTimestamp1465199669208__endTimestamp 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | ------- Summary: start ------- 00:54:29 INFO - PROCESS | 4446 | Number of tests: 14 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.77 (1.6%) stddev-sans-first:1.81 00:54:29 INFO - PROCESS | 4446 | Values: 111.0 105.0 110.0 110.0 110.0 110.0 109.0 111.0 111.0 110.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:140.50 stddev:19.42 (13.8%) stddev-sans-first:19.68 00:54:29 INFO - PROCESS | 4446 | Values: 156.0 124.0 127.0 177.0 126.0 128.0 158.0 124.0 153.0 124.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 00:54:29 INFO - PROCESS | 4446 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 163.0 161.0 161.0 161.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:16.17 (21.6%) stddev-sans-first:16.91 00:54:29 INFO - PROCESS | 4446 | Values: 74.0 75.0 77.0 123.0 76.0 75.0 73.0 73.0 97.0 74.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.00 stddev:14.88 (17.7%) stddev-sans-first:15.36 00:54:29 INFO - PROCESS | 4446 | Values: 84.0 85.0 109.0 84.0 84.0 86.0 116.0 84.0 86.0 120.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:54:29 INFO - PROCESS | 4446 | Values: 116.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 00:54:29 INFO - PROCESS | 4446 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 144.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 00:54:29 INFO - PROCESS | 4446 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 00:54:29 INFO - PROCESS | 4446 | Values: 53.0 55.0 54.0 54.0 52.0 54.0 54.0 54.0 54.0 53.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 00:54:29 INFO - PROCESS | 4446 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 62.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.50 stddev:7.98 (9.9%) stddev-sans-first:8.44 00:54:29 INFO - PROCESS | 4446 | Values: 85.0 79.0 79.0 79.0 79.0 81.0 82.0 86.0 105.0 80.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:125.00 stddev:7.28 (5.8%) stddev-sans-first:7.61 00:54:29 INFO - PROCESS | 4446 | Values: 122.0 123.0 143.0 119.0 131.0 121.0 120.0 121.0 128.0 127.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 00:54:29 INFO - PROCESS | 4446 | Values: 158.0 157.0 158.0 158.0 159.0 159.0 156.0 156.0 158.0 158.0 00:54:29 INFO - PROCESS | 4446 | 00:54:29 INFO - PROCESS | 4446 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:3.01 (4.9%) stddev-sans-first:3.18 00:54:29 INFO - PROCESS | 4446 | Values: 62.0 62.0 63.0 62.0 62.0 63.0 62.0 61.0 71.0 60.0 00:54:29 INFO - PROCESS | 4446 | -------- Summary: end -------- 00:54:29 INFO - PROCESS | 4446 | 00:54:30 INFO - TEST-INFO | 4446: exit 0 00:54:30 INFO - TEST-OK | kraken | took 61345ms 00:54:30 INFO - SUITE-END | took 1174s 00:54:30 INFO - Completed test suite (00:19:34) 00:54:30 INFO - javascript benchmark 00:54:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.1204556701337, 3113.112762862584, 3114.081346002929, 3153.9369212615734, 3171.3657268546294, 5292.550133238679, 5357.276767636368, 5365.356157261129, 5464.945350546498, 5494.2582751328555, 5358.0, 5366.0, 5396.973015134919, 5459.454054594548, 5495.368032676243, 4824.951750482494, 4901.2648102784515, 4913.189323761575, 4934.087193869128, 5115.232715092748, 5001.649884508086, 5017.799288028493, 5049.747512624373, 5068.645194836363, 5080.74596270185, 4798.376211092553, 4872.951270487285, 4873.195922672755, 4900.681455705403, 4955.0, 4875.414950205963, 4894.2903279024695, 4964.8758781030765, 4966.453690094087, 5019.021290848286, 4776.355192049064, 4913.778879950411, 4923.827666031708, 4928.556429921325, 4939.753012349368, 5264.6314757966575, 5311.601629877736, 5313.920291195596, 5394.298741163663, 5399.1091469907415, 5834.2998840139035, 5845.327787304472, 5850.23946886902, 5850.76596936122, 5850.97074514629, 5671.9716401418145, 5782.97108514459, 5870.11948207768, 5880.206172166745, 5885.176075349455, 5445.264889239941, 5531.3362396512275, 5533.03171944908, 5534.252875861747, 5534.916976245319, 6028.517718582503, 6043.879122417615, 6045.697715114315, 6045.758169673164, 6051.878962420815, 5545.085060964896, 5582.24639673647, 5679.460451257124, 5780.653160810365, 5787.479126878601, 5742.942570574241, 5749.798757043567, 5757.424257574293, 5759.22250496186, 5789.45000224978, 5677.205191273225, 5686.2039314496005, 5708.65748055118, 5713.257276554022, 5714.342850572154, 5620.156976453564, 5704.172894930211, 5713.628614140068, 5729.140628905698, 5748.19525266463, 4379.1241751649795, 4384.386185933972, 4387.27609944362, 4392.604665580113, 4420.668449866273, 3891.20230352777, 3911.9217615647526, 3927.3127202739406, 3950.0322421007036, 3979.1245925896255, 5340.385855626575, 5418.295621569249, 5439.728013599304, 5451.509364157245, 5459.563234941195, 5821.301443826768, 5825.097109947965, 5828.708564571754, 5834.649921004753, 5868.706564671749, 5336.839894803162, 5502.5597952163735, 5502.642328248731, 5504.532114770209, 5521.254630624894, 4787.234042553175, 4827.565519103297, 4840.564349208588, 4853.708777473293, 4868.707877527359, 6004.459598636144, 6014.0377539593455, 6018.368071352533, 6020.397960203944, 6023.186869772525, 5688.146777983336, 5785.739641716049, 5845.298564172326, 5856.0630299151935, 5867.383924688017, 5984.8803023940145, 6021.54838387114, 6029.78895738647, 6049.485793707584, 6074.939250607437, 5723.227364305765, 5733.8566535836935, 5734.311882574118, 5737.5983681141915, 5751.367349591458, 5652.0, 5781.392953739797, 5782.681952492653, 5831.591788574929, 5840.094785308284, 5733.455321744427, 5738.254026976467, 5743.396943321059, 5760.395158508464, 5781.017227071492, 5650.0, 5680.914786278292, 5686.2323586315315, 5694.288213973254, 5713.971430142823, 5447.1829225616475, 5486.890262194814, 5491.780328786804, 5532.3637781654015, 5613.494785469164, 5670.603057785916, 5677.5457963362005, 5682.062459694104, 5703.486686198262, 5767.567432442667, 5581.441855814386, 5585.497305242548, 5588.524975377139, 5591.245181900392, 5592.748326325243], "value": 5337.19077985097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.2789285500269, 592.623683960685, 605.0802779774742, 614.6189362595192, 632.010902936904, 31009.0, 31625.0, 34375.82812085942, 34483.482747758804, 34504.827475862614, 48590.51409485904, 49605.25592116121, 49619.25571116436, 49658.0, 49708.0, 8572.228499435065, 8697.391182617219, 8697.95651021744, 8701.17338852808, 8707.216350528452, 8760.956195219047, 8854.601542930552, 8867.68963086292, 8868.911310886873, 8875.0, 8632.697855575056, 8663.610137543825, 8666.223424198055, 8670.0, 8681.088485708973, 8832.20510154086, 8880.289576833839, 8898.86651700225, 8902.243309318683, 8906.42108262964, 8865.645374185026, 8948.328875334311, 8949.0, 8949.284057275467, 8951.910480895172, 43018.0, 43309.78345108254, 43435.78282108569, 43449.782751086044, 43531.78234108841, 3093.535969604555, 3321.667833216683, 3340.498925161221, 3622.4204127339763, 4034.132661477767, 32913.177170570685, 33028.83485582581, 33054.0, 33398.3320333592, 33492.832535837406, 4319.438472998521, 4323.265044942367, 4367.388565600819, 4391.934120988188, 4407.3609326647775, 362469.0, 362751.0, 363595.0, 364027.17986410164, 364624.0, 60199.699001505585, 60426.395736042956, 60756.696216518634, 60791.08813367715, 60908.69545652244, 45240.77379613147, 66994.33005669978, 68524.6573767128, 68698.65650671815, 68736.0, 16119.919400403158, 16208.75686864698, 16249.593760155854, 16295.103769292802, 16327.428540001281, 10666.733331666615, 12087.0, 12195.634130975908, 12331.198472099284, 12333.568325108577, 17976.19107140182, 18239.452816415527, 18479.0, 18855.622887542173, 18870.339538116375, 5648.49163575272, 5683.760256653668, 5698.430156984268, 5730.914036289459, 5776.797812076557, 880.124276345028, 914.9222316103205, 917.6925729880564, 918.536139249688, 948.0186410402155, 29217.0, 33309.50035749466, 34961.82519087388, 35135.64864351375, 37099.443508347395, 1046.3774054437597, 1092.257265059751, 1118.8433619293305, 1146.48408216303, 1210.4855436439477, 17282.914005258037, 17451.73822392665, 17463.38878139259, 17546.473605791845, 17553.47339579789, 589714.0, 592752.217433469, 596142.0, 596240.0, 597507.0, 59419.40580594225, 59714.43141254459, 59811.10283345753, 59905.70047149823, 59934.0, 1299.4347458855239, 1394.4073768648284, 1396.3576754692956, 1407.9648008799657, 1438.8129543159323, 32692.34615307633, 33963.830180848934, 34175.487367689006, 34478.65521344855, 34543.4818477718, 51035.0, 51162.488375115776, 51687.48312516977, 51755.482445176574, 51800.222996654324, 409639.0, 414031.0, 414101.0, 415808.0, 416094.0, 45871.541284586725, 46245.76877115593, 46954.29568556406, 47070.52929470661, 48382.27426588674, 47397.0, 48800.0, 52238.73880630572, 53035.73482132565, 53817.192742109684, 42106.7894660537, 42950.35574466323, 43462.56537434585, 43774.34338484862, 44356.778216108716, 41624.58375416207, 42395.57604423916, 42445.57554424416, 45180.548194518946, 45401.31898021466, 43946.78026609847, 44678.0, 44815.0, 44985.550144498135, 45182.774086130674, 38278.61721382862, 38956.971066321654, 39363.0, 39731.80134099311, 40174.79912600418, 29097.272568185967, 29595.412711029825, 29880.85059574688, 30233.395332093674, 30384.0], "value": 20505.25469863511, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1138545953361, 378.5495260639838, 384.2411237805335, 388.60556535116876, 398.9182217645383, 15174.54476365708, 16683.499495015138, 17659.823401765978, 20212.19151233951, 20251.898740506294, 17460.30158793647, 17858.464246072606, 18411.447656570323, 18970.0, 18976.810231897678, 5420.566354691615, 5446.074167391533, 5531.059719847615, 5586.497215250627, 5594.0, 3756.248750249947, 5220.8694782630355, 5230.895382092356, 5503.504684578387, 5522.144067669517, 5467.17992301156, 5542.75057622408, 5565.721713914309, 5570.944290557083, 5603.383627800959, 5426.593005524602, 5498.890022199554, 5582.692951887645, 5616.129499927497, 5629.60592758507, 5367.35591728995, 5396.676199428047, 5399.568034557226, 5399.946000540023, 5405.567554595623, 21184.682229766568, 22151.44621384478, 22221.666674999888, 22225.110995560157, 22470.32589022332, 2189.9671504927437, 2217.7671344508753, 2224.3994121587243, 2378.28846401378, 2692.6364940732947, 8909.777255568597, 9511.096445837635, 9549.713508594754, 9617.807643847154, 9862.45756483393, 1744.2848432142887, 1796.490947604006, 1828.286968082449, 1835.7246413038017, 1871.9719204211947, 52737.47262527402, 60275.69862150661, 62605.060924086174, 76161.61919190425, 81138.9999999994, 10594.15246780271, 10680.145588352912, 10785.514651840685, 10964.835527467094, 10980.505877235544, 15066.472673456376, 15179.772303415457, 15190.164540950133, 15190.164540950354, 15191.62020949463, 7748.457607967388, 7938.682452701827, 7978.202179782092, 8069.193080691884, 8141.796455088552, 7708.460407771514, 7724.3434308083315, 7737.381009519225, 7750.418718596128, 7858.214178582096, 4616.60758835496, 4654.232051711498, 4689.132510485571, 4708.693934894221, 4768.713877167381, 1681.1678219281534, 1770.6547223291334, 1778.5197996540862, 1896.7534220551515, 1909.9781616835205, 1002.9498525073717, 1011.7420057885192, 1025.190099821133, 1026.609888242463, 1032.256775121911, 18274.725879111826, 18915.90542047281, 18972.525686857938, 19024.143913523923, 19273.325433609756, 975.4829940131741, 977.0913050862624, 980.2305190425482, 1010.9949450252849, 1033.813913495563, 8480.660773568989, 9972.950135249423, 10479.738006549896, 10599.311044782064, 10603.787924241626, 515216.0, 516195.0, 518755.0, 524097.0, 524786.0, 55696.72151639216, 88415.55792220998, 89315.0, 89470.0, 89807.55096224477, 864.9308055355682, 874.6413970272158, 880.5465185429509, 883.8541640629225, 887.843715591067, 15253.635686468615, 15297.923510382378, 15765.29056192497, 15790.0, 15842.0, 38918.0, 39207.80396098001, 40217.59782402139, 40551.797241013606, 40570.1885962285, 54220.91558168893, 54568.0, 57027.42972570221, 62848.0, 63111.0, 7141.785746427616, 7403.407727381689, 7453.40372770188, 7857.567833769198, 8355.415120941476, 8807.339449541181, 11318.547258109584, 12211.145219834882, 12254.87745122573, 12374.195677280948, 10664.573417063231, 10676.83984740214, 10806.837897431702, 10862.945685271523, 10890.346579205274, 10318.690439286833, 10689.144868410353, 10741.301815381976, 10799.784004319712, 10881.673549793519, 8684.522351270489, 10179.931107233633, 10412.427316497666, 10714.25000249975, 11105.0, 7365.337119659256, 7418.258174182754, 7429.628518574158, 7458.440616953641, 7534.962325188339, 10301.484925753832, 10359.482025898524, 10409.42748148859, 10501.579936802442, 10509.264351495322], "value": 8685.94526081558, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.6373747219513, 1371.2663724907177, 1423.5658124272097, 1484.7327481053405, 1791.8476929460994, 8555.10171432, 8892.555372231387, 8918.241949434298, 9140.085991400872, 9141.908580914189, 8832.0, 9034.548272586377, 9035.367524273304, 9038.367314288002, 9042.638294468214, 2039.88780617066, 2267.353804165813, 2341.496578235679, 2354.5997180479276, 2374.8931298091543, 2356.0340260493203, 2361.6929799126174, 2363.2437619961534, 2365.2431222008963, 2365.5741966446035, 2283.668868014137, 2306.169778879602, 2334.5914464968564, 2337.731160916491, 2341.063574570177, 2019.1923230707687, 2268.2968279833303, 2345.8827058647084, 2349.0251545608553, 2350.764923507653, 2320.6983092197906, 2322.953540929189, 2340.9180678676166, 2343.8945247463903, 2344.5545346384133, 8859.0, 8911.821763564758, 8953.462792232487, 8970.058143894928, 8973.41672791273, 5038.345015148007, 5184.948150518484, 5186.922196167023, 5191.325127733408, 5195.0, 3104.28601421672, 3191.680831916813, 3244.4484437645656, 3263.608366995952, 3264.657210992835, 1047.61238341814, 1077.5097330714507, 1080.8324709670014, 1081.8052750504905, 1102.608573956242, 12797.872021279854, 12802.16785908913, 12815.935920320431, 12821.294828784414, 12828.358582070952, 4346.869593912188, 4406.757628330409, 4464.15181115587, 4520.299353600197, 4539.795709193094, 10720.142388608892, 10720.46397680113, 10727.088197503299, 10740.624078157227, 10740.838887416696, 5112.667676601009, 5113.233015047698, 5114.053900028507, 5114.053900028507, 5117.488251174853, 4041.6362527372676, 4604.263317869125, 4721.220998535203, 4729.4797572267025, 4778.880527986828, 3991.3613821788376, 4008.7193896427552, 4067.7966101694797, 4103.9179216415505, 4124.4019617155345, 1264.4689230523202, 1274.4265080713717, 1274.7832868412393, 1284.877936596022, 1286.4082522039967, 836.7029704454952, 948.5873644964463, 954.1841725324886, 977.2328721953232, 978.0708327089152, 5675.5459563234845, 5846.678432686158, 5849.590528663038, 5934.554908381889, 6192.752289908443, 417.17815902671686, 433.91538649962956, 434.03210839827364, 434.5068347425695, 439.1392869974885, 3846.480725102131, 3861.8455261789777, 3898.3957486589056, 3898.688104951597, 3936.0356712605594, 10998.34009959405, 11116.555337786398, 11373.0, 11389.772204555862, 11423.657290281139, 11190.552377904956, 11272.0, 11282.661520154408, 11288.492017859217, 11317.377544234982, 8226.629801658939, 8286.212809783061, 8362.749117526484, 8433.156684331518, 8433.325333973391, 5664.688442135557, 5793.739281732248, 5826.883462330645, 5856.648601083949, 5870.295564532113, 10114.241431892491, 10368.637097701545, 10436.739081523023, 10479.318844275098, 10498.370097794157, 10242.436665983145, 10481.161507079263, 10542.103921166787, 10708.625198118028, 10718.839217411589, 6872.209695884837, 7678.424118191047, 7689.50018248812, 7763.0684317882215, 7844.921550784419, 8551.1448855114, 8551.486910785372, 8578.828423431622, 8613.0, 8650.697225597074, 7322.304381083789, 7492.550446973199, 7534.510256833289, 7538.886916696364, 7567.697292108254, 7551.8867216992885, 7677.808054798675, 7694.345980591713, 7795.64919578609, 7942.761717148494, 6963.1644202696, 7053.858922821618, 7093.361597456254, 7098.041764361745, 7099.148102227766, 5102.566281865935, 5220.791168353223, 5232.476752324737, 5355.3305836770405, 5358.571314294769, 4804.95195048045, 4835.032993401263, 4908.141075311878, 5097.158968770112, 5277.868053298698], "value": 4527.024845076103, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.82401794949953, 315.60234105027666, 319.39474695452134, 322.78696060600004, 325.95436638870564, 4931.506849315067, 5177.352830896138, 5331.626786124973, 5394.676319420838, 5396.325459317585, 5297.841064768054, 5317.149256119022, 5318.9202161967505, 5361.892762144755, 5372.274742909716, 4182.351735480997, 4208.263553878074, 4209.768462734548, 4214.536400995888, 4223.556526564713, 3984.5218573771044, 4079.102597428561, 4180.979095104521, 4189.413482112506, 4191.413202151702, 4130.958690413103, 4133.731307465006, 4161.105362347094, 4163.979180104096, 4170.082581831992, 4100.138970816132, 4106.445629839978, 4136.772477513736, 4155.210510003089, 4159.00735294118, 3338.2488939988552, 3677.2829298286847, 3680.9815950920342, 3683.771318352385, 3710.2394009228315, 5086.643934924557, 5123.615728820353, 5148.279240906276, 5152.896942061176, 5158.509941555546, 4672.906541869178, 4675.4155730533685, 4679.812807487697, 4680.204365257914, 4691.812327506896, 5400.486953739389, 5427.887283106954, 5453.972730136324, 5535.509020940553, 5547.389787123413, 3904.3557812960826, 3913.66733827625, 3917.5494818096, 3925.8625948091967, 3931.0761970936805, 5491.643043202179, 5664.716764161775, 5752.223449834302, 5784.623999440023, 5807.0, 3897.707671924617, 3929.9171439137303, 3941.0, 3943.8225279862477, 4021.2761702893176, 4026.0, 4045.4943132108488, 4047.5547689754103, 4047.8785636430953, 4072.6538244248977, 4538.228501154812, 4631.583157515773, 4654.697444666086, 4666.673332866667, 4671.1358398695675, 5469.206964990054, 5483.698396588146, 5527.53015993637, 5564.1931919871395, 5571.442855714477, 1343.2813444807177, 1378.2144177818748, 1378.63466181462, 1381.9447222111003, 1382.6266907935003, 824.8721448175543, 852.1435956863437, 861.4831101339272, 866.5147517390155, 873.0004145253649, 4766.45185803637, 4772.3557319762085, 4802.927956080662, 4829.773947795678, 4851.320815085891, 5011.724355160428, 5037.471065538139, 5069.239614057847, 5069.7465126744255, 5082.567981721595, 4805.447373552016, 4823.3729615150505, 4828.710277383298, 4859.829905953275, 4959.70241785494, 3040.9239769005953, 3065.402246561899, 3069.8004629699444, 3071.508558630608, 3075.9692403075683, 5845.152452894306, 5846.970765146147, 5870.324912635102, 5963.7912673056235, 5978.133170690226, 5591.7483713233005, 5844.26946631671, 5848.590598658138, 5853.795117170878, 5856.912146317809, 5857.853553661193, 5872.882542349129, 5889.5582831286965, 5898.616589921641, 5913.319968203626, 5623.2127502148915, 5654.667091430497, 5714.485696287354, 5757.827265182052, 5765.818007308576, 5629.718514074362, 5646.2942132233475, 5659.490645841894, 5687.77248910039, 5741.0, 5628.718564071698, 5705.258316418839, 5828.154917537018, 5895.492182151613, 5912.349641539513, 3983.3029219885825, 4000.1599664070873, 4000.7999600020466, 4015.277250095011, 4017.91964160721, 5666.376698563073, 5690.231818704422, 5714.342850572238, 5729.885402292014, 5732.197492351158, 5284.867878303073, 5589.021921163861, 5607.102863541813, 5615.3823079462045, 5638.971805140948, 5584.636998595079, 5592.189132575835, 5601.579881508822, 5602.383737788921, 5628.60599758013, 5262.263283140287, 5491.176323551499, 5495.477929596682, 5547.1679248111495, 5592.804251851166, 5589.692566908859, 5628.74670639814, 5641.548676105984, 5666.744996475086, 5699.945510080648, 5457.0627427264335, 5507.586930980113, 5521.944780552143, 5529.474699903502, 5533.889322213614], "value": 4176.29637973431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4885724990635, 626.4988009592327, 658.8451713847245, 678.1760161403896, 722.7181399254289, 11373.829392559119, 11938.283702977827, 13836.792448113274, 14033.087849289788, 14157.646058848533, 13008.0, 13713.520026799064, 13737.519186828464, 13742.931285343584, 13748.931255343708, 672.2907332763932, 791.8218400859789, 798.4291231769283, 799.9880001799978, 801.1027649033091, 797.0554892452434, 798.022422532399, 801.5911884938665, 801.6592947997107, 804.6620419423856, 841.4614646626134, 846.1115828380207, 847.3052097280232, 847.4449235750562, 848.5417874347845, 830.8753686946945, 831.6049876308765, 840.5671079394117, 840.7309660908512, 840.794005468661, 607.2955371768727, 607.6172011632643, 608.4675908579992, 608.7777961044231, 609.3297372889785, 12395.690107747378, 12479.126461147724, 12487.812682809765, 12501.56244531437, 12510.562130325487, 13618.727625447535, 13636.386362613706, 13951.232682202475, 14221.644458888508, 14362.13827170373, 11003.0, 11032.44837758117, 11074.889251107466, 11198.888011119867, 11401.48693308803, 3781.640744129303, 3800.7529510582, 3813.275477659236, 3829.157585331223, 3877.9917221522323, 50300.245496317584, 61045.0, 63928.360716393174, 64457.67771161161, 70898.0, 10417.843732344021, 10540.420276884844, 10569.471526423647, 10690.585648610771, 10727.034566889017, 19284.8071519283, 19586.31447899317, 19824.90087549553, 19861.205551778057, 19863.702044469344, 7860.0, 7914.841703166019, 7924.20757924203, 7992.600369981477, 8121.228483294078, 4279.614834664895, 4453.198424283595, 4486.865394038184, 4510.594046535762, 4619.491855895849, 3258.3971965186515, 3316.1378041708845, 3366.5286859839644, 3406.131436483681, 3407.795532268072, 646.7930262316107, 647.9125318082093, 659.986800263992, 661.8940969444866, 663.4360793325731, 494.9331840201599, 657.4477438951304, 672.7981605518324, 688.8760023195773, 689.1454596300651, 9044.317455242908, 9397.671081512115, 9489.715308540755, 9496.43021418717, 9518.47648379332, 603.5533705058225, 638.9712462939179, 696.084648686975, 708.4190963409955, 717.3185473799911, 4101.85643502476, 4196.853110141131, 4345.261305578059, 4394.604485596312, 4399.824007039747, 76965.61517192378, 119116.0, 125431.0, 128395.0, 129208.3539582296, 87760.0, 109646.32475726782, 110797.44601276942, 111269.0, 111552.44223778829, 59298.0, 75651.43485651391, 76220.61889690516, 81189.59405203054, 87128.12871871327, 8767.780805479913, 9090.454572725657, 9101.226395756436, 9108.544572771467, 9116.453012819253, 52034.479655202966, 52767.20849187188, 52975.73512132415, 53151.468485314654, 55694.152114029064, 50258.0, 66181.37458316097, 72694.27305726874, 74315.0, 77745.0, 11702.180847340946, 12014.579489717818, 12250.448729807358, 12332.938335308267, 12739.808902866649, 13322.866771332163, 13427.19436833793, 13549.390277437737, 13569.86430135686, 13916.860831391556, 11777.411129443322, 11801.173917826014, 11808.232464889754, 11954.282743035097, 12100.45547950362, 12601.306928119042, 12697.238165710087, 12716.173448725804, 12722.427490763122, 13434.328283585977, 11688.123390745897, 11698.590549331073, 11783.293002419883, 12980.740385192432, 12981.935090324489, 10054.89945100569, 10142.391456512632, 10163.644272450725, 10284.177265818866, 10449.111825494918, 10152.847707284544, 10297.279190456597, 10345.327553708985, 10358.326708763907, 10399.688009359732], "value": 7083.852033886905, "unit": "score"}], "name": "dromaeo_css", "value": 7092.823843469044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 127.0, 177.0, 126.0, 128.0, 158.0, 124.0, 153.0, 124.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 123.0, 76.0, 75.0, 73.0, 73.0, 97.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 86.0, 116.0, 84.0, 86.0, 120.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 144.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 54.0, 52.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 79.0, 79.0, 79.0, 81.0, 82.0, 86.0, 105.0, 80.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 143.0, 119.0, 131.0, 121.0, 120.0, 121.0, 128.0, 127.0], "value": 125.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 158.0, 159.0, 159.0, 156.0, 156.0, 158.0, 158.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 61.0, 71.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1488.8000000000002, "alertThreshold": 2.0}]} 00:54:30 INFO - Return code: 0 00:54:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:54:30 ERROR - # TBPL SUCCESS # 00:54:30 INFO - Running post-action listener: _resource_record_post_action 00:54:30 INFO - ##### 00:54:30 INFO - ##### Finished run-tests step (success) 00:54:30 INFO - ##### 00:54:30 INFO - Running post-run listener: _resource_record_post_run 00:54:30 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540549120; Read time: 20; Write time: 537456 00:54:30 INFO - TinderboxPrint: CPU usage
13.1% 00:54:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 00:54:30 INFO - TinderboxPrint: I/O write bytes / time
540,549,120 / 537,456 00:54:30 INFO - TinderboxPrint: CPU idle
8,271.0 (86.9%) 00:54:30 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 00:54:30 INFO - TinderboxPrint: Swap in / out
0 / 0 00:54:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248029184; Read time: 0; Write time: 279988 00:54:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292519936; Read time: 20; Write time: 257468 00:54:31 INFO - Running post-run listener: _upload_blobber_files 00:54:31 INFO - Blob upload gear active. 00:54:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:54:31 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 00:54:31 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'] 00:54:31 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 00:54:31 INFO - (blobuploader) - INFO - Open directory for files ... 00:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:32 INFO - (blobuploader) - INFO - Done attempting. 00:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:36 INFO - (blobuploader) - INFO - Done attempting. 00:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:54:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:54:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:54:37 INFO - (blobuploader) - INFO - Done attempting. 00:54:37 INFO - (blobuploader) - INFO - Iteration through files over. 00:54:37 INFO - Return code: 0 00:54:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:54:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:54:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5490a57b79dae8fee23372bba24653c6c486248670717522cc69d01dd78c6c26421a2d9d43bbbc5baf5863fc3951c0d59e5d54266e420f002fe4adbdfd731d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136397af443c67686e59372910043f77d9fb44d068e78c07796bda3e8b62554eddd427d8565fb30a069210ddeb267fe37cff01f1d783ddfb30e30c8c89c85aaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7efb7a73f5a15cd8f6d03ea5ca43987c10130052d5d852aeb3e3524754241a3b21dd042682e4fa8d7c305ceeafd2cfcbdcf4f970b9eae5ced5832f915163f5fa"} 00:54:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:54:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:54:37 INFO - Contents: 00:54:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5490a57b79dae8fee23372bba24653c6c486248670717522cc69d01dd78c6c26421a2d9d43bbbc5baf5863fc3951c0d59e5d54266e420f002fe4adbdfd731d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136397af443c67686e59372910043f77d9fb44d068e78c07796bda3e8b62554eddd427d8565fb30a069210ddeb267fe37cff01f1d783ddfb30e30c8c89c85aaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7efb7a73f5a15cd8f6d03ea5ca43987c10130052d5d852aeb3e3524754241a3b21dd042682e4fa8d7c305ceeafd2cfcbdcf4f970b9eae5ced5832f915163f5fa"} 00:54:37 INFO - Running post-run listener: copy_logs_to_upload_dir 00:54:37 INFO - Copying logs to upload dir... 00:54:37 INFO - mkdir: /builds/slave/test/build/upload/logs 00:54:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.725158 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-06 00:54:37.034847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 00:54:37.038015) ========= 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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 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/5490a57b79dae8fee23372bba24653c6c486248670717522cc69d01dd78c6c26421a2d9d43bbbc5baf5863fc3951c0d59e5d54266e420f002fe4adbdfd731d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136397af443c67686e59372910043f77d9fb44d068e78c07796bda3e8b62554eddd427d8565fb30a069210ddeb267fe37cff01f1d783ddfb30e30c8c89c85aaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7efb7a73f5a15cd8f6d03ea5ca43987c10130052d5d852aeb3e3524754241a3b21dd042682e4fa8d7c305ceeafd2cfcbdcf4f970b9eae5ced5832f915163f5fa"} build_url:https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/anR9XvBWSsmcq0BqQ9zwJA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5490a57b79dae8fee23372bba24653c6c486248670717522cc69d01dd78c6c26421a2d9d43bbbc5baf5863fc3951c0d59e5d54266e420f002fe4adbdfd731d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/136397af443c67686e59372910043f77d9fb44d068e78c07796bda3e8b62554eddd427d8565fb30a069210ddeb267fe37cff01f1d783ddfb30e30c8c89c85aaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7efb7a73f5a15cd8f6d03ea5ca43987c10130052d5d852aeb3e3524754241a3b21dd042682e4fa8d7c305ceeafd2cfcbdcf4f970b9eae5ced5832f915163f5fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 00:54:37.063410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:54:37.063745) ========= 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=eca2ab57546de7b41f256b19000001ef-1465198440.999385-1847458552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 00:54:37.148364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 00:54:37.148718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 00:54:37.149011) ========= ========= Total master_lag: 0.17 =========