builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1469693757.91 results: success (0) buildid: 20160727200726 builduid: d570ceba77074d21ae8ff3558fb24d88 revision: 3a88dc3ec8eab71975935fcc11c798d3576f9106 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:57.914698) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:57.915374) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:57.915723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:57.932173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:57.932512) ========= 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=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 01:15:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.3M=0s 2016-07-28 01:15:58 (70.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.067970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:58.016543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:58.017024) ========= 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=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019378 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:58.071441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 01:15:58.071830) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a88dc3ec8eab71975935fcc11c798d3576f9106 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a88dc3ec8eab71975935fcc11c798d3576f9106 --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=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 01:15:58,771 truncating revision to first 12 chars 2016-07-28 01:15:58,771 Setting DEBUG logging. 2016-07-28 01:15:58,771 attempt 1/10 2016-07-28 01:15:58,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a88dc3ec8ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 01:15:59,561 unpacking tar archive at: mozilla-aurora-3a88dc3ec8ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.139969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 01:15:59.226141) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:59.226563) ========= script_repo_revision: 3a88dc3ec8eab71975935fcc11c798d3576f9106 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:59.227096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:59.227488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 01:15:59.237711) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-28 01:15:59.238055) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:16:00 INFO - MultiFileLogger online at 20160728 01:16:00 in /builds/slave/test 01:16:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:16:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:16:00 INFO - {'append_to_log': False, 01:16:00 INFO - 'base_work_dir': '/builds/slave/test', 01:16:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:16:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:16:00 INFO - 'branch': 'Mozilla-Aurora', 01:16:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:16:00 INFO - 'config_files': ('talos/linux_config.py',), 01:16:00 INFO - 'default_actions': ('clobber', 01:16:00 INFO - 'read-buildbot-config', 01:16:00 INFO - 'download-and-extract', 01:16:00 INFO - 'populate-webroot', 01:16:00 INFO - 'create-virtualenv', 01:16:00 INFO - 'install', 01:16:00 INFO - 'run-tests'), 01:16:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:16:00 INFO - 'download_minidump_stackwalk': True, 01:16:00 INFO - 'download_symbols': 'ondemand', 01:16:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:16:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:16:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:16:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:16:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:16:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:16:00 INFO - 'installer_path': 'installer.exe', 01:16:00 INFO - 'log_level': 'info', 01:16:00 INFO - 'log_name': 'talos', 01:16:00 INFO - 'log_to_console': True, 01:16:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:16:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:16:00 INFO - 'opt_config_files': (), 01:16:00 INFO - 'pip_index': False, 01:16:00 INFO - 'sps_profile': False, 01:16:00 INFO - 'sps_profile_interval': 0, 01:16:00 INFO - 'suite': 'dromaeojs', 01:16:00 INFO - 'system_bits': '32', 01:16:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:16:00 INFO - 'title': 'talos-linux64-ix-025', 01:16:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:16:00 INFO - 'use_talos_json': True, 01:16:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:16:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:16:00 INFO - 'work_dir': 'build'} 01:16:00 INFO - ##### 01:16:00 INFO - ##### Running clobber step. 01:16:00 INFO - ##### 01:16:00 INFO - Running pre-action listener: _resource_record_pre_action 01:16:00 INFO - Running main action method: clobber 01:16:00 INFO - rmtree: /builds/slave/test/build 01:16:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:16:00 INFO - Running post-action listener: _resource_record_post_action 01:16:00 INFO - ##### 01:16:00 INFO - ##### Finished clobber step (success) 01:16:00 INFO - ##### 01:16:00 INFO - ##### 01:16:00 INFO - ##### Running read-buildbot-config step. 01:16:00 INFO - ##### 01:16:00 INFO - Running pre-action listener: _resource_record_pre_action 01:16:00 INFO - Running main action method: read_buildbot_config 01:16:00 INFO - Using buildbot properties: 01:16:00 INFO - { 01:16:00 INFO - "project": "", 01:16:00 INFO - "product": "firefox", 01:16:00 INFO - "script_repo_revision": "production", 01:16:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:16:00 INFO - "repository": "", 01:16:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:16:00 INFO - "buildid": "20160727200726", 01:16:00 INFO - "pgo_build": "True", 01:16:00 INFO - "basedir": "/builds/slave/test", 01:16:00 INFO - "buildnumber": 640, 01:16:00 INFO - "slavename": "talos-linux64-ix-025", 01:16:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:16:00 INFO - "platform": "ubuntu64_hw", 01:16:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:16:00 INFO - "branch": "mozilla-aurora", 01:16:00 INFO - "repo_path": "releases/mozilla-aurora", 01:16:00 INFO - "revision": "3a88dc3ec8eab71975935fcc11c798d3576f9106", 01:16:00 INFO - "stage_platform": "linux64-pgo", 01:16:00 INFO - "builduid": "d570ceba77074d21ae8ff3558fb24d88", 01:16:00 INFO - "slavebuilddir": "test" 01:16:00 INFO - } 01:16:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:16:00 INFO - Running post-action listener: _resource_record_post_action 01:16:00 INFO - ##### 01:16:00 INFO - ##### Finished read-buildbot-config step (success) 01:16:00 INFO - ##### 01:16:00 INFO - ##### 01:16:00 INFO - ##### Running download-and-extract step. 01:16:00 INFO - ##### 01:16:00 INFO - Running pre-action listener: _resource_record_pre_action 01:16:00 INFO - Running main action method: download_and_extract 01:16:00 INFO - mkdir: /builds/slave/test/build/tests 01:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:00 INFO - https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:16:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:16:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:16:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:16:08 INFO - Downloaded 1361 bytes. 01:16:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:16:08 INFO - Using the following test package requirements: 01:16:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:16:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:16:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:16:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'jsshell-linux-x86_64.zip'], 01:16:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:16:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:16:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:16:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:16:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:16:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:16:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:16:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:08 INFO - https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:16:11 INFO - Downloaded 24494270 bytes. 01:16:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:16:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:16:12 INFO - Return code: 0 01:16:12 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:12 INFO - https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:16:15 INFO - Downloaded 24494270 bytes. 01:16:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:16:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:16:16 INFO - Return code: 0 01:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:16 INFO - https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:16:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:16:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:16:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:16:17 INFO - Downloaded 10833369 bytes. 01:16:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:16:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:16:17 INFO - Return code: 0 01:16:17 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')]} 01:16:17 INFO - https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:16:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:16:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:16:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:16:19 INFO - Downloaded 63642071 bytes. 01:16:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:16:19 INFO - mkdir: /builds/slave/test/properties 01:16:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:16:19 INFO - Writing to file /builds/slave/test/properties/build_url 01:16:19 INFO - Contents: 01:16:19 INFO - build_url:https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:16:20 INFO - Running post-action listener: _resource_record_post_action 01:16:20 INFO - Running post-action listener: set_extra_try_arguments 01:16:20 INFO - ##### 01:16:20 INFO - ##### Finished download-and-extract step (success) 01:16:20 INFO - ##### 01:16:20 INFO - ##### 01:16:20 INFO - ##### Running populate-webroot step. 01:16:20 INFO - ##### 01:16:20 INFO - Running pre-action listener: _resource_record_pre_action 01:16:20 INFO - Running main action method: populate_webroot 01:16:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:16:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:16:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:16:20 INFO - '--tppagecycles', 01:16:20 INFO - '7'], 01:16:20 INFO - 'tests': ['tsvgm']}}, 01:16:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:16:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:16:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:16:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:16:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['damp', 'tps']}, 01:16:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'tests': ['damp', 'tps']}, 01:16:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['dromaeo_dom']}, 01:16:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:16:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'other-e10s': {'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['a11yr', 01:16:20 INFO - 'ts_paint', 01:16:20 INFO - 'tpaint', 01:16:20 INFO - 'sessionrestore', 01:16:20 INFO - 'sessionrestore_no_auto_restore', 01:16:20 INFO - 'tabpaint']}, 01:16:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['tsvgx', 01:16:20 INFO - 'tsvgr_opacity', 01:16:20 INFO - 'tart', 01:16:20 INFO - 'tscrollx', 01:16:20 INFO - 'cart']}, 01:16:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:16:20 INFO - 'tsvgr_opacity', 01:16:20 INFO - 'tart', 01:16:20 INFO - 'tscrollx', 01:16:20 INFO - 'cart']}, 01:16:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'talos_options': ['--disable-e10s'], 01:16:20 INFO - 'tests': ['tp5o']}, 01:16:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'tests': ['tp5o']}, 01:16:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'talos_options': ['--disable-e10s', 01:16:20 INFO - '--xperf_path', 01:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:20 INFO - 'tests': ['tp5n']}, 01:16:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:20 INFO - 'talos_options': ['--xperf_path', 01:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:20 INFO - 'tests': ['tp5n']}}, 01:16:20 INFO - 'talos.zip': {'path': '', 01:16:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:16:20 INFO - Running post-action listener: _resource_record_post_action 01:16:20 INFO - ##### 01:16:20 INFO - ##### Finished populate-webroot step (success) 01:16:20 INFO - ##### 01:16:20 INFO - ##### 01:16:20 INFO - ##### Running create-virtualenv step. 01:16:20 INFO - ##### 01:16:20 INFO - Running pre-action listener: _resource_record_pre_action 01:16:20 INFO - Running main action method: create_virtualenv 01:16:20 INFO - Creating virtualenv /builds/slave/test/build/venv 01:16:20 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 01:16:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:16:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:16:20 INFO - Using real prefix '/usr' 01:16:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:16:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:16:22 INFO - Installing pip.................done. 01:16:22 INFO - Return code: 0 01:16:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:16:22 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')]} 01:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:22 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')]} 01:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:22 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:22 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 01:16:22 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 01:16:22 INFO - Using env: {'DISPLAY': ':0', 01:16:22 INFO - 'HOME': '/home/cltbld', 01:16:22 INFO - 'LANG': 'en_US.UTF-8', 01:16:22 INFO - 'LANGUAGE': 'en_US:en', 01:16:22 INFO - 'LOGNAME': 'cltbld', 01:16:22 INFO - 'MAIL': '/var/mail/cltbld', 01:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:22 INFO - 'MOZ_NO_REMOTE': '1', 01:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:22 INFO - 'NO_EM_RESTART': '1', 01:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:22 INFO - 'PWD': '/builds/slave/test', 01:16:22 INFO - 'SHELL': '/bin/bash', 01:16:22 INFO - 'SHLVL': '1', 01:16:22 INFO - 'TERM': 'linux', 01:16:22 INFO - 'TMOUT': '86400', 01:16:22 INFO - 'USER': 'cltbld', 01:16:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:22 INFO - '_': '/tools/buildbot/bin/python'} 01:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:23 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 01:16:23 INFO - Cleaning up... 01:16:23 INFO - Return code: 0 01:16:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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', '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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:16: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 psutil>=3.1.1 01:16:23 INFO - Using env: {'DISPLAY': ':0', 01:16:23 INFO - 'HOME': '/home/cltbld', 01:16:23 INFO - 'LANG': 'en_US.UTF-8', 01:16:23 INFO - 'LANGUAGE': 'en_US:en', 01:16:23 INFO - 'LOGNAME': 'cltbld', 01:16:23 INFO - 'MAIL': '/var/mail/cltbld', 01:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:23 INFO - 'MOZ_NO_REMOTE': '1', 01:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:23 INFO - 'NO_EM_RESTART': '1', 01:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:23 INFO - 'PWD': '/builds/slave/test', 01:16:23 INFO - 'SHELL': '/bin/bash', 01:16:23 INFO - 'SHLVL': '1', 01:16:23 INFO - 'TERM': 'linux', 01:16:23 INFO - 'TMOUT': '86400', 01:16:23 INFO - 'USER': 'cltbld', 01:16:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:23 INFO - '_': '/tools/buildbot/bin/python'} 01:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:23 INFO - Downloading/unpacking psutil>=3.1.1 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:25 INFO - Installing collected packages: psutil 01:16:25 INFO - Running setup.py install for psutil 01:16:25 INFO - building 'psutil._psutil_linux' extension 01:16:25 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 01:16:25 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 01:16:25 INFO - building 'psutil._psutil_posix' extension 01:16:25 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 01:16:25 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 01:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:25 INFO - Successfully installed psutil 01:16:25 INFO - Cleaning up... 01:16:25 INFO - Return code: 0 01:16:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:25 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:25 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 01:16:25 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 01:16:25 INFO - Using env: {'DISPLAY': ':0', 01:16:25 INFO - 'HOME': '/home/cltbld', 01:16:25 INFO - 'LANG': 'en_US.UTF-8', 01:16:25 INFO - 'LANGUAGE': 'en_US:en', 01:16:25 INFO - 'LOGNAME': 'cltbld', 01:16:25 INFO - 'MAIL': '/var/mail/cltbld', 01:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:25 INFO - 'MOZ_NO_REMOTE': '1', 01:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:25 INFO - 'NO_EM_RESTART': '1', 01:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:25 INFO - 'PWD': '/builds/slave/test', 01:16:25 INFO - 'SHELL': '/bin/bash', 01:16:25 INFO - 'SHLVL': '1', 01:16:25 INFO - 'TERM': 'linux', 01:16:25 INFO - 'TMOUT': '86400', 01:16:25 INFO - 'USER': 'cltbld', 01:16:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:25 INFO - '_': '/tools/buildbot/bin/python'} 01:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:16:28 INFO - Installing collected packages: mozsystemmonitor 01:16:28 INFO - Running setup.py install for mozsystemmonitor 01:16:28 INFO - Successfully installed mozsystemmonitor 01:16:28 INFO - Cleaning up... 01:16:28 INFO - Return code: 0 01:16:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:16:28 INFO - Using env: {'DISPLAY': ':0', 01:16:28 INFO - 'HOME': '/home/cltbld', 01:16:28 INFO - 'LANG': 'en_US.UTF-8', 01:16:28 INFO - 'LANGUAGE': 'en_US:en', 01:16:28 INFO - 'LOGNAME': 'cltbld', 01:16:28 INFO - 'MAIL': '/var/mail/cltbld', 01:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:28 INFO - 'MOZ_NO_REMOTE': '1', 01:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:28 INFO - 'NO_EM_RESTART': '1', 01:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:28 INFO - 'PWD': '/builds/slave/test', 01:16:28 INFO - 'SHELL': '/bin/bash', 01:16:28 INFO - 'SHLVL': '1', 01:16:28 INFO - 'TERM': 'linux', 01:16:28 INFO - 'TMOUT': '86400', 01:16:28 INFO - 'USER': 'cltbld', 01:16:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:28 INFO - '_': '/tools/buildbot/bin/python'} 01:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:28 INFO - Downloading/unpacking jsonschema==2.5.1 01:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:16:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:16:30 INFO - warning: no files found matching '*.txt' 01:16:30 INFO - no previously-included directories found matching 'build' 01:16:30 INFO - no previously-included directories found matching 'dist' 01:16:30 INFO - no previously-included directories found matching '.git*' 01:16:30 INFO - Installing collected packages: jsonschema, functools32 01:16:30 INFO - Running setup.py install for functools32 01:16:30 INFO - warning: no files found matching '*.txt' 01:16:30 INFO - no previously-included directories found matching 'build' 01:16:30 INFO - no previously-included directories found matching 'dist' 01:16:30 INFO - no previously-included directories found matching '.git*' 01:16:30 INFO - Successfully installed jsonschema functools32 01:16:30 INFO - Cleaning up... 01:16:30 INFO - Return code: 0 01:16:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:30 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:30 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 01:16:30 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 01:16:30 INFO - Using env: {'DISPLAY': ':0', 01:16:30 INFO - 'HOME': '/home/cltbld', 01:16:30 INFO - 'LANG': 'en_US.UTF-8', 01:16:30 INFO - 'LANGUAGE': 'en_US:en', 01:16:30 INFO - 'LOGNAME': 'cltbld', 01:16:30 INFO - 'MAIL': '/var/mail/cltbld', 01:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:30 INFO - 'MOZ_NO_REMOTE': '1', 01:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:30 INFO - 'NO_EM_RESTART': '1', 01:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:30 INFO - 'PWD': '/builds/slave/test', 01:16:30 INFO - 'SHELL': '/bin/bash', 01:16:30 INFO - 'SHLVL': '1', 01:16:30 INFO - 'TERM': 'linux', 01:16:30 INFO - 'TMOUT': '86400', 01:16:30 INFO - 'USER': 'cltbld', 01:16:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:30 INFO - '_': '/tools/buildbot/bin/python'} 01:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:31 INFO - Downloading/unpacking blobuploader==1.2.4 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:16: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 01:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:16:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:16:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 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 01:16:33 INFO - Downloading docopt-0.6.1.tar.gz 01:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:16:33 INFO - Running setup.py install for blobuploader 01:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:16:33 INFO - Running setup.py install for requests 01:16:34 INFO - Running setup.py install for docopt 01:16:34 INFO - Successfully installed blobuploader requests docopt 01:16:34 INFO - Cleaning up... 01:16:34 INFO - Return code: 0 01:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16: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')]} 01:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16: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')]} 01:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:34 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:34 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 01:16:34 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 01:16:34 INFO - Using env: {'DISPLAY': ':0', 01:16:34 INFO - 'HOME': '/home/cltbld', 01:16:34 INFO - 'LANG': 'en_US.UTF-8', 01:16:34 INFO - 'LANGUAGE': 'en_US:en', 01:16:34 INFO - 'LOGNAME': 'cltbld', 01:16:34 INFO - 'MAIL': '/var/mail/cltbld', 01:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:34 INFO - 'MOZ_NO_REMOTE': '1', 01:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:34 INFO - 'NO_EM_RESTART': '1', 01:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:34 INFO - 'PWD': '/builds/slave/test', 01:16:34 INFO - 'SHELL': '/bin/bash', 01:16:34 INFO - 'SHLVL': '1', 01:16:34 INFO - 'TERM': 'linux', 01:16:34 INFO - 'TMOUT': '86400', 01:16:34 INFO - 'USER': 'cltbld', 01:16:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:34 INFO - '_': '/tools/buildbot/bin/python'} 01:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:16:34 INFO - Running setup.py (path:/tmp/pip-jtII6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:16:34 INFO - Running setup.py (path:/tmp/pip-vdUoAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:16:34 INFO - Running setup.py (path:/tmp/pip-3I21bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:16:34 INFO - Running setup.py (path:/tmp/pip-TYt5c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:16:34 INFO - Running setup.py (path:/tmp/pip-UAlYKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:16:34 INFO - Running setup.py (path:/tmp/pip-jIF5hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:16:35 INFO - Running setup.py (path:/tmp/pip-Hl1ez6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:16:35 INFO - Running setup.py (path:/tmp/pip-2Cf6vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:16:35 INFO - Running setup.py (path:/tmp/pip-SYhLL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:16:35 INFO - Running setup.py (path:/tmp/pip-f0yzAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:16:35 INFO - Running setup.py (path:/tmp/pip-bYJ3RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:16:35 INFO - Running setup.py (path:/tmp/pip-EmVZdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:16:35 INFO - Running setup.py (path:/tmp/pip-HrDz3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:16:35 INFO - Running setup.py (path:/tmp/pip-TZV7Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:35 INFO - Running setup.py (path:/tmp/pip-LVZo1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:16:35 INFO - Running setup.py (path:/tmp/pip-oM3keu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:16:35 INFO - Running setup.py (path:/tmp/pip-x2T82f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:16:35 INFO - Running setup.py install for manifestparser 01:16:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:16:35 INFO - Running setup.py install for mozcrash 01:16:36 INFO - Running setup.py install for mozdebug 01:16:36 INFO - Running setup.py install for mozdevice 01:16:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for mozfile 01:16:36 INFO - Running setup.py install for mozhttpd 01:16:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for mozinfo 01:16:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for mozInstall 01:16:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for mozleak 01:16:36 INFO - Running setup.py install for mozlog 01:16:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for moznetwork 01:16:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:16:36 INFO - Running setup.py install for mozprocess 01:16:37 INFO - Running setup.py install for mozprofile 01:16:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:16:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:16:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:16:37 INFO - Running setup.py install for mozrunner 01:16:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:16:37 INFO - Running setup.py install for mozscreenshot 01:16:37 INFO - Running setup.py install for moztest 01:16:37 INFO - Running setup.py install for mozversion 01:16:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:16:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:16:37 INFO - Cleaning up... 01:16:37 INFO - Return code: 0 01:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:37 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:37 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 01:16:37 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 01:16:37 INFO - Using env: {'DISPLAY': ':0', 01:16:37 INFO - 'HOME': '/home/cltbld', 01:16:37 INFO - 'LANG': 'en_US.UTF-8', 01:16:37 INFO - 'LANGUAGE': 'en_US:en', 01:16:37 INFO - 'LOGNAME': 'cltbld', 01:16:37 INFO - 'MAIL': '/var/mail/cltbld', 01:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:37 INFO - 'MOZ_NO_REMOTE': '1', 01:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:37 INFO - 'NO_EM_RESTART': '1', 01:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:37 INFO - 'PWD': '/builds/slave/test', 01:16:37 INFO - 'SHELL': '/bin/bash', 01:16:37 INFO - 'SHLVL': '1', 01:16:37 INFO - 'TERM': 'linux', 01:16:37 INFO - 'TMOUT': '86400', 01:16:37 INFO - 'USER': 'cltbld', 01:16:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:37 INFO - '_': '/tools/buildbot/bin/python'} 01:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:16:37 INFO - Running setup.py (path:/tmp/pip-VgV6u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:16:37 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)) 01:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:16:37 INFO - Running setup.py (path:/tmp/pip-vRVrqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:16:37 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)) 01:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:16:37 INFO - Running setup.py (path:/tmp/pip-KgjHEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:16:38 INFO - Running setup.py (path:/tmp/pip-Bm5lGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:16:38 INFO - Running setup.py (path:/tmp/pip-hljM9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:16:38 INFO - Running setup.py (path:/tmp/pip-HgoElm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:16:38 INFO - Running setup.py (path:/tmp/pip-KPZxMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:16:38 INFO - Running setup.py (path:/tmp/pip-2dGCIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:16:38 INFO - Running setup.py (path:/tmp/pip-_HJ8LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:16:38 INFO - Running setup.py (path:/tmp/pip-NkZZd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:16:38 INFO - Running setup.py (path:/tmp/pip-1jltCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:16:38 INFO - Running setup.py (path:/tmp/pip-0nFobl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:16:38 INFO - Running setup.py (path:/tmp/pip-DrbGvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:16:38 INFO - Running setup.py (path:/tmp/pip-v7yqMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:38 INFO - Running setup.py (path:/tmp/pip-1ERE07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:16:38 INFO - Running setup.py (path:/tmp/pip-nqXJB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:16:38 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)) 01:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:16:38 INFO - Running setup.py (path:/tmp/pip-YnuvCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:16:39 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)) 01:16:39 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)) 01:16:39 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)) 01:16:39 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)) 01:16:39 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)) 01:16:39 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)) 01:16:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:40 INFO - Downloading blessings-1.6.tar.gz 01:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:16:41 INFO - Installing collected packages: blessings 01:16:41 INFO - Running setup.py install for blessings 01:16:41 INFO - Successfully installed blessings 01:16:41 INFO - Cleaning up... 01:16:41 INFO - Return code: 0 01:16:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:16:41 INFO - Reading from file tmpfile_stdout 01:16:41 INFO - Current package versions: 01:16:41 INFO - argparse == 1.2.1 01:16:41 INFO - blessings == 1.6 01:16:41 INFO - blobuploader == 1.2.4 01:16:41 INFO - docopt == 0.6.1 01:16:41 INFO - functools32 == 3.2.3-2 01:16:41 INFO - jsonschema == 2.5.1 01:16:41 INFO - manifestparser == 1.1 01:16:41 INFO - mozInstall == 1.12 01:16:41 INFO - mozcrash == 0.17 01:16:41 INFO - mozdebug == 0.1 01:16:41 INFO - mozdevice == 0.48 01:16:41 INFO - mozfile == 1.2 01:16:41 INFO - mozhttpd == 0.7 01:16:41 INFO - mozinfo == 0.9 01:16:41 INFO - mozleak == 0.1 01:16:41 INFO - mozlog == 3.2 01:16:41 INFO - moznetwork == 0.27 01:16:41 INFO - mozprocess == 0.23 01:16:41 INFO - mozprofile == 0.28 01:16:41 INFO - mozrunner == 6.12 01:16:41 INFO - mozscreenshot == 0.1 01:16:41 INFO - mozsystemmonitor == 0.3 01:16:41 INFO - moztest == 0.7 01:16:41 INFO - mozversion == 1.4 01:16:41 INFO - psutil == 3.1.1 01:16:41 INFO - requests == 1.2.3 01:16:41 INFO - wsgiref == 0.1.2 01:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:41 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 01:16:41 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 01:16:41 INFO - Using env: {'DISPLAY': ':0', 01:16:41 INFO - 'HOME': '/home/cltbld', 01:16:41 INFO - 'LANG': 'en_US.UTF-8', 01:16:41 INFO - 'LANGUAGE': 'en_US:en', 01:16:41 INFO - 'LOGNAME': 'cltbld', 01:16:41 INFO - 'MAIL': '/var/mail/cltbld', 01:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:41 INFO - 'MOZ_NO_REMOTE': '1', 01:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:41 INFO - 'NO_EM_RESTART': '1', 01:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:41 INFO - 'PWD': '/builds/slave/test', 01:16:41 INFO - 'SHELL': '/bin/bash', 01:16:41 INFO - 'SHLVL': '1', 01:16:41 INFO - 'TERM': 'linux', 01:16:41 INFO - 'TMOUT': '86400', 01:16:41 INFO - 'USER': 'cltbld', 01:16:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:41 INFO - '_': '/tools/buildbot/bin/python'} 01:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 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)) 01:16:41 INFO - Cleaning up... 01:16:41 INFO - Return code: 0 01:16:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:41 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 01:16:41 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 01:16:41 INFO - Using env: {'DISPLAY': ':0', 01:16:41 INFO - 'HOME': '/home/cltbld', 01:16:41 INFO - 'LANG': 'en_US.UTF-8', 01:16:41 INFO - 'LANGUAGE': 'en_US:en', 01:16:41 INFO - 'LOGNAME': 'cltbld', 01:16:41 INFO - 'MAIL': '/var/mail/cltbld', 01:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:41 INFO - 'MOZ_NO_REMOTE': '1', 01:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:41 INFO - 'NO_EM_RESTART': '1', 01:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:41 INFO - 'PWD': '/builds/slave/test', 01:16:41 INFO - 'SHELL': '/bin/bash', 01:16:41 INFO - 'SHLVL': '1', 01:16:41 INFO - 'TERM': 'linux', 01:16:41 INFO - 'TMOUT': '86400', 01:16:41 INFO - 'USER': 'cltbld', 01:16:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:41 INFO - '_': '/tools/buildbot/bin/python'} 01:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:16:41 INFO - Cleaning up... 01:16:41 INFO - Return code: 0 01:16:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:41 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 0x7fe37d162f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1451350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, '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': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', '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 01:16:41 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 01:16:41 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 01:16:41 INFO - Using env: {'DISPLAY': ':0', 01:16:41 INFO - 'HOME': '/home/cltbld', 01:16:41 INFO - 'LANG': 'en_US.UTF-8', 01:16:41 INFO - 'LANGUAGE': 'en_US:en', 01:16:41 INFO - 'LOGNAME': 'cltbld', 01:16:41 INFO - 'MAIL': '/var/mail/cltbld', 01:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:41 INFO - 'MOZ_NO_REMOTE': '1', 01:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:41 INFO - 'NO_EM_RESTART': '1', 01:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:41 INFO - 'PWD': '/builds/slave/test', 01:16:41 INFO - 'SHELL': '/bin/bash', 01:16:41 INFO - 'SHLVL': '1', 01:16:41 INFO - 'TERM': 'linux', 01:16:41 INFO - 'TMOUT': '86400', 01:16:41 INFO - 'USER': 'cltbld', 01:16:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:41 INFO - '_': '/tools/buildbot/bin/python'} 01:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:42 INFO - Downloading/unpacking flake8 01:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:16:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:16:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:16:43 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 01:16:43 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 01:16:43 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 01:16:43 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 01:16:43 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 01:16:43 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 01:16:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:16:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 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 01:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:16:44 INFO - no previously-included directories found matching 'docs/_build' 01:16:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:16:44 INFO - Running setup.py install for pep8 01:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:16:44 INFO - no previously-included directories found matching 'docs/_build' 01:16:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:16:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:16:44 INFO - Cleaning up... 01:16:44 INFO - Return code: 0 01:16:44 INFO - Running post-action listener: _resource_record_post_action 01:16:44 INFO - Running post-action listener: _start_resource_monitoring 01:16:44 INFO - Starting resource monitoring. 01:16:44 INFO - ##### 01:16:45 INFO - ##### Finished create-virtualenv step (success) 01:16:45 INFO - ##### 01:16:45 INFO - ##### 01:16:45 INFO - ##### Running install step. 01:16:45 INFO - ##### 01:16:45 INFO - Running pre-action listener: _resource_record_pre_action 01:16:45 INFO - Running main action method: install 01:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:16:45 INFO - Reading from file tmpfile_stdout 01:16:45 INFO - Detecting whether we're running mozinstall >=1.0... 01:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:16:45 INFO - Reading from file tmpfile_stdout 01:16:45 INFO - Output received: 01:16:45 INFO - Usage: mozinstall [options] installer 01:16:45 INFO - Options: 01:16:45 INFO - -h, --help show this help message and exit 01:16:45 INFO - -d DEST, --destination=DEST 01:16:45 INFO - Directory to install application into. [default: 01:16:45 INFO - "/builds/slave/test"] 01:16:45 INFO - --app=APP Application being installed. [default: firefox] 01:16:45 INFO - mkdir: /builds/slave/test/build/application 01:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:17:01 INFO - Reading from file tmpfile_stdout 01:17:01 INFO - Output received: 01:17:01 INFO - /builds/slave/test/build/application/firefox/firefox 01:17:01 INFO - Running post-action listener: _resource_record_post_action 01:17:01 INFO - ##### 01:17:01 INFO - ##### Finished install step (success) 01:17:01 INFO - ##### 01:17:01 INFO - ##### 01:17:01 INFO - ##### Running run-tests step. 01:17:01 INFO - ##### 01:17:01 INFO - Running pre-action listener: _resource_record_pre_action 01:17:01 INFO - Running main action method: run_tests 01:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:17:01 INFO - Python 2.7.3 01:17:01 INFO - Return code: 0 01:17:01 INFO - grabbing minidump binary from tooltool 01:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:01 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 0x14e01c0>, '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 0x14e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:17:01 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 01:17:01 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 01:17:01 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 01:17:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:17:01 INFO - Return code: 0 01:17:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:17:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:17:02 INFO - Return code: 0 01:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 01:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 01:17:02 INFO - Using env: {'DISPLAY': ':0', 01:17:02 INFO - 'HOME': '/home/cltbld', 01:17:02 INFO - 'LANG': 'en_US.UTF-8', 01:17:02 INFO - 'LANGUAGE': 'en_US:en', 01:17:02 INFO - 'LOGNAME': 'cltbld', 01:17:02 INFO - 'MAIL': '/var/mail/cltbld', 01:17:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:17:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:02 INFO - 'MOZ_NO_REMOTE': '1', 01:17:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:02 INFO - 'NO_EM_RESTART': '1', 01:17:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:02 INFO - 'PWD': '/builds/slave/test', 01:17:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:17:02 INFO - 'SHELL': '/bin/bash', 01:17:02 INFO - 'SHLVL': '1', 01:17:02 INFO - 'TERM': 'linux', 01:17:02 INFO - 'TMOUT': '86400', 01:17:02 INFO - 'USER': 'cltbld', 01:17:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813', 01:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:02 INFO - '_': '/tools/buildbot/bin/python'} 01:17:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 01:17:02 INFO - mozversion application_buildid: 20160727200726 01:17:02 INFO - mozversion application_changeset: 3a88dc3ec8eab71975935fcc11c798d3576f9106 01:17:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:17:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:17:02 INFO - mozversion application_name: Firefox 01:17:02 INFO - mozversion application_remotingname: firefox-dev 01:17:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:17:02 INFO - mozversion application_vendor: Mozilla 01:17:02 INFO - mozversion application_version: 49.0a2 01:17:02 INFO - mozversion platform_buildid: 20160727200726 01:17:02 INFO - mozversion platform_changeset: 3a88dc3ec8eab71975935fcc11c798d3576f9106 01:17:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:17:02 INFO - mozversion platform_version: 49.0a2 01:17:02 INFO - using testdate: 1469693822 01:17:02 INFO - actual date: 1469693822 01:17:02 INFO - starting webserver on 'localhost:56295' 01:17:02 INFO - SUITE-START | Running 2 tests 01:17:02 INFO - TEST-START | dromaeo_css 01:17:02 INFO - operating with platform_type : linux_ 01:17:02 INFO - Initialising browser for dromaeo_css test... 01:17:02 INFO - TEST-INFO | started process 25315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncSWue/profile http://localhost:56295/getInfo.html) 01:17:06 INFO - PROCESS | 25315 | __metrics Screen width/height:1600/1200 01:17:06 INFO - PROCESS | 25315 | colorDepth:24 01:17:06 INFO - PROCESS | 25315 | Browser inner width/height: 1024/697 01:17:06 INFO - PROCESS | 25315 | __metrics 01:17:07 INFO - PROCESS | 25315 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:17:07 ERROR - PROCESS | 25315 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:17:08 INFO - TEST-INFO | 25315: exit 0 01:17:08 INFO - Browser initialized. 01:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 01:17:08 INFO - TEST-INFO | started process 25408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpncSWue/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:20 INFO - PROCESS | 25408 | RSS: Main: 145338368 01:17:20 INFO - PROCESS | 25408 | 01:18:11 INFO - PROCESS | 25408 | 1469693891186 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] 01:20:18 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56295/tests/dromaeo/cssquery-ext.html) 01:20:19 INFO - PROCESS | 25408 | RSS: Main: 254390272 01:20:19 INFO - PROCESS | 25408 | 01:23:22 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-ext.html (next: http://localhost:56295/tests/dromaeo/cssquery-jquery.html) 01:23:22 INFO - PROCESS | 25408 | RSS: Main: 228392960 01:23:22 INFO - PROCESS | 25408 | 01:26:24 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56295/tests/dromaeo/cssquery-mootools.html) 01:26:25 INFO - PROCESS | 25408 | RSS: Main: 221892608 01:26:25 INFO - PROCESS | 25408 | 01:29:27 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56295/tests/dromaeo/cssquery-prototype.html) 01:29:27 INFO - PROCESS | 25408 | RSS: Main: 223338496 01:29:27 INFO - PROCESS | 25408 | 01:32:30 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56295/tests/dromaeo/cssquery-yui.html) 01:32:31 INFO - PROCESS | 25408 | RSS: Main: 200867840 01:32:31 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-yui.html (next: http://localhost:56295/tests/dromaeo/cssquery-dojo.html) 01:35:33 INFO - PROCESS | 25408 | RSS: Main: 261828608 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | __start_tp_report 01:35:33 INFO - PROCESS | 25408 | _x_x_mozilla_page_load 01:35:33 INFO - PROCESS | 25408 | _x_x_mozilla_page_load_details 01:35:33 INFO - PROCESS | 25408 | |i|pagename|runs| 01:35:33 INFO - PROCESS | 25408 | |0;dojo.html;3217.5495430639708;3242.9351412971755;3250.934981300374;3271.6401195868466;3295.439775238209;5231.921521177181;5235.3194084768975;5250.31745873036;5251.396089449714;5261.394939581949;5313.415524292324;5338.3060202173665;5342.091844386454;5343.759530821113;5356.491133342326;4755.048990201956;4794.760261986904;4798.592119669824;4841.3222148899185;4875.098106850244;4829.1307564638355;4876;4889.608831293488;4891.070696567658;4893.926591101119;4838.709677419349;4839.346688197101;4868.975655121737;4870;4888.462269150391;4930.457649658535;4947.579455746266;4958.479359667219;4964.205727083649;4965.3048573199785;4739.123262196505;4747.667663263573;4813.08551375241;4873.098476781806;4907.631927605408;5182.714950677711;5185.870353241162;5203.323567936144;5234.581233501311;5238.60710446718;5684.147377893308;5708.20085188074;5726.055200891848;5742;5743.712814359307;5684.317881854204;5697.430256974311;5743.16724075011;5765.3369862465515;5811.041178205591;5394.298741163663;5421.593380496479;5437.918431223535;5446.183072539111;5446.509814116669;5676.602637815396;5746.339170995389;5762.510186634099;5762.855928601818;5764.365919748824;5534.1145416733125;5575.8884822304135;5607.579431542651;5609.102543593087;5636.549076073904;5708.686022268732;5711.485966263056;5719.428057194331;5725.971370143206;5738.626989245769;5478.945210547843;5680.403557626472;5682.914756278659;5689.146628005749;5696.658200507983;5696.62971906833;5772.480476757112;5785.681787501728;5788.82633520995;5814.273215848019;4467.888302792456;4469.284914413678;4472.575105364985;4474.395956545824;4499;3890;3911.47195128654;3942.7634341939574;4018.778967156776;4057.9797101014897;5470.64440811346;5489.945100549024;5496.615236933376;5497.120460726344;5524.171374293807;5721.856953576111;5734.655920644775;5739.053056245756;5741.971290143522;5766.625169363978;5249.895002100013;5458.426865179178;5480.588955828329;5531.115021596525;5536.584756143306;4662.790174442091;4687.554682305175;4692.554207350297;4693.741844198602;4711.458182309078;5878.5297176225795;5907.350191478934;5913.2608423947;5963;5967.46292833647;5576.024195765806;5664.773409063591;5680.091185410314;5705.144228365778;5710.628809127394;5769.711514424178;5783.190353350618;5792.94207057924;5827.271591051119;5838.883222335445;5497.120460726264;5653.462921022497;5654.321481422256;5660;5664.773409063591;5697;5705.657660540381;5751.511121554715;5793.565482588739;5797.449242321973;5675.148727690879;5682.147677848356;5683.943160568341;5686.829395118153;5693.231413759255;5430.321209848769;5509.586780991362;5649.350324712711;5660.745266462936;5661.320641523043;5410.594205434687;5509.559235261089;5510.421405752499;5519.862003449946;5548.4174161712435;5579.581531385081;5603.243562119062;5631.155326701028;5639.746211420414;5649.6327738696855;5323.30796996388;5352.5985551084605;5400.027994960945;5497.065498865122;5529.944700552943 01:35:33 INFO - PROCESS | 25408 | |1;ext.html;603.8490377405649;644.5327137825077;661.1669296686175;663.9144997928386;670.2392784189944;33012;36412.08969775754;45124.32313515296;46238.768806155924;46339.30491042637;48339;48934.75532622341;48958.26562601564;48986;48991.51008489914;8984.865227021584;9132.680356187535;9134.908650913472;9140;9141.862872056925;8254.463459875118;10609;10859.67420977368;10879.782404351909;11189.657241131075;11024.669259922215;11107.166962477806;11121.944390278037;11122;11135.721606959809;8255.628496717662;10757.623483178051;11074.114070874351;11149.21955463118;11157.995780379764;10675.359478431319;10730.034296913238;11033.062189713804;11048.171387145996;11070.446477676083;46263.30605040927;46296.537034629895;46582.76708616469;46652.76673616644;46743.29885051727;3926.921461570781;4445.155420470101;4568.5431456854385;4607.9308810367875;4667.906641867144;32656.510152347735;34114.48828267578;34454;34564.48153277703;36016.27967440637;4254.957450425487;4262.104957958802;4264.402983582301;4295.8496452624;4307.095509942916;361002;365393;366122;366827.16586417163;368913;39138.804305978854;70502.64748676223;71418.2858171422;71476.285237148;71656.64171679108;40354;42931;42938.355924661155;42966.14067718628;42999.57000429956;15826.60433489172;16149;16150.434734784227;16158.596035099217;16158.919205403898;10817.513211905483;12685.619431417072;12754.04344674153;13008.674783130307;13110.803337949937;9445.76385590352;9474.810503790024;9492.525373731423;9521.428714277166;9552.617895284111;3568.5360903082433;3596.1549035976523;3616.6021737608844;3644.1254099016573;3648.908777280536;1071.6838532632892;1095.4413249242943;1137.624583887315;1150.7353308739036;1166.3934753928079;30927.381452371275;32522.83738581292;32811.50782738261;33086.17284567905;33499.16252093717;1170.2276497511602;1183.5679976808576;1198.0894520164738;1248.0265392993479;1281.2056524954587;17554.91222543879;17708.203130859143;17711.291548337922;17784.644307113784;17790.37733679315;576480;580475;580656;581503;581971;46978.76510617425;47217.76391118023;47337.526624734004;47466.28800567994;47621.76189119032;1378.2213049626928;1454.5200083972263;1491.2171110167249;1491.970160596782;1508.1403599947923;34308.48537271893;34746.47880281747;35480;35786.463203051455;35980.64019359773;55935.44064559302;55979.72010139923;56698.7165064172;56764;56791.432085678614;424473;425532;426003;426285;426958;27395;29849.850750746107;30992.535111972888;31004.844975774977;32770;51859.48140518546;52984.20523692225;53280.73359633177;53578.464215357344;53659.463405365444;43861.12277754491;44415.55584444243;44839.32741008822;44985;45390.77304613588;43261.134777304906;43761;44485.33272000987;44526;45190;44562.3315650272;44599.108017838815;44804;45441.31838022366;46043;36185.45721814122;38178.80910595429;38410.6158938407;38499.807500963434;39044.414333785586;28583;28818.567721483774;28827.7117228825;29196.7080329194;29486.852565737034 01:35:33 INFO - PROCESS | 25408 | |2;jquery.html;428.4494424664306;432.31693923600716;433.24615169604897;438.65784687943415;445.6412587866768;18628.720569191457;19666;20299.289524866614;21185.57628847422;21204.57590848182;17194.312227510884;17524.12379381029;18350.632987340246;18370.540736481595;18621.813781862176;5236.554892834104;5399.433059528732;5431;5435.402105768362;5440.047991601474;4093.6111069448502;4600.631949444037;5346.091164502024;5414.83755487334;5545.473180047889;6428.967855160741;6522.576032557892;6614.437772789294;6662.400383965442;6667.166604174478;5805.332386775512;6095.481884039862;6117.235345581802;6514.022896565506;6580.93419065808;4055.5944405559503;5733.655980641133;6021.2473440819895;6022.036474164112;6051.213342265477;14446.711065778625;15214.771778423223;15258.313375898111;16510.917445412815;24249.151279705125;2474.7277799442045;2553.8723063846733;2561.5133124706244;2570.730073342291;2892.915156816173;10706.78586428267;10793.946030269877;10811.891881081167;11115.888841111566;11185.440727963569;1928.3540014095295;1970.5369238229005;1982.9206831726713;2013.416109328293;2021.7270668459716;81618;82739;83235.16764832335;83739.16260837436;83956;11843;12095.637130886087;12110.515579376726;12321.815172772416;12771.61685149447;16868.746968795476;16950.576235593962;16983.575410614834;16986.745198822027;17002.57493562646;8210.507369557845;8257.298129659046;8272.255497005299;8313.293370063491;8337.583120843934;7632.465727399029;7653.885191722128;7692.423068269902;7723.189065148191;7733.613319334011;5048.924266136011;5188.507091826271;5200.45395233495;5250.632455728139;5262.030593896173;2087.5616120614536;2091.7594476635077;2103.4110449074283;2153.676948457744;2203.151786562185;929.9767505812273;1000.4697510319543;1006.3408467453829;1009.4246279620546;1034.002187888691;19563.31528396528;19576.608467830563;20016.499587510138;20189.697154542693;20225.59548809045;1022.0801278848946;1022.1465076661071;1036.5853658536646;1056.698840830375;1063.1494804156644;10652.840207396895;11014.284071535325;11140.888591113986;11291.153163512769;11411.543538258376;471697;474080;475427;479843;495453;92104;92184;92221.5388923051;92765.53617231871;94702.52648736713;1064.6486659402378;1067.114295135036;1078.9695840472486;1093.3002878157986;1097.3909480238544;17168.39910603123;17469.65060698804;17670.381536646157;17785.46643600694;17943.282268709107;40494.79752601218;41277.38083928804;41607;42853.78573107115;42954.570454295055;56870.43129568651;58854.86547998772;58856;59230.703846480494;59525.7023714896;9159.86260206084;9256.537173141181;9302.116298951589;9343.29925255595;9466.290028247771;13172.341382930623;13520.323983800574;13533;13553.79669304981;13610.523631672844;11728.061755059745;11754.353510557;11843.585474508696;11875.109366797353;11921.642350729491;11641.359725215194;11886.405679716152;11954.940225298818;11988;12015.81976270374;11888.881111188777;12097.516099356279;12126;12151.878481215428;12467.5012999479;7915.327197188303;9174.54127293646;9179.724608261762;9230.261579073793;9364.063593640854;11722.648320550397;12015.939920300692;12034.458449369624;12092.455839487067;12187.695307617381 01:35:33 INFO - PROCESS | 25408 | |3;mootools.html;1420.5312246958504;1569.3957826236895;1610.3156158632582;1818.2090790506122;1921.0970843703456;8422.241998220159;9267.07329267073;9561.904380956188;9576.99999999999;9890.357126786754;9602.711918642435;9782.853257201148;9800.950995245013;9806.068423499755;9822;2164.0694501364405;2235.2400183937457;2235.6646503024594;2451.8406303590255;2483.019207413071;2356.1164563288767;2475.9133430329944;2477.529269438801;2478.0583378316214;2494.3390001649486;2412.0472413396697;2432.8297019208662;2439.1950656283384;2507.636392723054;2516.9119080832174;2156.687280344341;2371.4664200554907;2485.254423672891;2513;2513.1957773512577;2480.2931164618176;2516.207394670691;2518.9874050629815;2524.1544082732307;2524.482481091372;9462.148406643366;9528.857067143997;9535.2371810255;9539.236861051098;9540.713778586654;5374.328208973879;5531.640443371168;5540.390557038722;5543.556515478752;5543.556515478752;3530.293941211742;3709.925801483982;3798.6771124454453;3814.294355544233;3827.8660246891227;1238.523168580094;1278.8017857232144;1290.3612711707765;1302.9087963842535;1323.6690827293178;13827.51603693876;14070.859291407058;14088.859111408858;14089.436422543085;14110.082844615066;5037.546620804145;5108.974455127701;5122.257272695439;5137.5889928806355;5190.169572868323;11780.352080635475;11827.349495777815;11828.763424731456;11848.703782405337;11848.881511184778;5522.779088836482;5531.474509921551;5538.667679939216;5539.169124631257;5540.113581826889;4400.471943366752;4885.853424397274;4965.32968049316;5004.649674522821;5121.897562048738;4332.870013899588;4429.2913133899065;4569.885752856205;4600.148972440109;4755.83354582588;1407.6551244945053;1421.8151640286696;1422.7581311177125;1445.595233334668;1454.2946670864621;1040.3653771199563;1042.9634962776267;1044.603050840691;1046.5604446132643;1055.5883205549842;6351.364863513611;6369.5222858285815;6386.393292637192;6513;6572.901406478906;1027.5684212630713;1060.7560261139981;1064.9520771565299;1079.400932482464;1090;4255.192199642993;4335.067960388468;4342.761148136819;4400.383946247528;4462.397576327155;12268.44791984363;12571.497140114294;12634.178778379375;12636.684082897817;12685;12082;12379.876201238052;12469.812952805714;12482.001439884787;12499.187552809039;8613.440126391639;9059.229965452878;9071.455712657262;9171.220446262143;9230.123138301851;6410.749519218724;6563.278039415756;6575.835604109936;6646.202455705346;6668.266490686117;11086.390248536409;11173.385463799568;11417.942910285396;11477.36874471912;11503.712407189887;11592.130590205938;11622.0702343814;11653.359065251154;11693.766124677288;11839.526418943145;7482.326590606872;8123.79690507742;8337.791555210926;8338.541380224146;8530.10433904456;9517.095875891779;9533.570989305359;9567.9043209567;9588.808223835624;9601.951990240004;7879.487833290817;8074.757757267292;8108.108108108221;8213.219744124299;8219.547924863951;7817.140114587277;7818.804529886798;8024.077231118263;8027.357811374959;8135.674573017013;7071.646417679199;7299.781006569811;7303.30618591233;7374.04137462148;7377.299156580117;5545.528630066489;5561.026820306511;5573.832785016456;5581.079121944996;5667.20659107717;5650.350209725934;5684.175794509691;5720.3707592165665;5790.710464476843;5831.591788574759 01:35:33 INFO - PROCESS | 25408 | |4;prototype.html;348.4285771335011;356.0901895656597;363.22270341469243;364.79936035180646;366.87342866710986;5149.871253218671;5235.73821308934;5266.315379000729;5310.495502927216;5348.786048558058;5320.579136492896;5333.413324534308;5345.1982202669615;5353.841233672142;5364.329458817648;4222.788860556975;4244.172386384656;4262.211490874198;4264.573542645726;4265.189613973351;4030.5969403059753;4120.526139493952;4240.787960601973;4268.890088576977;4274.145170965804;4190.979045104786;4214.346776249687;4228.5137209220875;4229.555896630855;4243.342281946303;4189.162167566484;4224.197402493516;4226;4227.788610569459;4235.8093885775215;3701.9814900925594;3784.7539909906045;3799.8290076946605;3813.199228162089;3818.198178382543;5067.949320506821;5092.5995351278325;5100.387953445573;5115.7442127893455;5125.82059627915;4800.615950723969;4801.255805350142;4808.2547205183255;4815.735134567597;4819.95180048202;5397.62216644835;5532.944670553283;5608.158776183564;5618.213450116987;5648.661080335152;4110.77390743509;4111.732737372061;4113.794310284474;4124.505059392862;4133.297339452301;5773.740181691834;5787.88424231513;5802.4197580241635;5808.506276966463;5819.098039803837;3958.5843486434087;4085.835536871977;4124.958750412457;4125.66994640428;4131.607497287753;4174.144300418407;4191.559886211965;4191.601797829201;4192;4199.874003779892;4762.14281429346;4767.903382222108;4792.849716068188;4795.544423279783;4798.712077275374;5547.972260138754;5559;5615.241942337814;5631.63394379364;5689.317281926195;1386.1682990205998;1419.865112814281;1424.2736204535554;1427.2435609127178;1430.577979496051;927.6474939522938;937.9437233765859;939.0703203828298;944.2540393089382;944.527736131934;4798.376211092605;4899.828506002273;4947.579455746302;4968.726720030433;4996.4503904570465;5094.6688465249645;5096.337476128079;5103.668261562986;5169.147090729987;5169.7932082717025;4805.645233835396;4805.957468076053;4839.661223714306;4847.80608775645;4852.908095678515;2617.6204450354594;2620.253227830059;2685.6911455182903;2687.7177896320995;2729.894392770931;5133.537981581676;5151.5363617274625;5159.561437277874;5186.533212010937;5200.245964335226;5098.2352647103235;5115.437301896788;5135.998480296306;5170.250313704491;5179.22311653255;5131.7434128293435;5182.637215394886;5198.584113270929;5418.539424148991;5886.409979608959;5698.1737648041635;5727.770889164387;5750.223719797941;5754.4533269339345;5764.596478246483;5682.232898558642;5686.829395118153;5706.946783470823;5711.400302968129;5728.3412407572;5722.685252311163;5830.0355758083215;5842.620229685057;5847.561432892465;5859.355470898283;4052.858149964737;4054.6350828425584;4078.816453259551;4091.9386209207482;4096.283150448719;5562.777488900399;5686.886262274814;5720.227769251264;5720.856978575569;5730.796532728174;5356.625036247581;5617.915731264116;5634.464490978994;5639.154126881001;5641.435856414326;5387.976284505931;5408.593765620888;5426.18607208906;5500.367457742411;5513.421090785409;5469.179623056573;5523.4200408956485;5530.668159910419;5538;5548.528375088163;5416.620836541404;5567.916481252865;5622.2128901954575;5627.240322556566;5649.293838270216;5442.891142177214;5479.808206712746;5518.448155184449;5524.33707955048;5532.336119665666 01:35:33 INFO - PROCESS | 25408 | |5;yui.html;710.5665544018148;716.0154787167645;731.7146312937952;733.2154594583798;754.1515794730927;14437.855621443783;14957.626059348522;15192.848071519282;15235;15237.390504379839;14290.356933937972;14318.785218221736;14320.355583998718;14338.641533961656;14429.206393648345;722.6964674836555;853.2278288149204;879.463527248378;881.6473410635733;898.5282726568571;865.5412631305387;869.4522450855984;871.5511511571545;872.1278721278721;872.3413822563987;925.2875286029753;925.4077390470071;926.3098991251493;926.666400095965;926.7775733823868;763.6334559411486;908.6274627402767;918.5499105438354;934.700895713372;936.0358830404695;690.2131570010192;690.3200347657604;690.6684791300154;690.8894576867677;691.1222747111141;14512.782308265385;14519.346629401702;14551.78172327416;14552.417903283857;14561.49034783788;13804.516841910585;14241.572752817432;14276.571702848827;14305.642358941006;14444.350004249729;12815.807762883564;13053.216806991612;13173;13181.209127452288;13191.2744799036;4578.427696537933;4632.837850675211;4636.44362676481;4654.697444666086;4685.718856868599;73359;74850.62574687092;74854.25145748582;76037.61981190114;76254;11660.941695291638;11765;11800.822987655192;11847.76304473923;12052.035837133008;20344.18623255083;20412;20420;20447.693284600744;20488.487787805127;7810.336121429628;7818.765437036898;7820.491668041559;7888.32949199313;8099.352051835839;4881.829135980223;4928.211486162197;4959.925601115986;5104.9744751276;5158;3414.3342048300838;3488.0059183133194;3514.139035936212;3514.5606799150105;3515.050936247199;572.2903599536545;599.4724642314735;630.4263120560269;653.4413076819346;654.4142992022208;648.4747354642755;801.1147681811515;811.3265989228926;816.1104396208161;819.2954059508818;9366.90633093674;9528.19010384125;9591.280653950982;9838.606455741834;9888.258380621339;706.1667232665504;744.988825167623;769.6228847864506;783.0698319869113;799.7161007842133;4922.852314430573;5048.242763585492;5213.947860521346;5221.086309895753;5266.183741520071;95840.52079739557;105655;129904;132873;135777;97398;97733;98426.5078674602;99050;99864.5006774976;84733;85300.14699852922;86253;86443.56778216195;86628.70056949151;9513.620525023694;9534.380265282734;9726.943743831594;9841.163501102486;9881.407115573089;51683.48316516937;52020;52638.473615263356;52777;54055.72972135114;67466.32533674796;75215.62392188005;76678.6166069166;77999.61000194962;79989;12436.751264974831;12908.419121139383;13133.868661313647;13238.205707657571;13305.401256943655;14287.499937502138;14541.400445950725;14627.561173164822;14823.629409264855;14840.703185936436;13806;13894.444222231401;14147.221902795445;14179.64550886236;14284.214368209849;13739.175649461064;13987.300634968007;14100.717985640435;14227.857721423068;14229.217393043482;13004.8049279259;13175.934120329337;13310.600681979557;13450.394732236877;13586.38861251266;11508;11715.765684686428;11981.880181198076;11987.400629968291;12119;11324.943375283401;11473.311601303949;11656.53373865036;11802.468888899848;12008.699782505508 01:35:33 INFO - PROCESS | 25408 | __end_tp_report 01:35:33 INFO - PROCESS | 25408 | __start_cc_report 01:35:33 INFO - PROCESS | 25408 | _x_x_mozilla_cycle_collect,918 01:35:33 INFO - PROCESS | 25408 | __end_cc_report 01:35:33 INFO - PROCESS | 25408 | __startTimestamp1469694933668__endTimestamp 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | ------- Summary: start ------- 01:35:33 INFO - PROCESS | 25408 | Number of tests: 6 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#0] dojo.html Cycles:165 Average:5306.94 Median:5510.42 stddev:578.37 (10.5%) stddev-sans-first:556.43 01:35:33 INFO - PROCESS | 25408 | Values: 3217.5 3242.9 3250.9 3271.6 3295.4 5231.9 5235.3 5250.3 5251.4 5261.4 5313.4 5338.3 5342.1 5343.8 5356.5 4755.0 4794.8 4798.6 4841.3 4875.1 4829.1 4876.0 4889.6 4891.1 4893.9 4838.7 4839.3 4869.0 4870.0 4888.5 4930.5 4947.6 4958.5 4964.2 4965.3 4739.1 4747.7 4813.1 4873.1 4907.6 5182.7 5185.9 5203.3 5234.6 5238.6 5684.1 5708.2 5726.1 5742.0 5743.7 5684.3 5697.4 5743.2 5765.3 5811.0 5394.3 5421.6 5437.9 5446.2 5446.5 5676.6 5746.3 5762.5 5762.9 5764.4 5534.1 5575.9 5607.6 5609.1 5636.5 5708.7 5711.5 5719.4 5726.0 5738.6 5478.9 5680.4 5682.9 5689.1 5696.7 5696.6 5772.5 5785.7 5788.8 5814.3 4467.9 4469.3 4472.6 4474.4 4499.0 3890.0 3911.5 3942.8 4018.8 4058.0 5470.6 5489.9 5496.6 5497.1 5524.2 5721.9 5734.7 5739.1 5742.0 5766.6 5249.9 5458.4 5480.6 5531.1 5536.6 4662.8 4687.6 4692.6 4693.7 4711.5 5878.5 5907.4 5913.3 5963.0 5967.5 5576.0 5664.8 5680.1 5705.1 5710.6 5769.7 5783.2 5792.9 5827.3 5838.9 5497.1 5653.5 5654.3 5660.0 5664.8 5697.0 5705.7 5751.5 5793.6 5797.4 5675.1 5682.1 5683.9 5686.8 5693.2 5430.3 5509.6 5649.4 5660.7 5661.3 5410.6 5509.6 5510.4 5519.9 5548.4 5579.6 5603.2 5631.2 5639.7 5649.6 5323.3 5352.6 5400.0 5497.1 5529.9 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#1] ext.html Cycles:180 Average:61966.45 Median:21532.86 stddev:123756.58 (574.7%) stddev-sans-first:124017.99 01:35:33 INFO - PROCESS | 25408 | Values: 603.8 644.5 661.2 663.9 670.2 33012.0 36412.1 45124.3 46238.8 46339.3 48339.0 48934.8 48958.3 48986.0 48991.5 8984.9 9132.7 9134.9 9140.0 9141.9 8254.5 10609.0 10859.7 10879.8 11189.7 11024.7 11107.2 11121.9 11122.0 11135.7 8255.6 10757.6 11074.1 11149.2 11158.0 10675.4 10730.0 11033.1 11048.2 11070.4 46263.3 46296.5 46582.8 46652.8 46743.3 3926.9 4445.2 4568.5 4607.9 4667.9 32656.5 34114.5 34454.0 34564.5 36016.3 4255.0 4262.1 4264.4 4295.8 4307.1 361002.0 365393.0 366122.0 366827.2 368913.0 39138.8 70502.6 71418.3 71476.3 71656.6 40354.0 42931.0 42938.4 42966.1 42999.6 15826.6 16149.0 16150.4 16158.6 16158.9 10817.5 12685.6 12754.0 13008.7 13110.8 9445.8 9474.8 9492.5 9521.4 9552.6 3568.5 3596.2 3616.6 3644.1 3648.9 1071.7 1095.4 1137.6 1150.7 1166.4 30927.4 32522.8 32811.5 33086.2 33499.2 1170.2 1183.6 1198.1 1248.0 1281.2 17554.9 17708.2 17711.3 17784.6 17790.4 576480.0 580475.0 580656.0 581503.0 581971.0 46978.8 47217.8 47337.5 47466.3 47621.8 1378.2 1454.5 1491.2 1492.0 1508.1 34308.5 34746.5 35480.0 35786.5 35980.6 55935.4 55979.7 56698.7 56764.0 56791.4 424473.0 425532.0 426003.0 426285.0 426958.0 27395.0 29849.9 30992.5 31004.8 32770.0 51859.5 52984.2 53280.7 53578.5 53659.5 43861.1 44415.6 44839.3 44985.0 45390.8 43261.1 43761.0 44485.3 44526.0 45190.0 44562.3 44599.1 44804.0 45441.3 46043.0 36185.5 38178.8 38410.6 38499.8 39044.4 28583.0 28818.6 28827.7 29196.7 29486.9 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#2] jquery.html Cycles:180 Average:28876.91 Median:11679.13 stddev:79132.38 (677.6%) stddev-sans-first:79325.53 01:35:33 INFO - PROCESS | 25408 | Values: 428.4 432.3 433.2 438.7 445.6 18628.7 19666.0 20299.3 21185.6 21204.6 17194.3 17524.1 18350.6 18370.5 18621.8 5236.6 5399.4 5431.0 5435.4 5440.0 4093.6 4600.6 5346.1 5414.8 5545.5 6429.0 6522.6 6614.4 6662.4 6667.2 5805.3 6095.5 6117.2 6514.0 6580.9 4055.6 5733.7 6021.2 6022.0 6051.2 14446.7 15214.8 15258.3 16510.9 24249.2 2474.7 2553.9 2561.5 2570.7 2892.9 10706.8 10793.9 10811.9 11115.9 11185.4 1928.4 1970.5 1982.9 2013.4 2021.7 81618.0 82739.0 83235.2 83739.2 83956.0 11843.0 12095.6 12110.5 12321.8 12771.6 16868.7 16950.6 16983.6 16986.7 17002.6 8210.5 8257.3 8272.3 8313.3 8337.6 7632.5 7653.9 7692.4 7723.2 7733.6 5048.9 5188.5 5200.5 5250.6 5262.0 2087.6 2091.8 2103.4 2153.7 2203.2 930.0 1000.5 1006.3 1009.4 1034.0 19563.3 19576.6 20016.5 20189.7 20225.6 1022.1 1022.1 1036.6 1056.7 1063.1 10652.8 11014.3 11140.9 11291.2 11411.5 471697.0 474080.0 475427.0 479843.0 495453.0 92104.0 92184.0 92221.5 92765.5 94702.5 1064.6 1067.1 1079.0 1093.3 1097.4 17168.4 17469.7 17670.4 17785.5 17943.3 40494.8 41277.4 41607.0 42853.8 42954.6 56870.4 58854.9 58856.0 59230.7 59525.7 9159.9 9256.5 9302.1 9343.3 9466.3 13172.3 13520.3 13533.0 13553.8 13610.5 11728.1 11754.4 11843.6 11875.1 11921.6 11641.4 11886.4 11954.9 11988.0 12015.8 11888.9 12097.5 12126.0 12151.9 12467.5 7915.3 9174.5 9179.7 9230.3 9364.1 11722.6 12015.9 12034.5 12092.5 12187.7 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#3] mootools.html Cycles:180 Average:6366.62 Median:4414.88 stddev:3740.34 (84.7%) stddev-sans-first:3732.36 01:35:33 INFO - PROCESS | 25408 | Values: 1420.5 1569.4 1610.3 1818.2 1921.1 8422.2 9267.1 9561.9 9577.0 9890.4 9602.7 9782.9 9801.0 9806.1 9822.0 2164.1 2235.2 2235.7 2451.8 2483.0 2356.1 2475.9 2477.5 2478.1 2494.3 2412.0 2432.8 2439.2 2507.6 2516.9 2156.7 2371.5 2485.3 2513.0 2513.2 2480.3 2516.2 2519.0 2524.2 2524.5 9462.1 9528.9 9535.2 9539.2 9540.7 5374.3 5531.6 5540.4 5543.6 5543.6 3530.3 3709.9 3798.7 3814.3 3827.9 1238.5 1278.8 1290.4 1302.9 1323.7 13827.5 14070.9 14088.9 14089.4 14110.1 5037.5 5109.0 5122.3 5137.6 5190.2 11780.4 11827.3 11828.8 11848.7 11848.9 5522.8 5531.5 5538.7 5539.2 5540.1 4400.5 4885.9 4965.3 5004.6 5121.9 4332.9 4429.3 4569.9 4600.1 4755.8 1407.7 1421.8 1422.8 1445.6 1454.3 1040.4 1043.0 1044.6 1046.6 1055.6 6351.4 6369.5 6386.4 6513.0 6572.9 1027.6 1060.8 1065.0 1079.4 1090.0 4255.2 4335.1 4342.8 4400.4 4462.4 12268.4 12571.5 12634.2 12636.7 12685.0 12082.0 12379.9 12469.8 12482.0 12499.2 8613.4 9059.2 9071.5 9171.2 9230.1 6410.7 6563.3 6575.8 6646.2 6668.3 11086.4 11173.4 11417.9 11477.4 11503.7 11592.1 11622.1 11653.4 11693.8 11839.5 7482.3 8123.8 8337.8 8338.5 8530.1 9517.1 9533.6 9567.9 9588.8 9602.0 7879.5 8074.8 8108.1 8213.2 8219.5 7817.1 7818.8 8024.1 8027.4 8135.7 7071.6 7299.8 7303.3 7374.0 7377.3 5545.5 5561.0 5573.8 5581.1 5667.2 5650.4 5684.2 5720.4 5790.7 5831.6 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#4] prototype.html Cycles:180 Average:4608.44 Median:5132.64 stddev:1330.47 (25.9%) stddev-sans-first:1295.22 01:35:33 INFO - PROCESS | 25408 | Values: 348.4 356.1 363.2 364.8 366.9 5149.9 5235.7 5266.3 5310.5 5348.8 5320.6 5333.4 5345.2 5353.8 5364.3 4222.8 4244.2 4262.2 4264.6 4265.2 4030.6 4120.5 4240.8 4268.9 4274.1 4191.0 4214.3 4228.5 4229.6 4243.3 4189.2 4224.2 4226.0 4227.8 4235.8 3702.0 3784.8 3799.8 3813.2 3818.2 5067.9 5092.6 5100.4 5115.7 5125.8 4800.6 4801.3 4808.3 4815.7 4820.0 5397.6 5532.9 5608.2 5618.2 5648.7 4110.8 4111.7 4113.8 4124.5 4133.3 5773.7 5787.9 5802.4 5808.5 5819.1 3958.6 4085.8 4125.0 4125.7 4131.6 4174.1 4191.6 4191.6 4192.0 4199.9 4762.1 4767.9 4792.8 4795.5 4798.7 5548.0 5559.0 5615.2 5631.6 5689.3 1386.2 1419.9 1424.3 1427.2 1430.6 927.6 937.9 939.1 944.3 944.5 4798.4 4899.8 4947.6 4968.7 4996.5 5094.7 5096.3 5103.7 5169.1 5169.8 4805.6 4806.0 4839.7 4847.8 4852.9 2617.6 2620.3 2685.7 2687.7 2729.9 5133.5 5151.5 5159.6 5186.5 5200.2 5098.2 5115.4 5136.0 5170.3 5179.2 5131.7 5182.6 5198.6 5418.5 5886.4 5698.2 5727.8 5750.2 5754.5 5764.6 5682.2 5686.8 5706.9 5711.4 5728.3 5722.7 5830.0 5842.6 5847.6 5859.4 4052.9 4054.6 4078.8 4091.9 4096.3 5562.8 5686.9 5720.2 5720.9 5730.8 5356.6 5617.9 5634.5 5639.2 5641.4 5388.0 5408.6 5426.2 5500.4 5513.4 5469.2 5523.4 5530.7 5538.0 5548.5 5416.6 5567.9 5622.2 5627.2 5649.3 5442.9 5479.8 5518.4 5524.3 5532.3 01:35:33 INFO - PROCESS | 25408 | 01:35:33 INFO - PROCESS | 25408 | [#5] yui.html Cycles:180 Average:21004.79 Median:28420.74 stddev:30417.56 (107.0%) stddev-sans-first:30464.72 01:35:33 INFO - PROCESS | 25408 | Values: 710.6 716.0 731.7 733.2 754.2 14437.9 14957.6 15192.8 15235.0 15237.4 14290.4 14318.8 14320.4 14338.6 14429.2 722.7 853.2 879.5 881.6 898.5 865.5 869.5 871.6 872.1 872.3 925.3 925.4 926.3 926.7 926.8 763.6 908.6 918.5 934.7 936.0 690.2 690.3 690.7 690.9 691.1 14512.8 14519.3 14551.8 14552.4 14561.5 13804.5 14241.6 14276.6 14305.6 14444.4 12815.8 13053.2 13173.0 13181.2 13191.3 4578.4 4632.8 4636.4 4654.7 4685.7 73359.0 74850.6 74854.3 76037.6 76254.0 11660.9 11765.0 11800.8 11847.8 12052.0 20344.2 20412.0 20420.0 20447.7 20488.5 7810.3 7818.8 7820.5 7888.3 8099.4 4881.8 4928.2 4959.9 5105.0 5158.0 3414.3 3488.0 3514.1 3514.6 3515.1 572.3 599.5 630.4 653.4 654.4 648.5 801.1 811.3 816.1 819.3 9366.9 9528.2 9591.3 9838.6 9888.3 706.2 745.0 769.6 783.1 799.7 4922.9 5048.2 5213.9 5221.1 5266.2 95840.5 105655.0 129904.0 132873.0 135777.0 97398.0 97733.0 98426.5 99050.0 99864.5 84733.0 85300.1 86253.0 86443.6 86628.7 9513.6 9534.4 9726.9 9841.2 9881.4 51683.5 52020.0 52638.5 52777.0 54055.7 67466.3 75215.6 76678.6 77999.6 79989.0 12436.8 12908.4 13133.9 13238.2 13305.4 14287.5 14541.4 14627.6 14823.6 14840.7 13806.0 13894.4 14147.2 14179.6 14284.2 13739.2 13987.3 14100.7 14227.9 14229.2 13004.8 13175.9 13310.6 13450.4 13586.4 11508.0 11715.8 11981.9 11987.4 12119.0 11324.9 11473.3 11656.5 11802.5 12008.7 01:35:33 INFO - PROCESS | 25408 | -------- Summary: end -------- 01:35:33 INFO - PROCESS | 25408 | 01:35:34 INFO - TEST-INFO | 25408: exit 0 01:35:34 INFO - TEST-OK | dromaeo_css | took 1112058ms 01:35:34 INFO - TEST-START | kraken 01:35:34 INFO - operating with platform_type : linux_ 01:35:34 INFO - Initialising browser for kraken test... 01:35:34 INFO - TEST-INFO | started process 25600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtESqT/profile http://localhost:56295/getInfo.html) 01:35:38 INFO - PROCESS | 25600 | __metrics Screen width/height:1600/1200 01:35:38 INFO - PROCESS | 25600 | colorDepth:24 01:35:38 INFO - PROCESS | 25600 | Browser inner width/height: 1024/697 01:35:38 INFO - PROCESS | 25600 | __metrics 01:35:39 INFO - PROCESS | 25600 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:35:39 ERROR - PROCESS | 25600 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:35:40 INFO - TEST-INFO | 25600: exit 0 01:35:40 INFO - Browser initialized. 01:35:40 INFO - Running cycle 1/1 for kraken test... 01:35:40 INFO - TEST-INFO | started process 25691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHtESqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:52 INFO - PROCESS | 25691 | RSS: Main: 145285120 01:35:52 INFO - PROCESS | 25691 | 01:35:54 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-beat-detection) 01:35:55 INFO - PROCESS | 25691 | RSS: Main: 194220032 01:35:55 INFO - PROCESS | 25691 | 01:35:58 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-dft) 01:35:58 INFO - PROCESS | 25691 | RSS: Main: 193310720 01:35:58 INFO - PROCESS | 25691 | 01:36:01 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-fft) 01:36:02 INFO - PROCESS | 25691 | RSS: Main: 279150592 01:36:02 INFO - PROCESS | 25691 | 01:36:04 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-oscillator) 01:36:04 INFO - PROCESS | 25691 | RSS: Main: 187310080 01:36:04 INFO - PROCESS | 25691 | 01:36:06 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:36:07 INFO - PROCESS | 25691 | RSS: Main: 187408384 01:36:07 INFO - PROCESS | 25691 | 01:36:10 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-darkroom) 01:36:11 INFO - PROCESS | 25691 | RSS: Main: 221954048 01:36:11 INFO - PROCESS | 25691 | 01:36:14 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-desaturate) 01:36:15 INFO - PROCESS | 25691 | RSS: Main: 222625792 01:36:15 INFO - PROCESS | 25691 | 01:36:17 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56295/tests/kraken/driver.html?testName=json-parse-financial) 01:36:18 INFO - PROCESS | 25691 | RSS: Main: 222728192 01:36:18 INFO - PROCESS | 25691 | 01:36:19 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:36:20 INFO - PROCESS | 25691 | RSS: Main: 200986624 01:36:20 INFO - PROCESS | 25691 | 01:36:22 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:36:22 INFO - PROCESS | 25691 | RSS: Main: 202436608 01:36:22 INFO - PROCESS | 25691 | 01:36:24 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:36:25 INFO - PROCESS | 25691 | RSS: Main: 207802368 01:36:25 INFO - PROCESS | 25691 | 01:36:27 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:36:28 INFO - PROCESS | 25691 | RSS: Main: 214433792 01:36:28 INFO - PROCESS | 25691 | 01:36:31 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:36:31 INFO - PROCESS | 25691 | RSS: Main: 213024768 01:36:31 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56295/tests/kraken/driver.html?testName=ai-astar) 01:36:33 INFO - PROCESS | 25691 | RSS: Main: 255967232 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | __start_tp_report 01:36:33 INFO - PROCESS | 25691 | _x_x_mozilla_page_load 01:36:33 INFO - PROCESS | 25691 | _x_x_mozilla_page_load_details 01:36:33 INFO - PROCESS | 25691 | |i|pagename|runs| 01:36:33 INFO - PROCESS | 25691 | |0;ai-astar;110;103;109;109;109;109;110;110;109;109 01:36:33 INFO - PROCESS | 25691 | |1;audio-beat-detection;157;125;125;175;125;131;152;121;152;124 01:36:33 INFO - PROCESS | 25691 | |2;audio-dft;162;162;163;162;163;162;162;161;160;161 01:36:33 INFO - PROCESS | 25691 | |3;audio-fft;75;75;76;129;74;76;76;75;116;76 01:36:33 INFO - PROCESS | 25691 | |4;audio-oscillator;84;85;109;85;85;84;113;85;86;133 01:36:33 INFO - PROCESS | 25691 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;123 01:36:33 INFO - PROCESS | 25691 | |6;imaging-darkroom;147;147;146;145;146;146;147;147;146;145 01:36:33 INFO - PROCESS | 25691 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 01:36:33 INFO - PROCESS | 25691 | |8;json-parse-financial;49;49;49;52;51;50;50;50;50;50 01:36:33 INFO - PROCESS | 25691 | |9;json-stringify-tinderbox;59;60;59;60;59;59;59;59;60;60 01:36:33 INFO - PROCESS | 25691 | |10;stanford-crypto-aes;76;77;76;82;81;81;77;77;108;77 01:36:33 INFO - PROCESS | 25691 | |11;stanford-crypto-ccm;118;125;115;117;115;116;116;121;129;120 01:36:33 INFO - PROCESS | 25691 | |12;stanford-crypto-pbkdf2;154;158;156;152;152;158;154;158;151;153 01:36:33 INFO - PROCESS | 25691 | |13;stanford-crypto-sha256-iterative;61;62;62;61;61;63;60;61;62;61 01:36:33 INFO - PROCESS | 25691 | __end_tp_report 01:36:33 INFO - PROCESS | 25691 | __start_cc_report 01:36:33 INFO - PROCESS | 25691 | _x_x_mozilla_cycle_collect,1629 01:36:33 INFO - PROCESS | 25691 | __end_cc_report 01:36:33 INFO - PROCESS | 25691 | __startTimestamp1469694993741__endTimestamp 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | ------- Summary: start ------- 01:36:33 INFO - PROCESS | 25691 | Number of tests: 14 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:2.06 (1.9%) stddev-sans-first:2.13 01:36:33 INFO - PROCESS | 25691 | Values: 110.0 103.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:141.50 stddev:18.73 (13.2%) stddev-sans-first:18.66 01:36:33 INFO - PROCESS | 25691 | Values: 157.0 125.0 125.0 175.0 125.0 131.0 152.0 121.0 152.0 124.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 01:36:33 INFO - PROCESS | 25691 | Values: 162.0 162.0 163.0 162.0 163.0 162.0 162.0 161.0 160.0 161.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.50 stddev:20.12 (26.6%) stddev-sans-first:21.02 01:36:33 INFO - PROCESS | 25691 | Values: 75.0 75.0 76.0 129.0 74.0 76.0 76.0 75.0 116.0 76.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:85.00 stddev:17.28 (20.3%) stddev-sans-first:17.87 01:36:33 INFO - PROCESS | 25691 | Values: 84.0 85.0 109.0 85.0 85.0 84.0 113.0 85.0 86.0 133.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:2.06 (1.8%) stddev-sans-first:2.13 01:36:33 INFO - PROCESS | 25691 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 123.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 01:36:33 INFO - PROCESS | 25691 | Values: 147.0 147.0 146.0 145.0 146.0 146.0 147.0 147.0 146.0 145.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:36:33 INFO - PROCESS | 25691 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.94 (1.9%) stddev-sans-first:0.93 01:36:33 INFO - PROCESS | 25691 | Values: 49.0 49.0 49.0 52.0 51.0 50.0 50.0 50.0 50.0 50.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 01:36:33 INFO - PROCESS | 25691 | Values: 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 60.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:77.00 stddev:9.68 (12.6%) stddev-sans-first:10.08 01:36:33 INFO - PROCESS | 25691 | Values: 76.0 77.0 76.0 82.0 81.0 81.0 77.0 77.0 108.0 77.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:119.00 stddev:4.66 (3.9%) stddev-sans-first:4.92 01:36:33 INFO - PROCESS | 25691 | Values: 118.0 125.0 115.0 117.0 115.0 116.0 116.0 121.0 129.0 120.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.00 stddev:2.72 (1.8%) stddev-sans-first:2.87 01:36:33 INFO - PROCESS | 25691 | Values: 154.0 158.0 156.0 152.0 152.0 158.0 154.0 158.0 151.0 153.0 01:36:33 INFO - PROCESS | 25691 | 01:36:33 INFO - PROCESS | 25691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 01:36:33 INFO - PROCESS | 25691 | Values: 61.0 62.0 62.0 61.0 61.0 63.0 60.0 61.0 62.0 61.0 01:36:33 INFO - PROCESS | 25691 | -------- Summary: end -------- 01:36:33 INFO - PROCESS | 25691 | 01:36:34 INFO - TEST-INFO | 25691: exit 0 01:36:34 INFO - TEST-OK | kraken | took 60300ms 01:36:34 INFO - SUITE-END | took 1172s 01:36:34 INFO - Completed test suite (00:19:32) 01:36:34 INFO - javascript benchmark 01:36:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3217.5495430639708, 3242.9351412971755, 3250.934981300374, 3271.6401195868466, 3295.439775238209, 5231.921521177181, 5235.3194084768975, 5250.31745873036, 5251.396089449714, 5261.394939581949, 5313.415524292324, 5338.3060202173665, 5342.091844386454, 5343.759530821113, 5356.491133342326, 4755.048990201956, 4794.760261986904, 4798.592119669824, 4841.3222148899185, 4875.098106850244, 4829.1307564638355, 4876.0, 4889.608831293488, 4891.070696567658, 4893.926591101119, 4838.709677419349, 4839.346688197101, 4868.975655121737, 4870.0, 4888.462269150391, 4930.457649658535, 4947.579455746266, 4958.479359667219, 4964.205727083649, 4965.3048573199785, 4739.123262196505, 4747.667663263573, 4813.08551375241, 4873.098476781806, 4907.631927605408, 5182.714950677711, 5185.870353241162, 5203.323567936144, 5234.581233501311, 5238.60710446718, 5684.147377893308, 5708.20085188074, 5726.055200891848, 5742.0, 5743.712814359307, 5684.317881854204, 5697.430256974311, 5743.16724075011, 5765.3369862465515, 5811.041178205591, 5394.298741163663, 5421.593380496479, 5437.918431223535, 5446.183072539111, 5446.509814116669, 5676.602637815396, 5746.339170995389, 5762.510186634099, 5762.855928601818, 5764.365919748824, 5534.1145416733125, 5575.8884822304135, 5607.579431542651, 5609.102543593087, 5636.549076073904, 5708.686022268732, 5711.485966263056, 5719.428057194331, 5725.971370143206, 5738.626989245769, 5478.945210547843, 5680.403557626472, 5682.914756278659, 5689.146628005749, 5696.658200507983, 5696.62971906833, 5772.480476757112, 5785.681787501728, 5788.82633520995, 5814.273215848019, 4467.888302792456, 4469.284914413678, 4472.575105364985, 4474.395956545824, 4499.0, 3890.0, 3911.47195128654, 3942.7634341939574, 4018.778967156776, 4057.9797101014897, 5470.64440811346, 5489.945100549024, 5496.615236933376, 5497.120460726344, 5524.171374293807, 5721.856953576111, 5734.655920644775, 5739.053056245756, 5741.971290143522, 5766.625169363978, 5249.895002100013, 5458.426865179178, 5480.588955828329, 5531.115021596525, 5536.584756143306, 4662.790174442091, 4687.554682305175, 4692.554207350297, 4693.741844198602, 4711.458182309078, 5878.5297176225795, 5907.350191478934, 5913.2608423947, 5963.0, 5967.46292833647, 5576.024195765806, 5664.773409063591, 5680.091185410314, 5705.144228365778, 5710.628809127394, 5769.711514424178, 5783.190353350618, 5792.94207057924, 5827.271591051119, 5838.883222335445, 5497.120460726264, 5653.462921022497, 5654.321481422256, 5660.0, 5664.773409063591, 5697.0, 5705.657660540381, 5751.511121554715, 5793.565482588739, 5797.449242321973, 5675.148727690879, 5682.147677848356, 5683.943160568341, 5686.829395118153, 5693.231413759255, 5430.321209848769, 5509.586780991362, 5649.350324712711, 5660.745266462936, 5661.320641523043, 5410.594205434687, 5509.559235261089, 5510.421405752499, 5519.862003449946, 5548.4174161712435, 5579.581531385081, 5603.243562119062, 5631.155326701028, 5639.746211420414, 5649.6327738696855, 5323.30796996388, 5352.5985551084605, 5400.027994960945, 5497.065498865122, 5529.944700552943], "value": 5270.368185896721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8490377405649, 644.5327137825077, 661.1669296686175, 663.9144997928386, 670.2392784189944, 33012.0, 36412.08969775754, 45124.32313515296, 46238.768806155924, 46339.30491042637, 48339.0, 48934.75532622341, 48958.26562601564, 48986.0, 48991.51008489914, 8984.865227021584, 9132.680356187535, 9134.908650913472, 9140.0, 9141.862872056925, 8254.463459875118, 10609.0, 10859.67420977368, 10879.782404351909, 11189.657241131075, 11024.669259922215, 11107.166962477806, 11121.944390278037, 11122.0, 11135.721606959809, 8255.628496717662, 10757.623483178051, 11074.114070874351, 11149.21955463118, 11157.995780379764, 10675.359478431319, 10730.034296913238, 11033.062189713804, 11048.171387145996, 11070.446477676083, 46263.30605040927, 46296.537034629895, 46582.76708616469, 46652.76673616644, 46743.29885051727, 3926.921461570781, 4445.155420470101, 4568.5431456854385, 4607.9308810367875, 4667.906641867144, 32656.510152347735, 34114.48828267578, 34454.0, 34564.48153277703, 36016.27967440637, 4254.957450425487, 4262.104957958802, 4264.402983582301, 4295.8496452624, 4307.095509942916, 361002.0, 365393.0, 366122.0, 366827.16586417163, 368913.0, 39138.804305978854, 70502.64748676223, 71418.2858171422, 71476.285237148, 71656.64171679108, 40354.0, 42931.0, 42938.355924661155, 42966.14067718628, 42999.57000429956, 15826.60433489172, 16149.0, 16150.434734784227, 16158.596035099217, 16158.919205403898, 10817.513211905483, 12685.619431417072, 12754.04344674153, 13008.674783130307, 13110.803337949937, 9445.76385590352, 9474.810503790024, 9492.525373731423, 9521.428714277166, 9552.617895284111, 3568.5360903082433, 3596.1549035976523, 3616.6021737608844, 3644.1254099016573, 3648.908777280536, 1071.6838532632892, 1095.4413249242943, 1137.624583887315, 1150.7353308739036, 1166.3934753928079, 30927.381452371275, 32522.83738581292, 32811.50782738261, 33086.17284567905, 33499.16252093717, 1170.2276497511602, 1183.5679976808576, 1198.0894520164738, 1248.0265392993479, 1281.2056524954587, 17554.91222543879, 17708.203130859143, 17711.291548337922, 17784.644307113784, 17790.37733679315, 576480.0, 580475.0, 580656.0, 581503.0, 581971.0, 46978.76510617425, 47217.76391118023, 47337.526624734004, 47466.28800567994, 47621.76189119032, 1378.2213049626928, 1454.5200083972263, 1491.2171110167249, 1491.970160596782, 1508.1403599947923, 34308.48537271893, 34746.47880281747, 35480.0, 35786.463203051455, 35980.64019359773, 55935.44064559302, 55979.72010139923, 56698.7165064172, 56764.0, 56791.432085678614, 424473.0, 425532.0, 426003.0, 426285.0, 426958.0, 27395.0, 29849.850750746107, 30992.535111972888, 31004.844975774977, 32770.0, 51859.48140518546, 52984.20523692225, 53280.73359633177, 53578.464215357344, 53659.463405365444, 43861.12277754491, 44415.55584444243, 44839.32741008822, 44985.0, 45390.77304613588, 43261.134777304906, 43761.0, 44485.33272000987, 44526.0, 45190.0, 44562.3315650272, 44599.108017838815, 44804.0, 45441.31838022366, 46043.0, 36185.45721814122, 38178.80910595429, 38410.6158938407, 38499.807500963434, 39044.414333785586, 28583.0, 28818.567721483774, 28827.7117228825, 29196.7080329194, 29486.852565737034], "value": 20406.534995231952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.4494424664306, 432.31693923600716, 433.24615169604897, 438.65784687943415, 445.6412587866768, 18628.720569191457, 19666.0, 20299.289524866614, 21185.57628847422, 21204.57590848182, 17194.312227510884, 17524.12379381029, 18350.632987340246, 18370.540736481595, 18621.813781862176, 5236.554892834104, 5399.433059528732, 5431.0, 5435.402105768362, 5440.047991601474, 4093.6111069448502, 4600.631949444037, 5346.091164502024, 5414.83755487334, 5545.473180047889, 6428.967855160741, 6522.576032557892, 6614.437772789294, 6662.400383965442, 6667.166604174478, 5805.332386775512, 6095.481884039862, 6117.235345581802, 6514.022896565506, 6580.93419065808, 4055.5944405559503, 5733.655980641133, 6021.2473440819895, 6022.036474164112, 6051.213342265477, 14446.711065778625, 15214.771778423223, 15258.313375898111, 16510.917445412815, 24249.151279705125, 2474.7277799442045, 2553.8723063846733, 2561.5133124706244, 2570.730073342291, 2892.915156816173, 10706.78586428267, 10793.946030269877, 10811.891881081167, 11115.888841111566, 11185.440727963569, 1928.3540014095295, 1970.5369238229005, 1982.9206831726713, 2013.416109328293, 2021.7270668459716, 81618.0, 82739.0, 83235.16764832335, 83739.16260837436, 83956.0, 11843.0, 12095.637130886087, 12110.515579376726, 12321.815172772416, 12771.61685149447, 16868.746968795476, 16950.576235593962, 16983.575410614834, 16986.745198822027, 17002.57493562646, 8210.507369557845, 8257.298129659046, 8272.255497005299, 8313.293370063491, 8337.583120843934, 7632.465727399029, 7653.885191722128, 7692.423068269902, 7723.189065148191, 7733.613319334011, 5048.924266136011, 5188.507091826271, 5200.45395233495, 5250.632455728139, 5262.030593896173, 2087.5616120614536, 2091.7594476635077, 2103.4110449074283, 2153.676948457744, 2203.151786562185, 929.9767505812273, 1000.4697510319543, 1006.3408467453829, 1009.4246279620546, 1034.002187888691, 19563.31528396528, 19576.608467830563, 20016.499587510138, 20189.697154542693, 20225.59548809045, 1022.0801278848946, 1022.1465076661071, 1036.5853658536646, 1056.698840830375, 1063.1494804156644, 10652.840207396895, 11014.284071535325, 11140.888591113986, 11291.153163512769, 11411.543538258376, 471697.0, 474080.0, 475427.0, 479843.0, 495453.0, 92104.0, 92184.0, 92221.5388923051, 92765.53617231871, 94702.52648736713, 1064.6486659402378, 1067.114295135036, 1078.9695840472486, 1093.3002878157986, 1097.3909480238544, 17168.39910603123, 17469.65060698804, 17670.381536646157, 17785.46643600694, 17943.282268709107, 40494.79752601218, 41277.38083928804, 41607.0, 42853.78573107115, 42954.570454295055, 56870.43129568651, 58854.86547998772, 58856.0, 59230.703846480494, 59525.7023714896, 9159.86260206084, 9256.537173141181, 9302.116298951589, 9343.29925255595, 9466.290028247771, 13172.341382930623, 13520.323983800574, 13533.0, 13553.79669304981, 13610.523631672844, 11728.061755059745, 11754.353510557, 11843.585474508696, 11875.109366797353, 11921.642350729491, 11641.359725215194, 11886.405679716152, 11954.940225298818, 11988.0, 12015.81976270374, 11888.881111188777, 12097.516099356279, 12126.0, 12151.878481215428, 12467.5012999479, 7915.327197188303, 9174.54127293646, 9179.724608261762, 9230.261579073793, 9364.063593640854, 11722.648320550397, 12015.939920300692, 12034.458449369624, 12092.455839487067, 12187.695307617381], "value": 9441.505700479862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.5312246958504, 1569.3957826236895, 1610.3156158632582, 1818.2090790506122, 1921.0970843703456, 8422.241998220159, 9267.07329267073, 9561.904380956188, 9576.99999999999, 9890.357126786754, 9602.711918642435, 9782.853257201148, 9800.950995245013, 9806.068423499755, 9822.0, 2164.0694501364405, 2235.2400183937457, 2235.6646503024594, 2451.8406303590255, 2483.019207413071, 2356.1164563288767, 2475.9133430329944, 2477.529269438801, 2478.0583378316214, 2494.3390001649486, 2412.0472413396697, 2432.8297019208662, 2439.1950656283384, 2507.636392723054, 2516.9119080832174, 2156.687280344341, 2371.4664200554907, 2485.254423672891, 2513.0, 2513.1957773512577, 2480.2931164618176, 2516.207394670691, 2518.9874050629815, 2524.1544082732307, 2524.482481091372, 9462.148406643366, 9528.857067143997, 9535.2371810255, 9539.236861051098, 9540.713778586654, 5374.328208973879, 5531.640443371168, 5540.390557038722, 5543.556515478752, 5543.556515478752, 3530.293941211742, 3709.925801483982, 3798.6771124454453, 3814.294355544233, 3827.8660246891227, 1238.523168580094, 1278.8017857232144, 1290.3612711707765, 1302.9087963842535, 1323.6690827293178, 13827.51603693876, 14070.859291407058, 14088.859111408858, 14089.436422543085, 14110.082844615066, 5037.546620804145, 5108.974455127701, 5122.257272695439, 5137.5889928806355, 5190.169572868323, 11780.352080635475, 11827.349495777815, 11828.763424731456, 11848.703782405337, 11848.881511184778, 5522.779088836482, 5531.474509921551, 5538.667679939216, 5539.169124631257, 5540.113581826889, 4400.471943366752, 4885.853424397274, 4965.32968049316, 5004.649674522821, 5121.897562048738, 4332.870013899588, 4429.2913133899065, 4569.885752856205, 4600.148972440109, 4755.83354582588, 1407.6551244945053, 1421.8151640286696, 1422.7581311177125, 1445.595233334668, 1454.2946670864621, 1040.3653771199563, 1042.9634962776267, 1044.603050840691, 1046.5604446132643, 1055.5883205549842, 6351.364863513611, 6369.5222858285815, 6386.393292637192, 6513.0, 6572.901406478906, 1027.5684212630713, 1060.7560261139981, 1064.9520771565299, 1079.400932482464, 1090.0, 4255.192199642993, 4335.067960388468, 4342.761148136819, 4400.383946247528, 4462.397576327155, 12268.44791984363, 12571.497140114294, 12634.178778379375, 12636.684082897817, 12685.0, 12082.0, 12379.876201238052, 12469.812952805714, 12482.001439884787, 12499.187552809039, 8613.440126391639, 9059.229965452878, 9071.455712657262, 9171.220446262143, 9230.123138301851, 6410.749519218724, 6563.278039415756, 6575.835604109936, 6646.202455705346, 6668.266490686117, 11086.390248536409, 11173.385463799568, 11417.942910285396, 11477.36874471912, 11503.712407189887, 11592.130590205938, 11622.0702343814, 11653.359065251154, 11693.766124677288, 11839.526418943145, 7482.326590606872, 8123.79690507742, 8337.791555210926, 8338.541380224146, 8530.10433904456, 9517.095875891779, 9533.570989305359, 9567.9043209567, 9588.808223835624, 9601.951990240004, 7879.487833290817, 8074.757757267292, 8108.108108108221, 8213.219744124299, 8219.547924863951, 7817.140114587277, 7818.804529886798, 8024.077231118263, 8027.357811374959, 8135.674573017013, 7071.646417679199, 7299.781006569811, 7303.30618591233, 7374.04137462148, 7377.299156580117, 5545.528630066489, 5561.026820306511, 5573.832785016456, 5581.079121944996, 5667.20659107717, 5650.350209725934, 5684.175794509691, 5720.3707592165665, 5790.710464476843, 5831.591788574759], "value": 5056.066808186388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.4285771335011, 356.0901895656597, 363.22270341469243, 364.79936035180646, 366.87342866710986, 5149.871253218671, 5235.73821308934, 5266.315379000729, 5310.495502927216, 5348.786048558058, 5320.579136492896, 5333.413324534308, 5345.1982202669615, 5353.841233672142, 5364.329458817648, 4222.788860556975, 4244.172386384656, 4262.211490874198, 4264.573542645726, 4265.189613973351, 4030.5969403059753, 4120.526139493952, 4240.787960601973, 4268.890088576977, 4274.145170965804, 4190.979045104786, 4214.346776249687, 4228.5137209220875, 4229.555896630855, 4243.342281946303, 4189.162167566484, 4224.197402493516, 4226.0, 4227.788610569459, 4235.8093885775215, 3701.9814900925594, 3784.7539909906045, 3799.8290076946605, 3813.199228162089, 3818.198178382543, 5067.949320506821, 5092.5995351278325, 5100.387953445573, 5115.7442127893455, 5125.82059627915, 4800.615950723969, 4801.255805350142, 4808.2547205183255, 4815.735134567597, 4819.95180048202, 5397.62216644835, 5532.944670553283, 5608.158776183564, 5618.213450116987, 5648.661080335152, 4110.77390743509, 4111.732737372061, 4113.794310284474, 4124.505059392862, 4133.297339452301, 5773.740181691834, 5787.88424231513, 5802.4197580241635, 5808.506276966463, 5819.098039803837, 3958.5843486434087, 4085.835536871977, 4124.958750412457, 4125.66994640428, 4131.607497287753, 4174.144300418407, 4191.559886211965, 4191.601797829201, 4192.0, 4199.874003779892, 4762.14281429346, 4767.903382222108, 4792.849716068188, 4795.544423279783, 4798.712077275374, 5547.972260138754, 5559.0, 5615.241942337814, 5631.63394379364, 5689.317281926195, 1386.1682990205998, 1419.865112814281, 1424.2736204535554, 1427.2435609127178, 1430.577979496051, 927.6474939522938, 937.9437233765859, 939.0703203828298, 944.2540393089382, 944.527736131934, 4798.376211092605, 4899.828506002273, 4947.579455746302, 4968.726720030433, 4996.4503904570465, 5094.6688465249645, 5096.337476128079, 5103.668261562986, 5169.147090729987, 5169.7932082717025, 4805.645233835396, 4805.957468076053, 4839.661223714306, 4847.80608775645, 4852.908095678515, 2617.6204450354594, 2620.253227830059, 2685.6911455182903, 2687.7177896320995, 2729.894392770931, 5133.537981581676, 5151.5363617274625, 5159.561437277874, 5186.533212010937, 5200.245964335226, 5098.2352647103235, 5115.437301896788, 5135.998480296306, 5170.250313704491, 5179.22311653255, 5131.7434128293435, 5182.637215394886, 5198.584113270929, 5418.539424148991, 5886.409979608959, 5698.1737648041635, 5727.770889164387, 5750.223719797941, 5754.4533269339345, 5764.596478246483, 5682.232898558642, 5686.829395118153, 5706.946783470823, 5711.400302968129, 5728.3412407572, 5722.685252311163, 5830.0355758083215, 5842.620229685057, 5847.561432892465, 5859.355470898283, 4052.858149964737, 4054.6350828425584, 4078.816453259551, 4091.9386209207482, 4096.283150448719, 5562.777488900399, 5686.886262274814, 5720.227769251264, 5720.856978575569, 5730.796532728174, 5356.625036247581, 5617.915731264116, 5634.464490978994, 5639.154126881001, 5641.435856414326, 5387.976284505931, 5408.593765620888, 5426.18607208906, 5500.367457742411, 5513.421090785409, 5469.179623056573, 5523.4200408956485, 5530.668159910419, 5538.0, 5548.528375088163, 5416.620836541404, 5567.916481252865, 5622.2128901954575, 5627.240322556566, 5649.293838270216, 5442.891142177214, 5479.808206712746, 5518.448155184449, 5524.33707955048, 5532.336119665666], "value": 4191.834596285204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.5665544018148, 716.0154787167645, 731.7146312937952, 733.2154594583798, 754.1515794730927, 14437.855621443783, 14957.626059348522, 15192.848071519282, 15235.0, 15237.390504379839, 14290.356933937972, 14318.785218221736, 14320.355583998718, 14338.641533961656, 14429.206393648345, 722.6964674836555, 853.2278288149204, 879.463527248378, 881.6473410635733, 898.5282726568571, 865.5412631305387, 869.4522450855984, 871.5511511571545, 872.1278721278721, 872.3413822563987, 925.2875286029753, 925.4077390470071, 926.3098991251493, 926.666400095965, 926.7775733823868, 763.6334559411486, 908.6274627402767, 918.5499105438354, 934.700895713372, 936.0358830404695, 690.2131570010192, 690.3200347657604, 690.6684791300154, 690.8894576867677, 691.1222747111141, 14512.782308265385, 14519.346629401702, 14551.78172327416, 14552.417903283857, 14561.49034783788, 13804.516841910585, 14241.572752817432, 14276.571702848827, 14305.642358941006, 14444.350004249729, 12815.807762883564, 13053.216806991612, 13173.0, 13181.209127452288, 13191.2744799036, 4578.427696537933, 4632.837850675211, 4636.44362676481, 4654.697444666086, 4685.718856868599, 73359.0, 74850.62574687092, 74854.25145748582, 76037.61981190114, 76254.0, 11660.941695291638, 11765.0, 11800.822987655192, 11847.76304473923, 12052.035837133008, 20344.18623255083, 20412.0, 20420.0, 20447.693284600744, 20488.487787805127, 7810.336121429628, 7818.765437036898, 7820.491668041559, 7888.32949199313, 8099.352051835839, 4881.829135980223, 4928.211486162197, 4959.925601115986, 5104.9744751276, 5158.0, 3414.3342048300838, 3488.0059183133194, 3514.139035936212, 3514.5606799150105, 3515.050936247199, 572.2903599536545, 599.4724642314735, 630.4263120560269, 653.4413076819346, 654.4142992022208, 648.4747354642755, 801.1147681811515, 811.3265989228926, 816.1104396208161, 819.2954059508818, 9366.90633093674, 9528.19010384125, 9591.280653950982, 9838.606455741834, 9888.258380621339, 706.1667232665504, 744.988825167623, 769.6228847864506, 783.0698319869113, 799.7161007842133, 4922.852314430573, 5048.242763585492, 5213.947860521346, 5221.086309895753, 5266.183741520071, 95840.52079739557, 105655.0, 129904.0, 132873.0, 135777.0, 97398.0, 97733.0, 98426.5078674602, 99050.0, 99864.5006774976, 84733.0, 85300.14699852922, 86253.0, 86443.56778216195, 86628.70056949151, 9513.620525023694, 9534.380265282734, 9726.943743831594, 9841.163501102486, 9881.407115573089, 51683.48316516937, 52020.0, 52638.473615263356, 52777.0, 54055.72972135114, 67466.32533674796, 75215.62392188005, 76678.6166069166, 77999.61000194962, 79989.0, 12436.751264974831, 12908.419121139383, 13133.868661313647, 13238.205707657571, 13305.401256943655, 14287.499937502138, 14541.400445950725, 14627.561173164822, 14823.629409264855, 14840.703185936436, 13806.0, 13894.444222231401, 14147.221902795445, 14179.64550886236, 14284.214368209849, 13739.175649461064, 13987.300634968007, 14100.717985640435, 14227.857721423068, 14229.217393043482, 13004.8049279259, 13175.934120329337, 13310.600681979557, 13450.394732236877, 13586.38861251266, 11508.0, 11715.765684686428, 11981.880181198076, 11987.400629968291, 12119.0, 11324.943375283401, 11473.311601303949, 11656.53373865036, 11802.468888899848, 12008.699782505508], "value": 7749.121857530336, "unit": "score"}], "name": "dromaeo_css", "value": 7419.263906560461, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 125.0, 175.0, 125.0, 131.0, 152.0, 121.0, 152.0, 124.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 163.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 129.0, 74.0, 76.0, 76.0, 75.0, 116.0, 76.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 85.0, 85.0, 84.0, 113.0, 85.0, 86.0, 133.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 123.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 52.0, 51.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 82.0, 81.0, 81.0, 77.0, 77.0, 108.0, 77.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 115.0, 117.0, 115.0, 116.0, 116.0, 121.0, 129.0, 120.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 156.0, 152.0, 152.0, 158.0, 154.0, 158.0, 151.0, 153.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 61.0, 63.0, 60.0, 61.0, 62.0, 61.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1473.2, "alertThreshold": 2.0}]} 01:36:34 INFO - Return code: 0 01:36:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:36:35 ERROR - # TBPL SUCCESS # 01:36:35 INFO - Running post-action listener: _resource_record_post_action 01:36:35 INFO - ##### 01:36:35 INFO - ##### Finished run-tests step (success) 01:36:35 INFO - ##### 01:36:35 INFO - Running post-run listener: _resource_record_post_run 01:36:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504881152; Read time: 8; Write time: 404788 01:36:35 INFO - TinderboxPrint: CPU usage
13.1% 01:36:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:36:35 INFO - TinderboxPrint: I/O write bytes / time
504,881,152 / 404,788 01:36:35 INFO - TinderboxPrint: CPU idle
8,246.5 (86.9%) 01:36:35 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 01:36:35 INFO - TinderboxPrint: Swap in / out
0 / 0 01:36:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252645376; Read time: 0; Write time: 284140 01:36:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252235776; Read time: 8; Write time: 120648 01:36:35 INFO - Running post-run listener: _upload_blobber_files 01:36:35 INFO - Blob upload gear active. 01:36:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:36:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:36:36 INFO - (blobuploader) - INFO - Open directory for files ... 01:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:36:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:36 INFO - (blobuploader) - INFO - Done attempting. 01:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:46 INFO - (blobuploader) - INFO - Done attempting. 01:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:36:46 INFO - (blobuploader) - INFO - Done attempting. 01:36:46 INFO - (blobuploader) - INFO - Iteration through files over. 01:36:46 INFO - Return code: 0 01:36:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:36:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:36:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ba8a8dadee3af0a9ccf0fd225d0953ec2a1b8dbebb59571ba3163346bf9e2cdafa97956c23d2dfa747165b66aab453a4406da0ee49e416620045ffcd93f7908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7f87fca4c991bc4dfba5e236c6c268974db2682197c6ec817b19380b52d41ad963ba9a0dc2f411dcc99711b7e98c4c760eb3b9daf23447162d559e1cb30adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01e97544e249beb442512dc3395e1254f472bd8fc9ce957e25bd408e364c5eb11dce7d83df723f9186fd23450e41010f635b090d6a2cb97b70e86bfc9558d5d"} 01:36:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:36:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:36:46 INFO - Contents: 01:36:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ba8a8dadee3af0a9ccf0fd225d0953ec2a1b8dbebb59571ba3163346bf9e2cdafa97956c23d2dfa747165b66aab453a4406da0ee49e416620045ffcd93f7908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7f87fca4c991bc4dfba5e236c6c268974db2682197c6ec817b19380b52d41ad963ba9a0dc2f411dcc99711b7e98c4c760eb3b9daf23447162d559e1cb30adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01e97544e249beb442512dc3395e1254f472bd8fc9ce957e25bd408e364c5eb11dce7d83df723f9186fd23450e41010f635b090d6a2cb97b70e86bfc9558d5d"} 01:36:46 INFO - Running post-run listener: copy_logs_to_upload_dir 01:36:46 INFO - Copying logs to upload dir... 01:36:46 INFO - mkdir: /builds/slave/test/build/upload/logs 01:36:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.965768 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-28 01:36:46.210478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 01:36:46.213768) ========= 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=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ba8a8dadee3af0a9ccf0fd225d0953ec2a1b8dbebb59571ba3163346bf9e2cdafa97956c23d2dfa747165b66aab453a4406da0ee49e416620045ffcd93f7908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7f87fca4c991bc4dfba5e236c6c268974db2682197c6ec817b19380b52d41ad963ba9a0dc2f411dcc99711b7e98c4c760eb3b9daf23447162d559e1cb30adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01e97544e249beb442512dc3395e1254f472bd8fc9ce957e25bd408e364c5eb11dce7d83df723f9186fd23450e41010f635b090d6a2cb97b70e86bfc9558d5d"} build_url:https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/LctPLALYSb2g_S5xwzl4qw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8ba8a8dadee3af0a9ccf0fd225d0953ec2a1b8dbebb59571ba3163346bf9e2cdafa97956c23d2dfa747165b66aab453a4406da0ee49e416620045ffcd93f7908", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7f87fca4c991bc4dfba5e236c6c268974db2682197c6ec817b19380b52d41ad963ba9a0dc2f411dcc99711b7e98c4c760eb3b9daf23447162d559e1cb30adc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e01e97544e249beb442512dc3395e1254f472bd8fc9ce957e25bd408e364c5eb11dce7d83df723f9186fd23450e41010f635b090d6a2cb97b70e86bfc9558d5d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 01:36:46.239915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:36:46.240264) ========= 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=232498196343f89f466a4a9a000001c8-1469693130.378298-1696719813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 01:36:46.323925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 01:36:46.324393) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 01:36:46.324915) ========= ========= Total master_lag: 0.17 =========