builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1469821078.34 results: success (0) buildid: 20160729120725 builduid: 4a997451ee2744b494d635adfefa9b6a revision: cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.343632) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.344044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.344330) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.364155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.364446) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 12:37: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% 112M=0s 2016-07-29 12:37:59 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.404951 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.838180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.838873) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018800 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.870882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:58.874239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 --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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 12:37:59,205 truncating revision to first 12 chars 2016-07-29 12:37:59,205 Setting DEBUG logging. 2016-07-29 12:37:59,205 attempt 1/10 2016-07-29 12:37:59,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb8fe696526c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 12:37:59,512 unpacking tar archive at: fx-team-cb8fe696526c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:59.513846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:59.514459) ========= script_repo_revision: cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:59.515403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:59.515992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 12:37:59.527789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-29 12:37:59.528091) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:37:59 INFO - MultiFileLogger online at 20160729 12:37:59 in /builds/slave/test 12:37:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:37:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:37:59 INFO - {'append_to_log': False, 12:37:59 INFO - 'base_work_dir': '/builds/slave/test', 12:37:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:37:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:37:59 INFO - 'branch': 'Fx-Team-Non-PGO', 12:37:59 INFO - 'buildbot_json_path': 'buildprops.json', 12:37:59 INFO - 'config_files': ('talos/linux_config.py',), 12:37:59 INFO - 'default_actions': ('clobber', 12:37:59 INFO - 'read-buildbot-config', 12:37:59 INFO - 'download-and-extract', 12:37:59 INFO - 'populate-webroot', 12:37:59 INFO - 'create-virtualenv', 12:37:59 INFO - 'install', 12:37:59 INFO - 'run-tests'), 12:37:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:37:59 INFO - 'download_minidump_stackwalk': True, 12:37:59 INFO - 'download_symbols': 'ondemand', 12:37:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:37:59 INFO - 'tooltool.py': '/tools/tooltool.py', 12:37:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:37:59 INFO - '/tools/misc-python/virtualenv.py')}, 12:37:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:37:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:37:59 INFO - 'installer_path': 'installer.exe', 12:37:59 INFO - 'log_level': 'info', 12:37:59 INFO - 'log_name': 'talos', 12:37:59 INFO - 'log_to_console': True, 12:37:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:37:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:37:59 INFO - 'opt_config_files': (), 12:37:59 INFO - 'pip_index': False, 12:37:59 INFO - 'sps_profile': False, 12:37:59 INFO - 'sps_profile_interval': 0, 12:37:59 INFO - 'suite': 'dromaeojs', 12:37:59 INFO - 'system_bits': '32', 12:37:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:37:59 INFO - 'title': 'talos-linux64-ix-040', 12:37:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:37:59 INFO - 'use_talos_json': True, 12:37:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:37:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:37:59 INFO - 'work_dir': 'build'} 12:37:59 INFO - [mozharness: 2016-07-29 19:37:59.946894Z] Running clobber step. 12:37:59 INFO - Running pre-action listener: _resource_record_pre_action 12:37:59 INFO - Running main action method: clobber 12:37:59 INFO - rmtree: /builds/slave/test/build 12:37:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:38:00 INFO - Running post-action listener: _resource_record_post_action 12:38:00 INFO - [mozharness: 2016-07-29 19:38:00.946395Z] Finished clobber step (success) 12:38:00 INFO - [mozharness: 2016-07-29 19:38:00.946497Z] Running read-buildbot-config step. 12:38:00 INFO - Running pre-action listener: _resource_record_pre_action 12:38:00 INFO - Running main action method: read_buildbot_config 12:38:00 INFO - Using buildbot properties: 12:38:00 INFO - { 12:38:00 INFO - "project": "", 12:38:00 INFO - "product": "firefox", 12:38:00 INFO - "script_repo_revision": "production", 12:38:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:38:00 INFO - "repository": "", 12:38:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:38:00 INFO - "buildid": "20160729120725", 12:38:00 INFO - "pgo_build": "False", 12:38:00 INFO - "basedir": "/builds/slave/test", 12:38:00 INFO - "buildnumber": 2043, 12:38:00 INFO - "slavename": "talos-linux64-ix-040", 12:38:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:38:00 INFO - "platform": "ubuntu64_hw", 12:38:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:38:00 INFO - "branch": "fx-team", 12:38:00 INFO - "repo_path": "integration/fx-team", 12:38:00 INFO - "revision": "cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145", 12:38:00 INFO - "stage_platform": "linux64", 12:38:00 INFO - "builduid": "4a997451ee2744b494d635adfefa9b6a", 12:38:00 INFO - "slavebuilddir": "test" 12:38:00 INFO - } 12:38:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:38:00 INFO - Running post-action listener: _resource_record_post_action 12:38:00 INFO - [mozharness: 2016-07-29 19:38:00.949257Z] Finished read-buildbot-config step (success) 12:38:00 INFO - [mozharness: 2016-07-29 19:38:00.949345Z] Running download-and-extract step. 12:38:00 INFO - Running pre-action listener: _resource_record_pre_action 12:38:00 INFO - Running main action method: download_and_extract 12:38:00 INFO - mkdir: /builds/slave/test/build/tests 12:38: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')]} 12:38:00 INFO - https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:38:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:38:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:38:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:38:02 INFO - Downloaded 1361 bytes. 12:38:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:38:02 INFO - Using the following test package requirements: 12:38:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:38:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:38:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'jsshell-linux-x86_64.zip'], 12:38:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:38:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:38:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:38:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:38:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:38:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:38:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:38:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:38:02 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')]} 12:38:02 INFO - https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:38:07 INFO - Downloaded 22758364 bytes. 12:38:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:38:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:38:08 INFO - Return code: 0 12:38:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:38: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')]} 12:38:08 INFO - https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:38:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:38:09 INFO - Downloaded 22758364 bytes. 12:38:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:38:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:38:11 INFO - Return code: 0 12:38:11 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')]} 12:38:11 INFO - https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:38:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:38:12 INFO - Downloaded 14413725 bytes. 12:38:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:38:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:38:12 INFO - Return code: 0 12:38: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')]} 12:38:12 INFO - https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:38:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:38:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:38:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:38:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:38:13 INFO - Downloaded 57172390 bytes. 12:38:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:38:13 INFO - mkdir: /builds/slave/test/properties 12:38:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:38:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:38:13 INFO - Contents: 12:38:13 INFO - build_url:https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:38:14 INFO - Running post-action listener: _resource_record_post_action 12:38:14 INFO - Running post-action listener: set_extra_try_arguments 12:38:14 INFO - [mozharness: 2016-07-29 19:38:14.621856Z] Finished download-and-extract step (success) 12:38:14 INFO - [mozharness: 2016-07-29 19:38:14.622090Z] Running populate-webroot step. 12:38:14 INFO - Running pre-action listener: _resource_record_pre_action 12:38:14 INFO - Running main action method: populate_webroot 12:38:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:38:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:38:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:38:14 INFO - '--tppagecycles', 12:38:14 INFO - '7'], 12:38:14 INFO - 'tests': ['tsvgm']}}, 12:38:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:38:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:38:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:38:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:38:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['damp', 'tps']}, 12:38:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'tests': ['damp', 'tps']}, 12:38:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['dromaeo_dom']}, 12:38:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:38:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['basic_compositor_video']}, 12:38:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:38:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'other-e10s': {'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['a11yr', 12:38:14 INFO - 'ts_paint', 12:38:14 INFO - 'tpaint', 12:38:14 INFO - 'sessionrestore', 12:38:14 INFO - 'sessionrestore_no_auto_restore', 12:38:14 INFO - 'tabpaint']}, 12:38:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['tsvgx', 12:38:14 INFO - 'tsvgr_opacity', 12:38:14 INFO - 'tart', 12:38:14 INFO - 'tscrollx', 12:38:14 INFO - 'cart']}, 12:38:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:38:14 INFO - 'tsvgr_opacity', 12:38:14 INFO - 'tart', 12:38:14 INFO - 'tscrollx', 12:38:14 INFO - 'cart']}, 12:38:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'talos_options': ['--disable-e10s'], 12:38:14 INFO - 'tests': ['tp5o']}, 12:38:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'tests': ['tp5o']}, 12:38:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'talos_options': ['--disable-e10s', 12:38:14 INFO - '--xperf_path', 12:38:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:14 INFO - 'tests': ['tp5n']}, 12:38:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:14 INFO - 'talos_options': ['--xperf_path', 12:38:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:14 INFO - 'tests': ['tp5n']}}, 12:38:14 INFO - 'talos.zip': {'path': '', 12:38:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:14 INFO - Running post-action listener: _resource_record_post_action 12:38:14 INFO - [mozharness: 2016-07-29 19:38:14.638564Z] Finished populate-webroot step (success) 12:38:14 INFO - [mozharness: 2016-07-29 19:38:14.638653Z] Running create-virtualenv step. 12:38:14 INFO - Running pre-action listener: _resource_record_pre_action 12:38:14 INFO - Running main action method: create_virtualenv 12:38:14 INFO - Creating virtualenv /builds/slave/test/build/venv 12:38:14 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 12:38:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:38:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:38:14 INFO - Using real prefix '/usr' 12:38:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:38:15 INFO - Installing distribute.............................................................................................................................................................................................done. 12:38:17 INFO - Installing pip.................done. 12:38:17 INFO - Return code: 0 12:38:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:17 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:17 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 12:38:17 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 12:38:17 INFO - Using env: {'DISPLAY': ':0', 12:38:17 INFO - 'HOME': '/home/cltbld', 12:38:17 INFO - 'LANG': 'en_US.UTF-8', 12:38:17 INFO - 'LANGUAGE': 'en_US:en', 12:38:17 INFO - 'LOGNAME': 'cltbld', 12:38:17 INFO - 'MAIL': '/var/mail/cltbld', 12:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:17 INFO - 'MOZ_NO_REMOTE': '1', 12:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:17 INFO - 'NO_EM_RESTART': '1', 12:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:17 INFO - 'PWD': '/builds/slave/test', 12:38:17 INFO - 'SHELL': '/bin/bash', 12:38:17 INFO - 'SHLVL': '1', 12:38:17 INFO - 'TERM': 'linux', 12:38:17 INFO - 'TMOUT': '86400', 12:38:17 INFO - 'USER': 'cltbld', 12:38:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:17 INFO - '_': '/tools/buildbot/bin/python'} 12:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:17 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 12:38:17 INFO - Cleaning up... 12:38:17 INFO - Return code: 0 12:38:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:17 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:17 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 12:38:17 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 12:38:17 INFO - Using env: {'DISPLAY': ':0', 12:38:17 INFO - 'HOME': '/home/cltbld', 12:38:17 INFO - 'LANG': 'en_US.UTF-8', 12:38:17 INFO - 'LANGUAGE': 'en_US:en', 12:38:17 INFO - 'LOGNAME': 'cltbld', 12:38:17 INFO - 'MAIL': '/var/mail/cltbld', 12:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:17 INFO - 'MOZ_NO_REMOTE': '1', 12:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:17 INFO - 'NO_EM_RESTART': '1', 12:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:17 INFO - 'PWD': '/builds/slave/test', 12:38:17 INFO - 'SHELL': '/bin/bash', 12:38:17 INFO - 'SHLVL': '1', 12:38:17 INFO - 'TERM': 'linux', 12:38:17 INFO - 'TMOUT': '86400', 12:38:17 INFO - 'USER': 'cltbld', 12:38:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:17 INFO - '_': '/tools/buildbot/bin/python'} 12:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:17 INFO - Downloading/unpacking psutil>=3.1.1 12:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:38:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:19 INFO - Installing collected packages: psutil 12:38:19 INFO - Running setup.py install for psutil 12:38:19 INFO - building 'psutil._psutil_linux' extension 12:38:19 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 12:38:19 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 12:38:19 INFO - building 'psutil._psutil_posix' extension 12:38:19 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 12:38:20 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 12:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:38:20 INFO - Successfully installed psutil 12:38:20 INFO - Cleaning up... 12:38:20 INFO - Return code: 0 12:38:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:38:20 INFO - Using env: {'DISPLAY': ':0', 12:38:20 INFO - 'HOME': '/home/cltbld', 12:38:20 INFO - 'LANG': 'en_US.UTF-8', 12:38:20 INFO - 'LANGUAGE': 'en_US:en', 12:38:20 INFO - 'LOGNAME': 'cltbld', 12:38:20 INFO - 'MAIL': '/var/mail/cltbld', 12:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:20 INFO - 'MOZ_NO_REMOTE': '1', 12:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:20 INFO - 'NO_EM_RESTART': '1', 12:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:20 INFO - 'PWD': '/builds/slave/test', 12:38:20 INFO - 'SHELL': '/bin/bash', 12:38:20 INFO - 'SHLVL': '1', 12:38:20 INFO - 'TERM': 'linux', 12:38:20 INFO - 'TMOUT': '86400', 12:38:20 INFO - 'USER': 'cltbld', 12:38:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:20 INFO - '_': '/tools/buildbot/bin/python'} 12:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:38:22 INFO - Installing collected packages: mozsystemmonitor 12:38:22 INFO - Running setup.py install for mozsystemmonitor 12:38:22 INFO - Successfully installed mozsystemmonitor 12:38:22 INFO - Cleaning up... 12:38:22 INFO - Return code: 0 12:38:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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', '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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:38: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 jsonschema==2.5.1 12:38:22 INFO - Using env: {'DISPLAY': ':0', 12:38:22 INFO - 'HOME': '/home/cltbld', 12:38:22 INFO - 'LANG': 'en_US.UTF-8', 12:38:22 INFO - 'LANGUAGE': 'en_US:en', 12:38:22 INFO - 'LOGNAME': 'cltbld', 12:38:22 INFO - 'MAIL': '/var/mail/cltbld', 12:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:22 INFO - 'MOZ_NO_REMOTE': '1', 12:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:22 INFO - 'NO_EM_RESTART': '1', 12:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:22 INFO - 'PWD': '/builds/slave/test', 12:38:22 INFO - 'SHELL': '/bin/bash', 12:38:22 INFO - 'SHLVL': '1', 12:38:22 INFO - 'TERM': 'linux', 12:38:22 INFO - 'TMOUT': '86400', 12:38:22 INFO - 'USER': 'cltbld', 12:38:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:22 INFO - '_': '/tools/buildbot/bin/python'} 12:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:22 INFO - Downloading/unpacking jsonschema==2.5.1 12:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:38:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:38:24 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 12:38:24 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 12:38:24 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 12:38:24 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 12:38:24 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 12:38:24 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 12:38:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:38:24 INFO - warning: no files found matching '*.txt' 12:38:24 INFO - no previously-included directories found matching 'build' 12:38:24 INFO - no previously-included directories found matching 'dist' 12:38:24 INFO - no previously-included directories found matching '.git*' 12:38:24 INFO - Installing collected packages: jsonschema, functools32 12:38:24 INFO - Running setup.py install for functools32 12:38:25 INFO - warning: no files found matching '*.txt' 12:38:25 INFO - no previously-included directories found matching 'build' 12:38:25 INFO - no previously-included directories found matching 'dist' 12:38:25 INFO - no previously-included directories found matching '.git*' 12:38:25 INFO - Successfully installed jsonschema functools32 12:38:25 INFO - Cleaning up... 12:38:25 INFO - Return code: 0 12:38:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:38: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 functools32==3.2.3-2 12:38:25 INFO - Using env: {'DISPLAY': ':0', 12:38:25 INFO - 'HOME': '/home/cltbld', 12:38:25 INFO - 'LANG': 'en_US.UTF-8', 12:38:25 INFO - 'LANGUAGE': 'en_US:en', 12:38:25 INFO - 'LOGNAME': 'cltbld', 12:38:25 INFO - 'MAIL': '/var/mail/cltbld', 12:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:25 INFO - 'MOZ_NO_REMOTE': '1', 12:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:25 INFO - 'NO_EM_RESTART': '1', 12:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:25 INFO - 'PWD': '/builds/slave/test', 12:38:25 INFO - 'SHELL': '/bin/bash', 12:38:25 INFO - 'SHLVL': '1', 12:38:25 INFO - 'TERM': 'linux', 12:38:25 INFO - 'TMOUT': '86400', 12:38:25 INFO - 'USER': 'cltbld', 12:38:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:25 INFO - '_': '/tools/buildbot/bin/python'} 12:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:38:25 INFO - Cleaning up... 12:38:25 INFO - Return code: 0 12:38:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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', '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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:38: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 blobuploader==1.2.4 12:38:25 INFO - Using env: {'DISPLAY': ':0', 12:38:25 INFO - 'HOME': '/home/cltbld', 12:38:25 INFO - 'LANG': 'en_US.UTF-8', 12:38:25 INFO - 'LANGUAGE': 'en_US:en', 12:38:25 INFO - 'LOGNAME': 'cltbld', 12:38:25 INFO - 'MAIL': '/var/mail/cltbld', 12:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:25 INFO - 'MOZ_NO_REMOTE': '1', 12:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:25 INFO - 'NO_EM_RESTART': '1', 12:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:25 INFO - 'PWD': '/builds/slave/test', 12:38:25 INFO - 'SHELL': '/bin/bash', 12:38:25 INFO - 'SHLVL': '1', 12:38:25 INFO - 'TERM': 'linux', 12:38:25 INFO - 'TMOUT': '86400', 12:38:25 INFO - 'USER': 'cltbld', 12:38:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:25 INFO - '_': '/tools/buildbot/bin/python'} 12:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:38:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:38:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:38:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:27 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 12:38:28 INFO - Downloading docopt-0.6.1.tar.gz 12:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:38:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:38:28 INFO - Running setup.py install for blobuploader 12:38:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:38:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:38:28 INFO - Running setup.py install for requests 12:38:28 INFO - Running setup.py install for docopt 12:38:28 INFO - Successfully installed blobuploader requests docopt 12:38:28 INFO - Cleaning up... 12:38:28 INFO - Return code: 0 12:38:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:38: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')]} 12:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38: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')]} 12:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:28 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:28 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 12:38:28 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 12:38:28 INFO - Using env: {'DISPLAY': ':0', 12:38:28 INFO - 'HOME': '/home/cltbld', 12:38:28 INFO - 'LANG': 'en_US.UTF-8', 12:38:28 INFO - 'LANGUAGE': 'en_US:en', 12:38:28 INFO - 'LOGNAME': 'cltbld', 12:38:28 INFO - 'MAIL': '/var/mail/cltbld', 12:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:28 INFO - 'MOZ_NO_REMOTE': '1', 12:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:28 INFO - 'NO_EM_RESTART': '1', 12:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:28 INFO - 'PWD': '/builds/slave/test', 12:38:28 INFO - 'SHELL': '/bin/bash', 12:38:28 INFO - 'SHLVL': '1', 12:38:28 INFO - 'TERM': 'linux', 12:38:28 INFO - 'TMOUT': '86400', 12:38:28 INFO - 'USER': 'cltbld', 12:38:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:28 INFO - '_': '/tools/buildbot/bin/python'} 12:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:38:29 INFO - Running setup.py (path:/tmp/pip-SpHYPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:38:29 INFO - Running setup.py (path:/tmp/pip-rkCxCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:38:29 INFO - Running setup.py (path:/tmp/pip-nFNg3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:38:29 INFO - Running setup.py (path:/tmp/pip-S1viP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:38:29 INFO - Running setup.py (path:/tmp/pip-aJupgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:38:29 INFO - Running setup.py (path:/tmp/pip-qGfttx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:38:29 INFO - Running setup.py (path:/tmp/pip-VeeUNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:38:29 INFO - Running setup.py (path:/tmp/pip-smQjer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:38:29 INFO - Running setup.py (path:/tmp/pip-HiiRXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:38:29 INFO - Running setup.py (path:/tmp/pip-ml6zuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:38:29 INFO - Running setup.py (path:/tmp/pip-7yaLWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:38:29 INFO - Running setup.py (path:/tmp/pip-obou78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:38:29 INFO - Running setup.py (path:/tmp/pip-wzjDEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:38:30 INFO - Running setup.py (path:/tmp/pip-MbgM0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:30 INFO - Running setup.py (path:/tmp/pip-omIECZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:38:30 INFO - Running setup.py (path:/tmp/pip-EwJBkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:38:30 INFO - Running setup.py (path:/tmp/pip-VOihEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:38:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:38:30 INFO - Running setup.py install for manifestparser 12:38:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:38:30 INFO - Running setup.py install for mozcrash 12:38:30 INFO - Running setup.py install for mozdebug 12:38:30 INFO - Running setup.py install for mozdevice 12:38:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:38:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:38:30 INFO - Running setup.py install for mozfile 12:38:30 INFO - Running setup.py install for mozhttpd 12:38:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:38:30 INFO - Running setup.py install for mozinfo 12:38:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for mozInstall 12:38:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for mozleak 12:38:31 INFO - Running setup.py install for mozlog 12:38:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for moznetwork 12:38:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for mozprocess 12:38:31 INFO - Running setup.py install for mozprofile 12:38:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for mozrunner 12:38:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:38:31 INFO - Running setup.py install for mozscreenshot 12:38:31 INFO - Running setup.py install for moztest 12:38:31 INFO - Running setup.py install for mozversion 12:38:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:38:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:38:32 INFO - Cleaning up... 12:38:32 INFO - Return code: 0 12:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:38:32 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')]} 12:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:32 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')]} 12:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:32 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:32 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 12:38:32 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 12:38:32 INFO - Using env: {'DISPLAY': ':0', 12:38:32 INFO - 'HOME': '/home/cltbld', 12:38:32 INFO - 'LANG': 'en_US.UTF-8', 12:38:32 INFO - 'LANGUAGE': 'en_US:en', 12:38:32 INFO - 'LOGNAME': 'cltbld', 12:38:32 INFO - 'MAIL': '/var/mail/cltbld', 12:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:32 INFO - 'MOZ_NO_REMOTE': '1', 12:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:32 INFO - 'NO_EM_RESTART': '1', 12:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:32 INFO - 'PWD': '/builds/slave/test', 12:38:32 INFO - 'SHELL': '/bin/bash', 12:38:32 INFO - 'SHLVL': '1', 12:38:32 INFO - 'TERM': 'linux', 12:38:32 INFO - 'TMOUT': '86400', 12:38:32 INFO - 'USER': 'cltbld', 12:38:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:32 INFO - '_': '/tools/buildbot/bin/python'} 12:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:38:32 INFO - Running setup.py (path:/tmp/pip-3pGO1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:38:32 INFO - Running setup.py (path:/tmp/pip-vQgnXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:38:32 INFO - Running setup.py (path:/tmp/pip-k5O6jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:38:32 INFO - Running setup.py (path:/tmp/pip-_nY89B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:38:32 INFO - Running setup.py (path:/tmp/pip-pXHLvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:38:32 INFO - Running setup.py (path:/tmp/pip-c8aT0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:38:32 INFO - Running setup.py (path:/tmp/pip-pTmY6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:38:32 INFO - Running setup.py (path:/tmp/pip-LBdAIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:38:32 INFO - Running setup.py (path:/tmp/pip-SoztO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:38:32 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)) 12:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:38:32 INFO - Running setup.py (path:/tmp/pip-fNT3uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:38:33 INFO - Running setup.py (path:/tmp/pip-43xrH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:38:33 INFO - Running setup.py (path:/tmp/pip-pfUdH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:38:33 INFO - Running setup.py (path:/tmp/pip-sRueAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:38:33 INFO - Running setup.py (path:/tmp/pip-dCBqS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:33 INFO - Running setup.py (path:/tmp/pip-twgFzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:38:33 INFO - Running setup.py (path:/tmp/pip-bHdmJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:38:33 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)) 12:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:38:33 INFO - Running setup.py (path:/tmp/pip-TtOW66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:38:33 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)) 12:38:33 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)) 12:38:33 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)) 12:38:33 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)) 12:38:33 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)) 12:38:33 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)) 12:38:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38: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 12:38:35 INFO - Downloading blessings-1.6.tar.gz 12:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:38:35 INFO - Installing collected packages: blessings 12:38:35 INFO - Running setup.py install for blessings 12:38:35 INFO - Successfully installed blessings 12:38:35 INFO - Cleaning up... 12:38:35 INFO - Return code: 0 12:38:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:38:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:38:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:38:35 INFO - Reading from file tmpfile_stdout 12:38:35 INFO - Current package versions: 12:38:35 INFO - argparse == 1.2.1 12:38:35 INFO - blessings == 1.6 12:38:35 INFO - blobuploader == 1.2.4 12:38:35 INFO - docopt == 0.6.1 12:38:35 INFO - functools32 == 3.2.3-2 12:38:35 INFO - jsonschema == 2.5.1 12:38:35 INFO - manifestparser == 1.1 12:38:35 INFO - mozInstall == 1.12 12:38:35 INFO - mozcrash == 0.17 12:38:35 INFO - mozdebug == 0.1 12:38:35 INFO - mozdevice == 0.48 12:38:35 INFO - mozfile == 1.2 12:38:35 INFO - mozhttpd == 0.7 12:38:35 INFO - mozinfo == 0.9 12:38:35 INFO - mozleak == 0.1 12:38:35 INFO - mozlog == 3.3 12:38:35 INFO - moznetwork == 0.27 12:38:35 INFO - mozprocess == 0.23 12:38:35 INFO - mozprofile == 0.28 12:38:35 INFO - mozrunner == 6.12 12:38:35 INFO - mozscreenshot == 0.1 12:38:35 INFO - mozsystemmonitor == 0.3 12:38:35 INFO - moztest == 0.7 12:38:35 INFO - mozversion == 1.4 12:38:35 INFO - psutil == 3.1.1 12:38:35 INFO - requests == 1.2.3 12:38:35 INFO - wsgiref == 0.1.2 12:38:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:38:35 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')]} 12:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:35 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')]} 12:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:35 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 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:35 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 12:38:35 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 12:38:35 INFO - Using env: {'DISPLAY': ':0', 12:38:35 INFO - 'HOME': '/home/cltbld', 12:38:35 INFO - 'LANG': 'en_US.UTF-8', 12:38:35 INFO - 'LANGUAGE': 'en_US:en', 12:38:35 INFO - 'LOGNAME': 'cltbld', 12:38:35 INFO - 'MAIL': '/var/mail/cltbld', 12:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:35 INFO - 'MOZ_NO_REMOTE': '1', 12:38:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:35 INFO - 'NO_EM_RESTART': '1', 12:38:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:35 INFO - 'PWD': '/builds/slave/test', 12:38:35 INFO - 'SHELL': '/bin/bash', 12:38:35 INFO - 'SHLVL': '1', 12:38:35 INFO - 'TERM': 'linux', 12:38:35 INFO - 'TMOUT': '86400', 12:38:35 INFO - 'USER': 'cltbld', 12:38:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:35 INFO - '_': '/tools/buildbot/bin/python'} 12:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 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)) 12:38:36 INFO - Cleaning up... 12:38:36 INFO - Return code: 0 12:38:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:38:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2867030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', '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 12:38:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:38:36 INFO - Using env: {'DISPLAY': ':0', 12:38:36 INFO - 'HOME': '/home/cltbld', 12:38:36 INFO - 'LANG': 'en_US.UTF-8', 12:38:36 INFO - 'LANGUAGE': 'en_US:en', 12:38:36 INFO - 'LOGNAME': 'cltbld', 12:38:36 INFO - 'MAIL': '/var/mail/cltbld', 12:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:36 INFO - 'MOZ_NO_REMOTE': '1', 12:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:36 INFO - 'NO_EM_RESTART': '1', 12:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:36 INFO - 'PWD': '/builds/slave/test', 12:38:36 INFO - 'SHELL': '/bin/bash', 12:38:36 INFO - 'SHLVL': '1', 12:38:36 INFO - 'TERM': 'linux', 12:38:36 INFO - 'TMOUT': '86400', 12:38:36 INFO - 'USER': 'cltbld', 12:38:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:36 INFO - '_': '/tools/buildbot/bin/python'} 12:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:38:36 INFO - Cleaning up... 12:38:36 INFO - Return code: 0 12:38:36 INFO - Running post-action listener: _resource_record_post_action 12:38:36 INFO - Running post-action listener: _start_resource_monitoring 12:38:36 INFO - Starting resource monitoring. 12:38:36 INFO - [mozharness: 2016-07-29 19:38:36.403837Z] Finished create-virtualenv step (success) 12:38:36 INFO - [mozharness: 2016-07-29 19:38:36.404282Z] Running install step. 12:38:36 INFO - Running pre-action listener: _resource_record_pre_action 12:38:36 INFO - Running main action method: install 12:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:38:36 INFO - Reading from file tmpfile_stdout 12:38:36 INFO - Detecting whether we're running mozinstall >=1.0... 12:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:38:36 INFO - Reading from file tmpfile_stdout 12:38:36 INFO - Output received: 12:38:36 INFO - Usage: mozinstall [options] installer 12:38:36 INFO - Options: 12:38:36 INFO - -h, --help show this help message and exit 12:38:36 INFO - -d DEST, --destination=DEST 12:38:36 INFO - Directory to install application into. [default: 12:38:36 INFO - "/builds/slave/test"] 12:38:36 INFO - --app=APP Application being installed. [default: firefox] 12:38:36 INFO - mkdir: /builds/slave/test/build/application 12:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:38:53 INFO - Reading from file tmpfile_stdout 12:38:53 INFO - Output received: 12:38:53 INFO - /builds/slave/test/build/application/firefox/firefox 12:38:53 INFO - Running post-action listener: _resource_record_post_action 12:38:53 INFO - [mozharness: 2016-07-29 19:38:53.114031Z] Finished install step (success) 12:38:53 INFO - [mozharness: 2016-07-29 19:38:53.114308Z] Running run-tests step. 12:38:53 INFO - Running pre-action listener: _resource_record_pre_action 12:38:53 INFO - Running main action method: run_tests 12:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:38:53 INFO - Python 2.7.3 12:38:53 INFO - Return code: 0 12:38:53 INFO - grabbing minidump binary from tooltool 12:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:53 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 0x2b263b0>, '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 0x2b272b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:38:53 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 12:38:53 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 12:38:53 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 12:38:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:38:53 INFO - Return code: 0 12:38:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:38:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:38:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:38:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:38:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 12:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 12:38:53 INFO - Using env: {'DISPLAY': ':0', 12:38:53 INFO - 'HOME': '/home/cltbld', 12:38:53 INFO - 'LANG': 'en_US.UTF-8', 12:38:53 INFO - 'LANGUAGE': 'en_US:en', 12:38:53 INFO - 'LOGNAME': 'cltbld', 12:38:53 INFO - 'MAIL': '/var/mail/cltbld', 12:38:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:38:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:53 INFO - 'MOZ_NO_REMOTE': '1', 12:38:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:53 INFO - 'NO_EM_RESTART': '1', 12:38:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:53 INFO - 'PWD': '/builds/slave/test', 12:38:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:38:53 INFO - 'SHELL': '/bin/bash', 12:38:53 INFO - 'SHLVL': '1', 12:38:53 INFO - 'TERM': 'linux', 12:38:53 INFO - 'TMOUT': '86400', 12:38:53 INFO - 'USER': 'cltbld', 12:38:53 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854', 12:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:53 INFO - '_': '/tools/buildbot/bin/python'} 12:38:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 12:38:53 INFO - mozversion application_buildid: 20160729120725 12:38:53 INFO - mozversion application_changeset: cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 12:38:53 INFO - mozversion application_display_name: Nightly 12:38:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:38:53 INFO - mozversion application_name: Firefox 12:38:53 INFO - mozversion application_remotingname: firefox 12:38:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:38:53 INFO - mozversion application_vendor: Mozilla 12:38:53 INFO - mozversion application_version: 50.0a1 12:38:53 INFO - mozversion platform_buildid: 20160729120725 12:38:53 INFO - mozversion platform_changeset: cb8fe696526cea65b8bbdcb6f62ae0a7c4d13145 12:38:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:38:53 INFO - mozversion platform_version: 50.0a1 12:38:53 INFO - using testdate: 1469821133 12:38:53 INFO - actual date: 1469821133 12:38:53 INFO - starting webserver on 'localhost:60527' 12:38:53 INFO - SUITE-START | Running 2 tests 12:38:53 INFO - TEST-START | dromaeo_css 12:38:53 INFO - operating with platform_type : linux_ 12:38:53 INFO - Initialising browser for dromaeo_css test... 12:38:53 INFO - TEST-INFO | started process 31648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ykI1W/profile http://localhost:60527/getInfo.html) 12:38:56 INFO - PROCESS | 31648 | JavaScript error: , line 0: uncaught exception: undefined 12:38:57 INFO - PROCESS | 31648 | __metrics Screen width/height:1600/1200 12:38:57 INFO - PROCESS | 31648 | colorDepth:24 12:38:57 INFO - PROCESS | 31648 | Browser inner width/height: 1024/697 12:38:57 INFO - PROCESS | 31648 | __metrics 12:38:58 INFO - PROCESS | 31648 | 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" 12:38:58 INFO - PROCESS | 31648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:59 INFO - TEST-INFO | 31648: exit 0 12:38:59 INFO - Browser initialized. 12:38:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:38:59 INFO - TEST-INFO | started process 31727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ykI1W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:11 INFO - PROCESS | 31727 | RSS: Main: 159137792 12:39:11 INFO - PROCESS | 31727 | 12:40:03 INFO - PROCESS | 31727 | 1469821203372 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] 12:42:15 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60527/tests/dromaeo/cssquery-ext.html) 12:42:16 INFO - PROCESS | 31727 | RSS: Main: 240041984 12:42:16 INFO - PROCESS | 31727 | 12:45:19 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-ext.html (next: http://localhost:60527/tests/dromaeo/cssquery-jquery.html) 12:45:19 INFO - PROCESS | 31727 | RSS: Main: 249978880 12:45:19 INFO - PROCESS | 31727 | 12:48:21 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60527/tests/dromaeo/cssquery-mootools.html) 12:48:22 INFO - PROCESS | 31727 | RSS: Main: 227041280 12:48:22 INFO - PROCESS | 31727 | 12:51:24 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60527/tests/dromaeo/cssquery-prototype.html) 12:51:25 INFO - PROCESS | 31727 | RSS: Main: 190332928 12:51:25 INFO - PROCESS | 31727 | 12:54:28 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60527/tests/dromaeo/cssquery-yui.html) 12:54:28 INFO - PROCESS | 31727 | RSS: Main: 189997056 12:54:28 INFO - PROCESS | 31727 | 12:57:31 INFO - PROCESS | 31727 | Cycle 1(1): loaded http://localhost:60527/tests/dromaeo/cssquery-yui.html (next: http://localhost:60527/tests/dromaeo/cssquery-dojo.html) 12:57:32 INFO - PROCESS | 31727 | RSS: Main: 279044096 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | __start_tp_report 12:57:32 INFO - PROCESS | 31727 | _x_x_mozilla_page_load 12:57:32 INFO - PROCESS | 31727 | _x_x_mozilla_page_load_details 12:57:32 INFO - PROCESS | 31727 | |i|pagename|runs| 12:57:32 INFO - PROCESS | 31727 | |0;dojo.html;2648.27172527555;2650.9204723858284;2683.5706286994077;2685.382362056728;2689.75792178704;4672.042231342575;4720.5515476029805;4751.073540659573;4864.367632207813;4884.560389564934;4728.645351598635;4798.01640663664;4799.952000479994;4823.13183626947;4835.371401717781;4340.696151269412;4370.71590346628;4402.360557375756;4409.492908315553;4473.507914129443;4414.558544145591;4497.460304763433;4529.23003089474;4529.796159172845;4567.931481027771;4341.41390912226;4388.692791504596;4480.327950807405;4490.730556166608;4578.5650363215445;4400.823967041314;4481.731096134243;4487.528809475023;4487.775611219426;4545.636349092098;4422.137683151786;4443.289073748185;4443.511213766483;4477.597016268519;4477.955220447787;4671.649626278008;4831.565159135695;4859.0767754126955;4880.951190488086;4896.4858689837765;4967.006598680242;4993.0263598598285;5036.445990940993;5036.697798132123;5137.2037334213255;5138.640295179339;5150.484951504857;5185.714785686786;5195.272661827347;5200.427952925175;4799.784009719571;4801.831935882227;4802.015586804731;4809.95190048102;4813.181759100961;5105.412877519133;5132.666376685504;5133.486651334912;5140.717260550631;5156.097682905476;4994.126027945168;5011.749412529359;5026.195808670595;5036.7733451994745;5039.571636410946;5094.057599344059;5139.331886854685;5142.51146141116;5142.71715055668;5143.202803565453;4941.703497790072;5019.272205530177;5022.4977502249485;5075.796968121308;5078.669886457443;5089.134847076006;5092.363454568179;5094.083065048327;5094.7962081516325;5128.205128205134;4300.548442413501;4343.1747967886;4344.283193273138;4377.190219809346;4385.101054283864;3744.045268456526;3754.6620804127215;3758.755680880734;3786.1670432504807;3791.184895247535;4430.424044874146;4435.955640443554;4447.888802779892;4452.5547445255215;4477.3731677565165;5159.845204643867;5181.5077567631015;5188.558972487381;5196.818111366084;5218.452062533455;4279.2083464559155;4387.903024243939;4409;4430.20256353853;4491.169133710274;4610.9308360374625;4627.606653434428;4636.6058884995155;4664.39362882823;4691.460482044608;4819.3012013258585;4821.566059054702;4826.758662066813;4862.78117484714;4886.071646387175;5013.899722005613;5075.08648443269;5092.694438333712;5174.586033117417;5183.50756678115;4809.903801923872;4841.903161936812;4854.635902307412;4878.853634390974;4902.1911384621135;5049.520295571915;5081.644284900021;5091.643584949018;5106.565941894981;5142.1258386073705;4968.304437378698;5029.949700502948;5074.264231686311;5096.643234973516;5115.948840511547;4925.630577706758;4956.454789973028;4973.303737476828;5014.047331007097;5023.171176755941;4952.059108769322;4952.727599982036;4953.18272485036;4958.404991401055;5002.099622068063;4722.055588882306;4767.880802979815;4857.417109946829;4865.051314993542;4900;4889.63327750413;4962.801487940442;4965.602751779921;4981.37732783402;5019.247112933089;4813.181759101031;4846.830360937351;4856.538628830255;4858.805647774049;4901.50984901507 12:57:32 INFO - PROCESS | 31727 | |1;ext.html;577.5783677915122;590.6338070396354;592.1916583863028;608.978685745999;616.2574098211655;37224.99999999996;38950;38994.41508377373;38999.22001559967;41747.16505669885;39569.40645890307;40012;40055.39916901249;40083.398749018714;40118.19763604726;7604.163542010375;7663.5785031823225;7721.382289416833;7733.53598784072;7745.728899488519;7639.083310002779;7716.768496945073;7718.845623087563;7720.420968427362;7723.961380193091;7731.884021739678;7758.495697779655;7769.650365733555;7771.844563108734;7774.961125194394;7692.615369231544;7719.38244940409;7720.691172353099;7722.884156737653;7723.845523089563;7685.308322251024;7741;7747.147813740484;7747.767566973;7748.2251774822635;38205.42691859624;38414.423783643266;38511.422328665096;38566.61433385658;38599.8070009651;2948.395578906319;3159.3523327717994;3167;3170.1599076244815;3228.5641438405983;28786.85606571975;28925;28989.56515652267;29259.268518287;30625;2783.8886444542195;2833.9008134715186;2843.672977607581;2851.073401144636;2874.841883696396;248715;250738;250850;251116;251249;49834.25248621274;50034.49965500371;50117.24824127641;50119.498805011484;50197.24704129441;32093.358132837213;33043.504347434806;33068.66931330704;35097.122571935906;52894.47105528895;15037.624059398384;15218.847811521964;15224.847751522564;15227.390904363923;15240.466583669519;11473.655790326304;11546.364949927667;11570.247933884271;11598.88401115995;11614.070874330033;17395.47813565595;17520.561985950455;17589.384371546934;17608.295668173385;17646.647067058842;6573.441257493167;6601.6699165041555;6787.151606049244;6883.483738719616;6992.790216293418;842.7176895739996;859.9183077607618;902.9413088149249;955.3933252384646;1011.8532812742111;26216.73783262181;27923.860380698374;28148.577771333446;28171.295717606812;28303.43393132126;817.5789468423767;935.4714586258742;978.848278516831;999.1507218863908;1023.0281232828843;13860.306984650728;14618.561443156723;14659.633509162357;14905.478308259158;14992.325345359484;381320;384364;385327;386909;387246;48832.75583622059;49367.753161233966;49372.75313623481;49456.50543494519;49462.258066129034;1086.739182596187;1158.5134243617701;1203.181836351272;1209.7096696792883;1212.2484059883104;27432.451350973268;28694.42611147807;28939.131826045254;29245.85377073101;29385;40205.79897100496;46130.308045380014;47494.76252618715;47610;52068.21897671614;369638;373404;375006;375192;375332;22602.434939126655;22944.885275574183;23112.191073312355;24205.878970605034;38911;38789.80605097069;38958;41439.7928010358;42071.400471090026;43503.129937400445;33060.66939330576;35696.28607427889;35860.82069589636;36421.635783641825;36906.63093369139;35336.82331588326;36000.63999360077;36271.45592816057;37081.81459092687;37318.440223397214;35705.28589428249;35722;36689.61517501354;37030.8148459256;37280.254394912496;30785.230369240948;33056.1735956603;33491;33553.66446335603;33561;23998.40003999914;24019.27942161738;24143.51712965766;24551.140710075062;24776.38059048466 12:57:32 INFO - PROCESS | 31727 | |2;jquery.html;350.64759916284163;350.84562792371355;380.22813688212926;381.3250546532638;398.1678292368948;12844.935775321122;16435.50693479196;16747.832521674794;17400.738988915145;18520.425763810093;17374.82625173748;17533.73699394507;17730.911345443255;17738;17861.464156075304;4741.691790033654;4907.68100073494;4922.55696987271;4927.827526036589;4930.506949305059;3737.5514938207452;5033.169527028036;5111.233315002761;5112.437631860493;5580.218769372291;5827.854303642401;5912.763489460438;5927.88144237115;5935.050391937291;5937.050071988483;5732.828015159552;5887.293524777054;5916.319623243317;5946.613470124428;5950.047992321208;5286.973565132188;5290.603204759658;5294.788208471657;5298.496642818965;5301.7084060376665;20725.792742072535;21338.679919801216;21369.252076177258;21384.35846924579;21571.784282157136;1963.1950900131021;1972.9901350493155;1974.7037944308468;1985.2952201968237;2103.831693464519;12984.805227921588;13248.337583120805;13441.462341506329;14184.787228191586;14346.856531434656;1663.376233912283;1747.973780393295;1753.7457068725091;1773.9822601773947;1816.527702797269;69890.30109698889;70860;71402;72194.63902680506;73833;9796.559154838049;9823.214142868554;9845.471083301618;9853;10082.74793130163;13718.725625487434;13752.587422377144;13765.793513097111;13772.20961275048;13779.379927903068;7282.745103921337;7310.671019804122;7510.624468776539;7526.397888168934;7562.621868906533;7002.369786719118;7010.228874823765;7151.348430515363;7295.306945840137;7323.707051717978;6172.672875331825;6182.938170618237;6267.310595834455;6305.117283580303;6320.873582528324;1779.2349289805509;1779.741937419093;1818.4635532517675;1821.3261093395263;1821.9908900455678;830.7175560309523;834.2575108153748;874.9562521874008;905.2848249882651;909;15595.688086238211;16873.156342182843;16951.152442377832;17401.129943503027;17927.462176134737;845.3659755183612;850.5237067242364;876.8684697295329;901.9278457723498;926.8470702334039;9532.618695252113;9712.514374281258;10613.416262105504;10788.838167427339;10846.67459976202;412147;414060;414450;415075;415730;52472.737636311576;60894.69552652208;87696;87753.56123219343;88801;408.3976135200615;424.64117820441675;425.3109961861742;426.55212027370516;428.7727504422661;9467.090259035496;9621.470819105016;9955.452450115023;10140.695779126638;10210.864599837078;37363;37371.81314093412;37797.24405511819;38359.42460863033;38569;52719.36403179902;53784.73107634437;55074.17388739252;55358.72320638371;55840.720796395755;7216.206217316196;7260.491765576359;7273.563586184846;7453.440991925736;7518.398528117628;9261.259099272176;10527.842082368923;11040.613578525034;11049.834252486058;11375;9869.457179855177;9967.352122112039;10337.17302615774;10392.22058345612;10582.629607963992;10208.54061567246;10307.433091179757;10329.483525823529;10597.47012649349;10729.088027517748;10102.747431314276;10259.58961641526;10317.638882639072;10668.413237272025;10759.462026898467;7514.586697731677;7795.142534321333;7805.882911756442;7998.320142787696;8107.594620269081;9706.757331066497;9808;9943.801123977624;10025.398476091457;10128 12:57:32 INFO - PROCESS | 31727 | |3;mootools.html;1248.8189212564173;1307.091571357906;1384.466980212618;1400.649837540615;1686.089511663701;6700.631465269408;7303.963480182599;7610.124835643903;7612.124605670349;7641.541507509546;7326.816829579263;7468.290512401327;7485.214052524489;7714.382849372051;7718.961405192967;2152.9569408611856;2198.0658220256405;2198.2416066457045;2204.195468653938;2205.0628482894786;2158.6222411077997;2190.76996915324;2210.778922107784;2217.6008318502663;2218.245796429214;2185.573813106445;2197.2529340024466;2202.317281642696;2209.9558008839813;2220.04538048639;2130.3928380411585;2131.07298325229;2131.9766512074216;2146.9570608587896;2150.193677370986;2106.6208082545136;2159.812103343155;2160.2655097266847;2160.34109596573;2183.967240491394;7473.626318684044;7539.886901696479;7631.3894888408795;7660.885086723703;7674.616269186518;4548.317752337143;4744.644151688637;4754.358161648168;4755.381800365965;4759.167145749515;2796.300924768808;2950.6754257031707;2978.3894301668106;2988.716071973181;2997.6552696439753;875.4047247871445;884.2660591708866;887.2680038967877;904.656230632362;906.5947780939583;10161;10384.37693738378;10384.428856412818;10391.948040259826;10392.584296628125;4041.4341992121126;4197.916041679149;4340.500842403101;4354.455693038371;4433.800478978454;8903.33225008127;8914;8914.465132092095;8917.687880924137;8933;4704.5765881070865;4707.741074240949;4708.270218116198;4710.105080034851;4711.74085425298;3724.8137593120778;4098.6516146127915;4258.659307255412;4287.528371879153;4293.849715259951;3716.832742526593;3762.793046382475;3840.6543411092575;3842.289176502356;3854.4989151410136;1180.7048237940514;1222.7004383925816;1225.209739717877;1230.2618428942742;1237.5359240284893;788.9921100788919;807.5800583696563;809.3323008517996;815.6533473273954;816.7427260413069;4906.656534042654;4930.457649658535;4969.850904472872;5018.24726291052;5157.174852023658;406.69091490467457;423.39031794216845;424.60723830456703;426.1285670803215;431.2905270829468;3313.337332533503;3344.9331013379597;3349.112485191426;3381.847816848248;3575.6245594212232;9305.069493050776;9684.41893486393;9707.271954603433;9724.611015559298;9749.463779492055;9589.472579008221;9590.184834289024;9606;9606.615735370508;9608.423494590346;7177.282271772781;7290.526115802456;7351.154617218981;7373.926260737431;7380.557166570023;4992.525710057539;5077.695338279715;5132.97433512845;5164.7417629119145;5256.500632439912;8717.564121793757;8906.554672266491;8918.821623567363;8919.821603568022;8985.101489850962;8940.552972351226;8961.327900407365;9163.49600771964;9167.49578773174;9184.678536251198;5943.702814859326;6418.326075762165;6638;6713.56361836479;6728.461723062242;7225.385842203472;7518.323350898227;7534.698612055457;7535.623218839146;7546.773596792105;6646.567973081735;6694.966525167343;6711.161104861892;6900.551464155014;6924.3421874921805;6365.363463653597;6588.209414870246;6593.934060659524;6608.471322294301;6673.899891501728;5674.347450043298;5757.683327417032;5759.2512973313205;5759.539236861125;5766.625169363978;4128.649064829403;4138;4205.5373908870615;4254.680898932531;4278.65770738334;4177.665786736993;4280.59334363235;4300.548442413627;4314.633256173135;4485.259932111165 12:57:32 INFO - PROCESS | 31727 | |4;prototype.html;293.97942144049927;300.67076551176456;302.9984850075749;304.12867135656353;309.42910330440327;4786.4974177711365;4831;4872.658913876021;4894.388201474816;4902.8774280643;4815.470298267197;4823.118983596391;4848.248521479168;4850.563449289563;4856.39295088114;3666.6333366663252;3688.686461650763;3711.610280920505;3804.5624753153465;3844.596317386669;3834.6357096075826;3835.386338185891;3853.344931361675;3857.614238576148;3857.691384689218;3821.522309711286;3829.48301979232;3829.5213098362706;3838.3282925488065;3843.3466310727244;3567.8037707926055;3684.355237833382;3788.147666774981;3792.829322680486;3863.8987888451798;3355.8825441109443;3360.8487618057247;3368.776607439103;3370.0226934189054;3387.5088112223834;4662.743549104832;4676.929846052312;4685.88285292867;4692.36653051837;4709.740964246965;4238.7456752594635;4364.847230346954;4367.71609845359;4368.694191406603;4371.475422949235;5010.72441015744;5011.298418221452;5018.2974383586325;5027.170516864713;5030.949690503085;3655.4882316475714;3657.0674478008204;3658.719448193111;3683.852645894188;3689.9705162160703;5072.619553533463;5227.137522308814;5290.867728306785;5302.496262855061;5305.14319988005;3714.220013797079;3754.9061273467837;3756.6806821420487;3783;3783.05423644089;3792.0140763401714;3812.7331086823656;3814.771113733185;3835.827387767557;3842.634949679776;4312.633426158749;4329.891752706208;4330.133973205371;4333.891652708708;4334.176506463762;4836.975815120902;5065.214891691794;5066.847994560169;5102.642815002989;5112.36095488064;1270.7140893299118;1280.961571152867;1284.441268048402;1284.4862055178003;1289.9806502902463;812.6140083460309;830.5930094253772;838.8172676526069;850.9404341696022;853.6713365354259;4091.693123015726;4145.7719825409895;4289.120730250291;4386.8025938832825;4443.4445694288215;5135.537801597874;5161.483851614808;5194.818181363634;5224.346956630421;5242.554382877422;4417.955820441754;4444.355568442557;4450.35469856869;4471.8658440246845;4486.798094085774;2611.6213149093273;2707.998040724905;2745.203890871665;2747.5191841427672;2765.764909982634;4873.26900964851;4899.387576552931;4904.166291730415;4913.140200464904;4919.90160196794;5350.839474815762;5385.438222915389;5386.622936394415;5392.676439413648;5417.968261901787;4671.6262698984;4870.829520966749;4894.730789806595;4919.704817710877;4945.664670538934;5190.6107041971245;5241.842744717665;5253.562562747538;5299;5336.412994570672;5272.3128598848;5275.525202731773;5275.683458992473;5281.55106815925;5282.762275697526;4700.835470758507;4883.724414127829;4934.950650493449;4938.283948827472;4949.886275587964;3701.7408781385043;3713.832877520464;3731.5708693500596;3762.2475504899676;3766.962330376661;5328.413874473882;5335.973320133375;5337.092694241911;5338;5343.7862485500145;4968.4286307075145;5065.620078494054;5100.285959965534;5105.6426050177615;5106.514881086439;5087.618428617942;5103.642745007963;5148.150555158357;5174.27560141588;5181.55956743666;4991.800525556773;5069.670471419346;5071.2139618359215;5079.593632509316;5087.542121209109;4898.363212782316;5018.197088465828;5081.4918508148885;5134.8973020540125;5198.298229738937;4797.616190704805;4953.851384458472;4968.112117395511;5018;5039.344885165052 12:57:32 INFO - PROCESS | 31727 | |5;yui.html;555.5389027107497;584.5995493087235;638.7636574467448;642.765672357615;661.2792056658244;11682.941585292072;12125.939370303136;12198.69503262419;12332.876671233285;12348.567800126997;11839;11864.406779661003;11921.701957451069;11925.105617078732;11972.880271197286;762.3443838299058;770.8612449759041;780.0366547314063;781.1290411191537;782.5070205770356;633.9397757213058;748.9475736698433;779.9493032952869;782.8277778888636;787.5117427195147;810.7891948093479;812.6668066092903;813.4631143445328;813.5728742410223;813.6094674556217;810.7446154461326;811.0956283743642;811.9391045671568;812.7277362083709;813.5444151275275;486.8734129126417;575.9625624334404;588.2176704982363;591.9852003699899;592.2478452365515;12647.936760316139;12677.936610316981;12685.17546359493;12698.873011269954;12711.491540338375;11293.774124517546;11375.829362559569;11465.656030319104;11468.770624587461;11893.643190704293;11331.263467874562;11457.439899257826;11522.974597963257;11685.649430517098;12001.939990299992;4117.279476091672;4126.484189476316;4130.318497447917;4224.957750422487;4246.426732391118;53517;55250.17124743132;55417.89164216693;61242.69378653123;64462.03306950446;9311.953440232755;9458.479783611967;9700.854487182698;9731.41611503312;9735.70792876215;17821.73267400964;17828.3760068397;17832.197551110232;17842.286308547773;17903.37338193157;6157.876842463125;6454.419102280817;6544.640044797487;6826.283240259801;6980.197277313073;3343.6656334366367;3377.7128944040032;3457.0493114393744;3485.5991560970306;3489.668481494254;2687.032668239432;2790.1908446550274;2792.427552351763;2797.482465743803;2798.5802129680305;498.2551086126192;506.9619778516626;510.6425502148511;518.4892880512692;524.9685018898879;503.8362532177057;532.8774381892109;581.5551103405897;608.2457752387008;622.0575827621067;7399.149097853708;7799.571023593643;7935.325497332791;8101.6354264058255;8216.383771217183;502.8717676992417;564.305903738404;577.9364269930304;592.1473078766562;597.5309382135003;3522.700570451489;3631.5460567429072;3751.2122454284904;3757.1734218471893;3963.960360396359;64113;109732.4513377428;110271.44864275627;112318;112971;83460.16539834524;85274.57362713147;85421;85805.57097214473;87421.5628921864;48770.5122948766;75247;78888;82763.17236827675;84358.57820710857;7158.642067896689;7187.209406965334;7224.566526008456;7389.852202956018;7452.962735186289;33548.161295967795;37103.81448092742;46140.30789538092;46628.7668561655;46859.76570117127;54202;56282;56869.146962794766;57239;60764.39235607587;10552.894471055499;10966.287191332538;10990.505427255634;10991.395473249047;11218.887811121784;12059.457324420599;12066.939665301617;12085.335306558223;12109.455074521491;12224.327661978321;10562.26064175531;10774.676759697222;11498.712532186428;11586.76826463483;11773.88226117728;10657;10890.29213101146;11157.44212789341;11503.76992460163;11710.765784684429;10994.945025274823;11085.445727713743;11171.608993685182;11672.416379181177;11704.297742135499;8829.955850220707;8969.50667713282;9492.778097868439;9822.65620703272;10031.097201251923;8291.670408845543;8571.057183709912;8881.111888811325;8982.461052336881;9005.954970225106 12:57:32 INFO - PROCESS | 31727 | __end_tp_report 12:57:32 INFO - PROCESS | 31727 | __start_cc_report 12:57:32 INFO - PROCESS | 31727 | _x_x_mozilla_cycle_collect,1021 12:57:32 INFO - PROCESS | 31727 | __end_cc_report 12:57:32 INFO - PROCESS | 31727 | __startTimestamp1469822252005__endTimestamp 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | ------- Summary: start ------- 12:57:32 INFO - PROCESS | 31727 | Number of tests: 6 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#0] dojo.html Cycles:165 Average:4731.66 Median:4858.81 stddev:484.64 (10.0%) stddev-sans-first:457.74 12:57:32 INFO - PROCESS | 31727 | Values: 2648.3 2650.9 2683.6 2685.4 2689.8 4672.0 4720.6 4751.1 4864.4 4884.6 4728.6 4798.0 4800.0 4823.1 4835.4 4340.7 4370.7 4402.4 4409.5 4473.5 4414.6 4497.5 4529.2 4529.8 4567.9 4341.4 4388.7 4480.3 4490.7 4578.6 4400.8 4481.7 4487.5 4487.8 4545.6 4422.1 4443.3 4443.5 4477.6 4478.0 4671.6 4831.6 4859.1 4881.0 4896.5 4967.0 4993.0 5036.4 5036.7 5137.2 5138.6 5150.5 5185.7 5195.3 5200.4 4799.8 4801.8 4802.0 4810.0 4813.2 5105.4 5132.7 5133.5 5140.7 5156.1 4994.1 5011.7 5026.2 5036.8 5039.6 5094.1 5139.3 5142.5 5142.7 5143.2 4941.7 5019.3 5022.5 5075.8 5078.7 5089.1 5092.4 5094.1 5094.8 5128.2 4300.5 4343.2 4344.3 4377.2 4385.1 3744.0 3754.7 3758.8 3786.2 3791.2 4430.4 4436.0 4447.9 4452.6 4477.4 5159.8 5181.5 5188.6 5196.8 5218.5 4279.2 4387.9 4409.0 4430.2 4491.2 4610.9 4627.6 4636.6 4664.4 4691.5 4819.3 4821.6 4826.8 4862.8 4886.1 5013.9 5075.1 5092.7 5174.6 5183.5 4809.9 4841.9 4854.6 4878.9 4902.2 5049.5 5081.6 5091.6 5106.6 5142.1 4968.3 5029.9 5074.3 5096.6 5115.9 4925.6 4956.5 4973.3 5014.0 5023.2 4952.1 4952.7 4953.2 4958.4 5002.1 4722.1 4767.9 4857.4 4865.1 4900.0 4889.6 4962.8 4965.6 4981.4 5019.2 4813.2 4846.8 4856.5 4858.8 4901.5 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#1] ext.html Cycles:180 Average:48412.99 Median:37299.35 stddev:90193.78 (241.8%) stddev-sans-first:90375.29 12:57:32 INFO - PROCESS | 31727 | Values: 577.6 590.6 592.2 609.0 616.3 37225.0 38950.0 38994.4 38999.2 41747.2 39569.4 40012.0 40055.4 40083.4 40118.2 7604.2 7663.6 7721.4 7733.5 7745.7 7639.1 7716.8 7718.8 7720.4 7724.0 7731.9 7758.5 7769.7 7771.8 7775.0 7692.6 7719.4 7720.7 7722.9 7723.8 7685.3 7741.0 7747.1 7747.8 7748.2 38205.4 38414.4 38511.4 38566.6 38599.8 2948.4 3159.4 3167.0 3170.2 3228.6 28786.9 28925.0 28989.6 29259.3 30625.0 2783.9 2833.9 2843.7 2851.1 2874.8 248715.0 250738.0 250850.0 251116.0 251249.0 49834.3 50034.5 50117.2 50119.5 50197.2 32093.4 33043.5 33068.7 35097.1 52894.5 15037.6 15218.8 15224.8 15227.4 15240.5 11473.7 11546.4 11570.2 11598.9 11614.1 17395.5 17520.6 17589.4 17608.3 17646.6 6573.4 6601.7 6787.2 6883.5 6992.8 842.7 859.9 902.9 955.4 1011.9 26216.7 27923.9 28148.6 28171.3 28303.4 817.6 935.5 978.8 999.2 1023.0 13860.3 14618.6 14659.6 14905.5 14992.3 381320.0 384364.0 385327.0 386909.0 387246.0 48832.8 49367.8 49372.8 49456.5 49462.3 1086.7 1158.5 1203.2 1209.7 1212.2 27432.5 28694.4 28939.1 29245.9 29385.0 40205.8 46130.3 47494.8 47610.0 52068.2 369638.0 373404.0 375006.0 375192.0 375332.0 22602.4 22944.9 23112.2 24205.9 38911.0 38789.8 38958.0 41439.8 42071.4 43503.1 33060.7 35696.3 35860.8 36421.6 36906.6 35336.8 36000.6 36271.5 37081.8 37318.4 35705.3 35722.0 36689.6 37030.8 37280.3 30785.2 33056.2 33491.0 33553.7 33561.0 23998.4 24019.3 24143.5 24551.1 24776.4 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#2] jquery.html Cycles:180 Average:25175.18 Median:2585.23 stddev:68355.39 (2644.1%) stddev-sans-first:68521.73 12:57:32 INFO - PROCESS | 31727 | Values: 350.6 350.8 380.2 381.3 398.2 12844.9 16435.5 16747.8 17400.7 18520.4 17374.8 17533.7 17730.9 17738.0 17861.5 4741.7 4907.7 4922.6 4927.8 4930.5 3737.6 5033.2 5111.2 5112.4 5580.2 5827.9 5912.8 5927.9 5935.1 5937.1 5732.8 5887.3 5916.3 5946.6 5950.0 5287.0 5290.6 5294.8 5298.5 5301.7 20725.8 21338.7 21369.3 21384.4 21571.8 1963.2 1973.0 1974.7 1985.3 2103.8 12984.8 13248.3 13441.5 14184.8 14346.9 1663.4 1748.0 1753.7 1774.0 1816.5 69890.3 70860.0 71402.0 72194.6 73833.0 9796.6 9823.2 9845.5 9853.0 10082.7 13718.7 13752.6 13765.8 13772.2 13779.4 7282.7 7310.7 7510.6 7526.4 7562.6 7002.4 7010.2 7151.3 7295.3 7323.7 6172.7 6182.9 6267.3 6305.1 6320.9 1779.2 1779.7 1818.5 1821.3 1822.0 830.7 834.3 875.0 905.3 909.0 15595.7 16873.2 16951.2 17401.1 17927.5 845.4 850.5 876.9 901.9 926.8 9532.6 9712.5 10613.4 10788.8 10846.7 412147.0 414060.0 414450.0 415075.0 415730.0 52472.7 60894.7 87696.0 87753.6 88801.0 408.4 424.6 425.3 426.6 428.8 9467.1 9621.5 9955.5 10140.7 10210.9 37363.0 37371.8 37797.2 38359.4 38569.0 52719.4 53784.7 55074.2 55358.7 55840.7 7216.2 7260.5 7273.6 7453.4 7518.4 9261.3 10527.8 11040.6 11049.8 11375.0 9869.5 9967.4 10337.2 10392.2 10582.6 10208.5 10307.4 10329.5 10597.5 10729.1 10102.7 10259.6 10317.6 10668.4 10759.5 7514.6 7795.1 7805.9 7998.3 8107.6 9706.8 9808.0 9943.8 10025.4 10128.0 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#3] mootools.html Cycles:180 Average:5043.67 Median:4918.56 stddev:2849.67 (57.9%) stddev-sans-first:2843.40 12:57:32 INFO - PROCESS | 31727 | Values: 1248.8 1307.1 1384.5 1400.6 1686.1 6700.6 7304.0 7610.1 7612.1 7641.5 7326.8 7468.3 7485.2 7714.4 7719.0 2153.0 2198.1 2198.2 2204.2 2205.1 2158.6 2190.8 2210.8 2217.6 2218.2 2185.6 2197.3 2202.3 2210.0 2220.0 2130.4 2131.1 2132.0 2147.0 2150.2 2106.6 2159.8 2160.3 2160.3 2184.0 7473.6 7539.9 7631.4 7660.9 7674.6 4548.3 4744.6 4754.4 4755.4 4759.2 2796.3 2950.7 2978.4 2988.7 2997.7 875.4 884.3 887.3 904.7 906.6 10161.0 10384.4 10384.4 10391.9 10392.6 4041.4 4197.9 4340.5 4354.5 4433.8 8903.3 8914.0 8914.5 8917.7 8933.0 4704.6 4707.7 4708.3 4710.1 4711.7 3724.8 4098.7 4258.7 4287.5 4293.8 3716.8 3762.8 3840.7 3842.3 3854.5 1180.7 1222.7 1225.2 1230.3 1237.5 789.0 807.6 809.3 815.7 816.7 4906.7 4930.5 4969.9 5018.2 5157.2 406.7 423.4 424.6 426.1 431.3 3313.3 3344.9 3349.1 3381.8 3575.6 9305.1 9684.4 9707.3 9724.6 9749.5 9589.5 9590.2 9606.0 9606.6 9608.4 7177.3 7290.5 7351.2 7373.9 7380.6 4992.5 5077.7 5133.0 5164.7 5256.5 8717.6 8906.6 8918.8 8919.8 8985.1 8940.6 8961.3 9163.5 9167.5 9184.7 5943.7 6418.3 6638.0 6713.6 6728.5 7225.4 7518.3 7534.7 7535.6 7546.8 6646.6 6695.0 6711.2 6900.6 6924.3 6365.4 6588.2 6593.9 6608.5 6673.9 5674.3 5757.7 5759.3 5759.5 5766.6 4128.6 4138.0 4205.5 4254.7 4278.7 4177.7 4280.6 4300.5 4314.6 4485.3 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#4] prototype.html Cycles:180 Average:4225.44 Median:4827.06 stddev:1230.63 (25.5%) stddev-sans-first:1198.18 12:57:32 INFO - PROCESS | 31727 | Values: 294.0 300.7 303.0 304.1 309.4 4786.5 4831.0 4872.7 4894.4 4902.9 4815.5 4823.1 4848.2 4850.6 4856.4 3666.6 3688.7 3711.6 3804.6 3844.6 3834.6 3835.4 3853.3 3857.6 3857.7 3821.5 3829.5 3829.5 3838.3 3843.3 3567.8 3684.4 3788.1 3792.8 3863.9 3355.9 3360.8 3368.8 3370.0 3387.5 4662.7 4676.9 4685.9 4692.4 4709.7 4238.7 4364.8 4367.7 4368.7 4371.5 5010.7 5011.3 5018.3 5027.2 5030.9 3655.5 3657.1 3658.7 3683.9 3690.0 5072.6 5227.1 5290.9 5302.5 5305.1 3714.2 3754.9 3756.7 3783.0 3783.1 3792.0 3812.7 3814.8 3835.8 3842.6 4312.6 4329.9 4330.1 4333.9 4334.2 4837.0 5065.2 5066.8 5102.6 5112.4 1270.7 1281.0 1284.4 1284.5 1290.0 812.6 830.6 838.8 850.9 853.7 4091.7 4145.8 4289.1 4386.8 4443.4 5135.5 5161.5 5194.8 5224.3 5242.6 4418.0 4444.4 4450.4 4471.9 4486.8 2611.6 2708.0 2745.2 2747.5 2765.8 4873.3 4899.4 4904.2 4913.1 4919.9 5350.8 5385.4 5386.6 5392.7 5418.0 4671.6 4870.8 4894.7 4919.7 4945.7 5190.6 5241.8 5253.6 5299.0 5336.4 5272.3 5275.5 5275.7 5281.6 5282.8 4700.8 4883.7 4935.0 4938.3 4949.9 3701.7 3713.8 3731.6 3762.2 3767.0 5328.4 5336.0 5337.1 5338.0 5343.8 4968.4 5065.6 5100.3 5105.6 5106.5 5087.6 5103.6 5148.2 5174.3 5181.6 4991.8 5069.7 5071.2 5079.6 5087.5 4898.4 5018.2 5081.5 5134.9 5198.3 4797.6 4953.9 4968.1 5018.0 5039.3 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - PROCESS | 31727 | [#5] yui.html Cycles:180 Average:17293.02 Median:508.80 stddev:25631.69 (5037.7%) stddev-sans-first:25672.78 12:57:32 INFO - PROCESS | 31727 | Values: 555.5 584.6 638.8 642.8 661.3 11682.9 12125.9 12198.7 12332.9 12348.6 11839.0 11864.4 11921.7 11925.1 11972.9 762.3 770.9 780.0 781.1 782.5 633.9 748.9 779.9 782.8 787.5 810.8 812.7 813.5 813.6 813.6 810.7 811.1 811.9 812.7 813.5 486.9 576.0 588.2 592.0 592.2 12647.9 12677.9 12685.2 12698.9 12711.5 11293.8 11375.8 11465.7 11468.8 11893.6 11331.3 11457.4 11523.0 11685.6 12001.9 4117.3 4126.5 4130.3 4225.0 4246.4 53517.0 55250.2 55417.9 61242.7 64462.0 9312.0 9458.5 9700.9 9731.4 9735.7 17821.7 17828.4 17832.2 17842.3 17903.4 6157.9 6454.4 6544.6 6826.3 6980.2 3343.7 3377.7 3457.0 3485.6 3489.7 2687.0 2790.2 2792.4 2797.5 2798.6 498.3 507.0 510.6 518.5 525.0 503.8 532.9 581.6 608.2 622.1 7399.1 7799.6 7935.3 8101.6 8216.4 502.9 564.3 577.9 592.1 597.5 3522.7 3631.5 3751.2 3757.2 3964.0 64113.0 109732.5 110271.4 112318.0 112971.0 83460.2 85274.6 85421.0 85805.6 87421.6 48770.5 75247.0 78888.0 82763.2 84358.6 7158.6 7187.2 7224.6 7389.9 7453.0 33548.2 37103.8 46140.3 46628.8 46859.8 54202.0 56282.0 56869.1 57239.0 60764.4 10552.9 10966.3 10990.5 10991.4 11218.9 12059.5 12066.9 12085.3 12109.5 12224.3 10562.3 10774.7 11498.7 11586.8 11773.9 10657.0 10890.3 11157.4 11503.8 11710.8 10994.9 11085.4 11171.6 11672.4 11704.3 8830.0 8969.5 9492.8 9822.7 10031.1 8291.7 8571.1 8881.1 8982.5 9006.0 12:57:32 INFO - PROCESS | 31727 | -------- Summary: end -------- 12:57:32 INFO - PROCESS | 31727 | 12:57:32 INFO - TEST-INFO | 31727: exit 0 12:57:32 INFO - TEST-OK | dromaeo_css | took 1119416ms 12:57:32 INFO - TEST-START | kraken 12:57:32 INFO - operating with platform_type : linux_ 12:57:32 INFO - Initialising browser for kraken test... 12:57:32 INFO - TEST-INFO | started process 31913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpon33BL/profile http://localhost:60527/getInfo.html) 12:57:36 INFO - PROCESS | 31913 | JavaScript error: , line 0: uncaught exception: undefined 12:57:37 INFO - PROCESS | 31913 | __metrics Screen width/height:1600/1200 12:57:37 INFO - PROCESS | 31913 | colorDepth:24 12:57:37 INFO - PROCESS | 31913 | Browser inner width/height: 1024/697 12:57:37 INFO - PROCESS | 31913 | __metrics 12:57:37 INFO - PROCESS | 31913 | 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" 12:57:37 INFO - PROCESS | 31913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:57:38 INFO - TEST-INFO | 31913: exit 0 12:57:38 INFO - Browser initialized. 12:57:38 INFO - Running cycle 1/1 for kraken test... 12:57:38 INFO - TEST-INFO | started process 31993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpon33BL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:50 INFO - PROCESS | 31993 | RSS: Main: 159465472 12:57:50 INFO - PROCESS | 31993 | 12:57:53 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60527/tests/kraken/driver.html?testName=audio-beat-detection) 12:57:54 INFO - PROCESS | 31993 | RSS: Main: 216006656 12:57:54 INFO - PROCESS | 31993 | 12:57:57 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60527/tests/kraken/driver.html?testName=audio-dft) 12:57:57 INFO - PROCESS | 31993 | RSS: Main: 193236992 12:57:57 INFO - PROCESS | 31993 | 12:58:01 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60527/tests/kraken/driver.html?testName=audio-fft) 12:58:01 INFO - PROCESS | 31993 | RSS: Main: 273231872 12:58:01 INFO - PROCESS | 31993 | 12:58:03 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60527/tests/kraken/driver.html?testName=audio-oscillator) 12:58:04 INFO - PROCESS | 31993 | RSS: Main: 182337536 12:58:04 INFO - PROCESS | 31993 | 12:58:06 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:58:07 INFO - PROCESS | 31993 | RSS: Main: 186724352 12:58:07 INFO - PROCESS | 31993 | 12:58:10 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60527/tests/kraken/driver.html?testName=imaging-darkroom) 12:58:11 INFO - PROCESS | 31993 | RSS: Main: 222908416 12:58:11 INFO - PROCESS | 31993 | 12:58:14 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60527/tests/kraken/driver.html?testName=imaging-desaturate) 12:58:15 INFO - PROCESS | 31993 | RSS: Main: 222392320 12:58:15 INFO - PROCESS | 31993 | 12:58:18 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60527/tests/kraken/driver.html?testName=json-parse-financial) 12:58:18 INFO - PROCESS | 31993 | RSS: Main: 221728768 12:58:18 INFO - PROCESS | 31993 | 12:58:20 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:58:21 INFO - PROCESS | 31993 | RSS: Main: 187121664 12:58:21 INFO - PROCESS | 31993 | 12:58:22 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:58:23 INFO - PROCESS | 31993 | RSS: Main: 192937984 12:58:23 INFO - PROCESS | 31993 | 12:58:25 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:58:26 INFO - PROCESS | 31993 | RSS: Main: 196972544 12:58:26 INFO - PROCESS | 31993 | 12:58:29 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:58:29 INFO - PROCESS | 31993 | RSS: Main: 192008192 12:58:29 INFO - PROCESS | 31993 | 12:58:32 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:58:33 INFO - PROCESS | 31993 | RSS: Main: 195219456 12:58:33 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | Cycle 1(1): loaded http://localhost:60527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60527/tests/kraken/driver.html?testName=ai-astar) 12:58:35 INFO - PROCESS | 31993 | RSS: Main: 246824960 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | __start_tp_report 12:58:35 INFO - PROCESS | 31993 | _x_x_mozilla_page_load 12:58:35 INFO - PROCESS | 31993 | _x_x_mozilla_page_load_details 12:58:35 INFO - PROCESS | 31993 | |i|pagename|runs| 12:58:35 INFO - PROCESS | 31993 | |0;ai-astar;105;116;114;115;114;117;114;113;113;115 12:58:35 INFO - PROCESS | 31993 | |1;audio-beat-detection;149;127;130;197;128;122;148;127;179;130 12:58:35 INFO - PROCESS | 31993 | |2;audio-dft;161;160;160;162;163;162;163;163;161;161 12:58:35 INFO - PROCESS | 31993 | |3;audio-fft;75;75;75;133;77;76;75;76;102;76 12:58:35 INFO - PROCESS | 31993 | |4;audio-oscillator;86;86;109;85;85;85;126;85;86;129 12:58:35 INFO - PROCESS | 31993 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 12:58:35 INFO - PROCESS | 31993 | |6;imaging-darkroom;146;147;146;146;145;147;146;146;146;146 12:58:35 INFO - PROCESS | 31993 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 12:58:35 INFO - PROCESS | 31993 | |8;json-parse-financial;63;62;61;61;61;62;63;62;62;61 12:58:35 INFO - PROCESS | 31993 | |9;json-stringify-tinderbox;65;66;65;65;66;66;65;67;66;66 12:58:35 INFO - PROCESS | 31993 | |10;stanford-crypto-aes;79;88;78;80;90;81;80;80;80;86 12:58:35 INFO - PROCESS | 31993 | |11;stanford-crypto-ccm;147;137;137;134;127;140;136;128;176;126 12:58:35 INFO - PROCESS | 31993 | |12;stanford-crypto-pbkdf2;165;164;169;166;166;165;166;165;166;163 12:58:35 INFO - PROCESS | 31993 | |13;stanford-crypto-sha256-iterative;70;69;71;67;66;65;70;65;65;64 12:58:35 INFO - PROCESS | 31993 | __end_tp_report 12:58:35 INFO - PROCESS | 31993 | __start_cc_report 12:58:35 INFO - PROCESS | 31993 | _x_x_mozilla_cycle_collect,1981 12:58:35 INFO - PROCESS | 31993 | __end_cc_report 12:58:35 INFO - PROCESS | 31993 | __startTimestamp1469822315362__endTimestamp 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | ------- Summary: start ------- 12:58:35 INFO - PROCESS | 31993 | Number of tests: 14 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:3.27 (2.9%) stddev-sans-first:1.33 12:58:35 INFO - PROCESS | 31993 | Values: 105.0 116.0 114.0 115.0 114.0 117.0 114.0 113.0 113.0 115.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:139.00 stddev:25.35 (18.2%) stddev-sans-first:26.82 12:58:35 INFO - PROCESS | 31993 | Values: 149.0 127.0 130.0 197.0 128.0 122.0 148.0 127.0 179.0 130.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 12:58:35 INFO - PROCESS | 31993 | Values: 161.0 160.0 160.0 162.0 163.0 162.0 163.0 163.0 161.0 161.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:19.12 (25.3%) stddev-sans-first:20.00 12:58:35 INFO - PROCESS | 31993 | Values: 75.0 75.0 75.0 133.0 77.0 76.0 75.0 76.0 102.0 76.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.08 (21.3%) stddev-sans-first:18.79 12:58:35 INFO - PROCESS | 31993 | Values: 86.0 86.0 109.0 85.0 85.0 85.0 126.0 85.0 86.0 129.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:58:35 INFO - PROCESS | 31993 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:58:35 INFO - PROCESS | 31993 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:58:35 INFO - PROCESS | 31993 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 12:58:35 INFO - PROCESS | 31993 | Values: 63.0 62.0 61.0 61.0 61.0 62.0 63.0 62.0 62.0 61.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 12:58:35 INFO - PROCESS | 31993 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 65.0 67.0 66.0 66.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:80.50 stddev:4.18 (5.2%) stddev-sans-first:4.28 12:58:35 INFO - PROCESS | 31993 | Values: 79.0 88.0 78.0 80.0 90.0 81.0 80.0 80.0 80.0 86.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:137.00 stddev:14.57 (10.6%) stddev-sans-first:15.14 12:58:35 INFO - PROCESS | 31993 | Values: 147.0 137.0 137.0 134.0 127.0 140.0 136.0 128.0 176.0 126.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:166.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 12:58:35 INFO - PROCESS | 31993 | Values: 165.0 164.0 169.0 166.0 166.0 165.0 166.0 165.0 166.0 163.0 12:58:35 INFO - PROCESS | 31993 | 12:58:35 INFO - PROCESS | 31993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:2.57 (3.8%) stddev-sans-first:2.52 12:58:35 INFO - PROCESS | 31993 | Values: 70.0 69.0 71.0 67.0 66.0 65.0 70.0 65.0 65.0 64.0 12:58:35 INFO - PROCESS | 31993 | -------- Summary: end -------- 12:58:35 INFO - PROCESS | 31993 | 12:58:36 INFO - TEST-INFO | 31993: exit 0 12:58:36 INFO - TEST-OK | kraken | took 63746ms 12:58:36 INFO - SUITE-END | took 1183s 12:58:37 INFO - Completed test suite (00:19:43) 12:58:37 INFO - javascript benchmark 12:58:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.27172527555, 2650.9204723858284, 2683.5706286994077, 2685.382362056728, 2689.75792178704, 4672.042231342575, 4720.5515476029805, 4751.073540659573, 4864.367632207813, 4884.560389564934, 4728.645351598635, 4798.01640663664, 4799.952000479994, 4823.13183626947, 4835.371401717781, 4340.696151269412, 4370.71590346628, 4402.360557375756, 4409.492908315553, 4473.507914129443, 4414.558544145591, 4497.460304763433, 4529.23003089474, 4529.796159172845, 4567.931481027771, 4341.41390912226, 4388.692791504596, 4480.327950807405, 4490.730556166608, 4578.5650363215445, 4400.823967041314, 4481.731096134243, 4487.528809475023, 4487.775611219426, 4545.636349092098, 4422.137683151786, 4443.289073748185, 4443.511213766483, 4477.597016268519, 4477.955220447787, 4671.649626278008, 4831.565159135695, 4859.0767754126955, 4880.951190488086, 4896.4858689837765, 4967.006598680242, 4993.0263598598285, 5036.445990940993, 5036.697798132123, 5137.2037334213255, 5138.640295179339, 5150.484951504857, 5185.714785686786, 5195.272661827347, 5200.427952925175, 4799.784009719571, 4801.831935882227, 4802.015586804731, 4809.95190048102, 4813.181759100961, 5105.412877519133, 5132.666376685504, 5133.486651334912, 5140.717260550631, 5156.097682905476, 4994.126027945168, 5011.749412529359, 5026.195808670595, 5036.7733451994745, 5039.571636410946, 5094.057599344059, 5139.331886854685, 5142.51146141116, 5142.71715055668, 5143.202803565453, 4941.703497790072, 5019.272205530177, 5022.4977502249485, 5075.796968121308, 5078.669886457443, 5089.134847076006, 5092.363454568179, 5094.083065048327, 5094.7962081516325, 5128.205128205134, 4300.548442413501, 4343.1747967886, 4344.283193273138, 4377.190219809346, 4385.101054283864, 3744.045268456526, 3754.6620804127215, 3758.755680880734, 3786.1670432504807, 3791.184895247535, 4430.424044874146, 4435.955640443554, 4447.888802779892, 4452.5547445255215, 4477.3731677565165, 5159.845204643867, 5181.5077567631015, 5188.558972487381, 5196.818111366084, 5218.452062533455, 4279.2083464559155, 4387.903024243939, 4409.0, 4430.20256353853, 4491.169133710274, 4610.9308360374625, 4627.606653434428, 4636.6058884995155, 4664.39362882823, 4691.460482044608, 4819.3012013258585, 4821.566059054702, 4826.758662066813, 4862.78117484714, 4886.071646387175, 5013.899722005613, 5075.08648443269, 5092.694438333712, 5174.586033117417, 5183.50756678115, 4809.903801923872, 4841.903161936812, 4854.635902307412, 4878.853634390974, 4902.1911384621135, 5049.520295571915, 5081.644284900021, 5091.643584949018, 5106.565941894981, 5142.1258386073705, 4968.304437378698, 5029.949700502948, 5074.264231686311, 5096.643234973516, 5115.948840511547, 4925.630577706758, 4956.454789973028, 4973.303737476828, 5014.047331007097, 5023.171176755941, 4952.059108769322, 4952.727599982036, 4953.18272485036, 4958.404991401055, 5002.099622068063, 4722.055588882306, 4767.880802979815, 4857.417109946829, 4865.051314993542, 4900.0, 4889.63327750413, 4962.801487940442, 4965.602751779921, 4981.37732783402, 5019.247112933089, 4813.181759101031, 4846.830360937351, 4856.538628830255, 4858.805647774049, 4901.50984901507], "value": 4701.037453589716, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5783677915122, 590.6338070396354, 592.1916583863028, 608.978685745999, 616.2574098211655, 37224.99999999996, 38950.0, 38994.41508377373, 38999.22001559967, 41747.16505669885, 39569.40645890307, 40012.0, 40055.39916901249, 40083.398749018714, 40118.19763604726, 7604.163542010375, 7663.5785031823225, 7721.382289416833, 7733.53598784072, 7745.728899488519, 7639.083310002779, 7716.768496945073, 7718.845623087563, 7720.420968427362, 7723.961380193091, 7731.884021739678, 7758.495697779655, 7769.650365733555, 7771.844563108734, 7774.961125194394, 7692.615369231544, 7719.38244940409, 7720.691172353099, 7722.884156737653, 7723.845523089563, 7685.308322251024, 7741.0, 7747.147813740484, 7747.767566973, 7748.2251774822635, 38205.42691859624, 38414.423783643266, 38511.422328665096, 38566.61433385658, 38599.8070009651, 2948.395578906319, 3159.3523327717994, 3167.0, 3170.1599076244815, 3228.5641438405983, 28786.85606571975, 28925.0, 28989.56515652267, 29259.268518287, 30625.0, 2783.8886444542195, 2833.9008134715186, 2843.672977607581, 2851.073401144636, 2874.841883696396, 248715.0, 250738.0, 250850.0, 251116.0, 251249.0, 49834.25248621274, 50034.49965500371, 50117.24824127641, 50119.498805011484, 50197.24704129441, 32093.358132837213, 33043.504347434806, 33068.66931330704, 35097.122571935906, 52894.47105528895, 15037.624059398384, 15218.847811521964, 15224.847751522564, 15227.390904363923, 15240.466583669519, 11473.655790326304, 11546.364949927667, 11570.247933884271, 11598.88401115995, 11614.070874330033, 17395.47813565595, 17520.561985950455, 17589.384371546934, 17608.295668173385, 17646.647067058842, 6573.441257493167, 6601.6699165041555, 6787.151606049244, 6883.483738719616, 6992.790216293418, 842.7176895739996, 859.9183077607618, 902.9413088149249, 955.3933252384646, 1011.8532812742111, 26216.73783262181, 27923.860380698374, 28148.577771333446, 28171.295717606812, 28303.43393132126, 817.5789468423767, 935.4714586258742, 978.848278516831, 999.1507218863908, 1023.0281232828843, 13860.306984650728, 14618.561443156723, 14659.633509162357, 14905.478308259158, 14992.325345359484, 381320.0, 384364.0, 385327.0, 386909.0, 387246.0, 48832.75583622059, 49367.753161233966, 49372.75313623481, 49456.50543494519, 49462.258066129034, 1086.739182596187, 1158.5134243617701, 1203.181836351272, 1209.7096696792883, 1212.2484059883104, 27432.451350973268, 28694.42611147807, 28939.131826045254, 29245.85377073101, 29385.0, 40205.79897100496, 46130.308045380014, 47494.76252618715, 47610.0, 52068.21897671614, 369638.0, 373404.0, 375006.0, 375192.0, 375332.0, 22602.434939126655, 22944.885275574183, 23112.191073312355, 24205.878970605034, 38911.0, 38789.80605097069, 38958.0, 41439.7928010358, 42071.400471090026, 43503.129937400445, 33060.66939330576, 35696.28607427889, 35860.82069589636, 36421.635783641825, 36906.63093369139, 35336.82331588326, 36000.63999360077, 36271.45592816057, 37081.81459092687, 37318.440223397214, 35705.28589428249, 35722.0, 36689.61517501354, 37030.8148459256, 37280.254394912496, 30785.230369240948, 33056.1735956603, 33491.0, 33553.66446335603, 33561.0, 23998.40003999914, 24019.27942161738, 24143.51712965766, 24551.140710075062, 24776.38059048466], "value": 17341.762888632707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.64759916284163, 350.84562792371355, 380.22813688212926, 381.3250546532638, 398.1678292368948, 12844.935775321122, 16435.50693479196, 16747.832521674794, 17400.738988915145, 18520.425763810093, 17374.82625173748, 17533.73699394507, 17730.911345443255, 17738.0, 17861.464156075304, 4741.691790033654, 4907.68100073494, 4922.55696987271, 4927.827526036589, 4930.506949305059, 3737.5514938207452, 5033.169527028036, 5111.233315002761, 5112.437631860493, 5580.218769372291, 5827.854303642401, 5912.763489460438, 5927.88144237115, 5935.050391937291, 5937.050071988483, 5732.828015159552, 5887.293524777054, 5916.319623243317, 5946.613470124428, 5950.047992321208, 5286.973565132188, 5290.603204759658, 5294.788208471657, 5298.496642818965, 5301.7084060376665, 20725.792742072535, 21338.679919801216, 21369.252076177258, 21384.35846924579, 21571.784282157136, 1963.1950900131021, 1972.9901350493155, 1974.7037944308468, 1985.2952201968237, 2103.831693464519, 12984.805227921588, 13248.337583120805, 13441.462341506329, 14184.787228191586, 14346.856531434656, 1663.376233912283, 1747.973780393295, 1753.7457068725091, 1773.9822601773947, 1816.527702797269, 69890.30109698889, 70860.0, 71402.0, 72194.63902680506, 73833.0, 9796.559154838049, 9823.214142868554, 9845.471083301618, 9853.0, 10082.74793130163, 13718.725625487434, 13752.587422377144, 13765.793513097111, 13772.20961275048, 13779.379927903068, 7282.745103921337, 7310.671019804122, 7510.624468776539, 7526.397888168934, 7562.621868906533, 7002.369786719118, 7010.228874823765, 7151.348430515363, 7295.306945840137, 7323.707051717978, 6172.672875331825, 6182.938170618237, 6267.310595834455, 6305.117283580303, 6320.873582528324, 1779.2349289805509, 1779.741937419093, 1818.4635532517675, 1821.3261093395263, 1821.9908900455678, 830.7175560309523, 834.2575108153748, 874.9562521874008, 905.2848249882651, 909.0, 15595.688086238211, 16873.156342182843, 16951.152442377832, 17401.129943503027, 17927.462176134737, 845.3659755183612, 850.5237067242364, 876.8684697295329, 901.9278457723498, 926.8470702334039, 9532.618695252113, 9712.514374281258, 10613.416262105504, 10788.838167427339, 10846.67459976202, 412147.0, 414060.0, 414450.0, 415075.0, 415730.0, 52472.737636311576, 60894.69552652208, 87696.0, 87753.56123219343, 88801.0, 408.3976135200615, 424.64117820441675, 425.3109961861742, 426.55212027370516, 428.7727504422661, 9467.090259035496, 9621.470819105016, 9955.452450115023, 10140.695779126638, 10210.864599837078, 37363.0, 37371.81314093412, 37797.24405511819, 38359.42460863033, 38569.0, 52719.36403179902, 53784.73107634437, 55074.17388739252, 55358.72320638371, 55840.720796395755, 7216.206217316196, 7260.491765576359, 7273.563586184846, 7453.440991925736, 7518.398528117628, 9261.259099272176, 10527.842082368923, 11040.613578525034, 11049.834252486058, 11375.0, 9869.457179855177, 9967.352122112039, 10337.17302615774, 10392.22058345612, 10582.629607963992, 10208.54061567246, 10307.433091179757, 10329.483525823529, 10597.47012649349, 10729.088027517748, 10102.747431314276, 10259.58961641526, 10317.638882639072, 10668.413237272025, 10759.462026898467, 7514.586697731677, 7795.142534321333, 7805.882911756442, 7998.320142787696, 8107.594620269081, 9706.757331066497, 9808.0, 9943.801123977624, 10025.398476091457, 10128.0], "value": 8171.940360697956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.8189212564173, 1307.091571357906, 1384.466980212618, 1400.649837540615, 1686.089511663701, 6700.631465269408, 7303.963480182599, 7610.124835643903, 7612.124605670349, 7641.541507509546, 7326.816829579263, 7468.290512401327, 7485.214052524489, 7714.382849372051, 7718.961405192967, 2152.9569408611856, 2198.0658220256405, 2198.2416066457045, 2204.195468653938, 2205.0628482894786, 2158.6222411077997, 2190.76996915324, 2210.778922107784, 2217.6008318502663, 2218.245796429214, 2185.573813106445, 2197.2529340024466, 2202.317281642696, 2209.9558008839813, 2220.04538048639, 2130.3928380411585, 2131.07298325229, 2131.9766512074216, 2146.9570608587896, 2150.193677370986, 2106.6208082545136, 2159.812103343155, 2160.2655097266847, 2160.34109596573, 2183.967240491394, 7473.626318684044, 7539.886901696479, 7631.3894888408795, 7660.885086723703, 7674.616269186518, 4548.317752337143, 4744.644151688637, 4754.358161648168, 4755.381800365965, 4759.167145749515, 2796.300924768808, 2950.6754257031707, 2978.3894301668106, 2988.716071973181, 2997.6552696439753, 875.4047247871445, 884.2660591708866, 887.2680038967877, 904.656230632362, 906.5947780939583, 10161.0, 10384.37693738378, 10384.428856412818, 10391.948040259826, 10392.584296628125, 4041.4341992121126, 4197.916041679149, 4340.500842403101, 4354.455693038371, 4433.800478978454, 8903.33225008127, 8914.0, 8914.465132092095, 8917.687880924137, 8933.0, 4704.5765881070865, 4707.741074240949, 4708.270218116198, 4710.105080034851, 4711.74085425298, 3724.8137593120778, 4098.6516146127915, 4258.659307255412, 4287.528371879153, 4293.849715259951, 3716.832742526593, 3762.793046382475, 3840.6543411092575, 3842.289176502356, 3854.4989151410136, 1180.7048237940514, 1222.7004383925816, 1225.209739717877, 1230.2618428942742, 1237.5359240284893, 788.9921100788919, 807.5800583696563, 809.3323008517996, 815.6533473273954, 816.7427260413069, 4906.656534042654, 4930.457649658535, 4969.850904472872, 5018.24726291052, 5157.174852023658, 406.69091490467457, 423.39031794216845, 424.60723830456703, 426.1285670803215, 431.2905270829468, 3313.337332533503, 3344.9331013379597, 3349.112485191426, 3381.847816848248, 3575.6245594212232, 9305.069493050776, 9684.41893486393, 9707.271954603433, 9724.611015559298, 9749.463779492055, 9589.472579008221, 9590.184834289024, 9606.0, 9606.615735370508, 9608.423494590346, 7177.282271772781, 7290.526115802456, 7351.154617218981, 7373.926260737431, 7380.557166570023, 4992.525710057539, 5077.695338279715, 5132.97433512845, 5164.7417629119145, 5256.500632439912, 8717.564121793757, 8906.554672266491, 8918.821623567363, 8919.821603568022, 8985.101489850962, 8940.552972351226, 8961.327900407365, 9163.49600771964, 9167.49578773174, 9184.678536251198, 5943.702814859326, 6418.326075762165, 6638.0, 6713.56361836479, 6728.461723062242, 7225.385842203472, 7518.323350898227, 7534.698612055457, 7535.623218839146, 7546.773596792105, 6646.567973081735, 6694.966525167343, 6711.161104861892, 6900.551464155014, 6924.3421874921805, 6365.363463653597, 6588.209414870246, 6593.934060659524, 6608.471322294301, 6673.899891501728, 5674.347450043298, 5757.683327417032, 5759.2512973313205, 5759.539236861125, 5766.625169363978, 4128.649064829403, 4138.0, 4205.5373908870615, 4254.680898932531, 4278.65770738334, 4177.665786736993, 4280.59334363235, 4300.548442413627, 4314.633256173135, 4485.259932111165], "value": 3998.497885522385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.97942144049927, 300.67076551176456, 302.9984850075749, 304.12867135656353, 309.42910330440327, 4786.4974177711365, 4831.0, 4872.658913876021, 4894.388201474816, 4902.8774280643, 4815.470298267197, 4823.118983596391, 4848.248521479168, 4850.563449289563, 4856.39295088114, 3666.6333366663252, 3688.686461650763, 3711.610280920505, 3804.5624753153465, 3844.596317386669, 3834.6357096075826, 3835.386338185891, 3853.344931361675, 3857.614238576148, 3857.691384689218, 3821.522309711286, 3829.48301979232, 3829.5213098362706, 3838.3282925488065, 3843.3466310727244, 3567.8037707926055, 3684.355237833382, 3788.147666774981, 3792.829322680486, 3863.8987888451798, 3355.8825441109443, 3360.8487618057247, 3368.776607439103, 3370.0226934189054, 3387.5088112223834, 4662.743549104832, 4676.929846052312, 4685.88285292867, 4692.36653051837, 4709.740964246965, 4238.7456752594635, 4364.847230346954, 4367.71609845359, 4368.694191406603, 4371.475422949235, 5010.72441015744, 5011.298418221452, 5018.2974383586325, 5027.170516864713, 5030.949690503085, 3655.4882316475714, 3657.0674478008204, 3658.719448193111, 3683.852645894188, 3689.9705162160703, 5072.619553533463, 5227.137522308814, 5290.867728306785, 5302.496262855061, 5305.14319988005, 3714.220013797079, 3754.9061273467837, 3756.6806821420487, 3783.0, 3783.05423644089, 3792.0140763401714, 3812.7331086823656, 3814.771113733185, 3835.827387767557, 3842.634949679776, 4312.633426158749, 4329.891752706208, 4330.133973205371, 4333.891652708708, 4334.176506463762, 4836.975815120902, 5065.214891691794, 5066.847994560169, 5102.642815002989, 5112.36095488064, 1270.7140893299118, 1280.961571152867, 1284.441268048402, 1284.4862055178003, 1289.9806502902463, 812.6140083460309, 830.5930094253772, 838.8172676526069, 850.9404341696022, 853.6713365354259, 4091.693123015726, 4145.7719825409895, 4289.120730250291, 4386.8025938832825, 4443.4445694288215, 5135.537801597874, 5161.483851614808, 5194.818181363634, 5224.346956630421, 5242.554382877422, 4417.955820441754, 4444.355568442557, 4450.35469856869, 4471.8658440246845, 4486.798094085774, 2611.6213149093273, 2707.998040724905, 2745.203890871665, 2747.5191841427672, 2765.764909982634, 4873.26900964851, 4899.387576552931, 4904.166291730415, 4913.140200464904, 4919.90160196794, 5350.839474815762, 5385.438222915389, 5386.622936394415, 5392.676439413648, 5417.968261901787, 4671.6262698984, 4870.829520966749, 4894.730789806595, 4919.704817710877, 4945.664670538934, 5190.6107041971245, 5241.842744717665, 5253.562562747538, 5299.0, 5336.412994570672, 5272.3128598848, 5275.525202731773, 5275.683458992473, 5281.55106815925, 5282.762275697526, 4700.835470758507, 4883.724414127829, 4934.950650493449, 4938.283948827472, 4949.886275587964, 3701.7408781385043, 3713.832877520464, 3731.5708693500596, 3762.2475504899676, 3766.962330376661, 5328.413874473882, 5335.973320133375, 5337.092694241911, 5338.0, 5343.7862485500145, 4968.4286307075145, 5065.620078494054, 5100.285959965534, 5105.6426050177615, 5106.514881086439, 5087.618428617942, 5103.642745007963, 5148.150555158357, 5174.27560141588, 5181.55956743666, 4991.800525556773, 5069.670471419346, 5071.2139618359215, 5079.593632509316, 5087.542121209109, 4898.363212782316, 5018.197088465828, 5081.4918508148885, 5134.8973020540125, 5198.298229738937, 4797.616190704805, 4953.851384458472, 4968.112117395511, 5018.0, 5039.344885165052], "value": 3831.923142282023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5389027107497, 584.5995493087235, 638.7636574467448, 642.765672357615, 661.2792056658244, 11682.941585292072, 12125.939370303136, 12198.69503262419, 12332.876671233285, 12348.567800126997, 11839.0, 11864.406779661003, 11921.701957451069, 11925.105617078732, 11972.880271197286, 762.3443838299058, 770.8612449759041, 780.0366547314063, 781.1290411191537, 782.5070205770356, 633.9397757213058, 748.9475736698433, 779.9493032952869, 782.8277778888636, 787.5117427195147, 810.7891948093479, 812.6668066092903, 813.4631143445328, 813.5728742410223, 813.6094674556217, 810.7446154461326, 811.0956283743642, 811.9391045671568, 812.7277362083709, 813.5444151275275, 486.8734129126417, 575.9625624334404, 588.2176704982363, 591.9852003699899, 592.2478452365515, 12647.936760316139, 12677.936610316981, 12685.17546359493, 12698.873011269954, 12711.491540338375, 11293.774124517546, 11375.829362559569, 11465.656030319104, 11468.770624587461, 11893.643190704293, 11331.263467874562, 11457.439899257826, 11522.974597963257, 11685.649430517098, 12001.939990299992, 4117.279476091672, 4126.484189476316, 4130.318497447917, 4224.957750422487, 4246.426732391118, 53517.0, 55250.17124743132, 55417.89164216693, 61242.69378653123, 64462.03306950446, 9311.953440232755, 9458.479783611967, 9700.854487182698, 9731.41611503312, 9735.70792876215, 17821.73267400964, 17828.3760068397, 17832.197551110232, 17842.286308547773, 17903.37338193157, 6157.876842463125, 6454.419102280817, 6544.640044797487, 6826.283240259801, 6980.197277313073, 3343.6656334366367, 3377.7128944040032, 3457.0493114393744, 3485.5991560970306, 3489.668481494254, 2687.032668239432, 2790.1908446550274, 2792.427552351763, 2797.482465743803, 2798.5802129680305, 498.2551086126192, 506.9619778516626, 510.6425502148511, 518.4892880512692, 524.9685018898879, 503.8362532177057, 532.8774381892109, 581.5551103405897, 608.2457752387008, 622.0575827621067, 7399.149097853708, 7799.571023593643, 7935.325497332791, 8101.6354264058255, 8216.383771217183, 502.8717676992417, 564.305903738404, 577.9364269930304, 592.1473078766562, 597.5309382135003, 3522.700570451489, 3631.5460567429072, 3751.2122454284904, 3757.1734218471893, 3963.960360396359, 64113.0, 109732.4513377428, 110271.44864275627, 112318.0, 112971.0, 83460.16539834524, 85274.57362713147, 85421.0, 85805.57097214473, 87421.5628921864, 48770.5122948766, 75247.0, 78888.0, 82763.17236827675, 84358.57820710857, 7158.642067896689, 7187.209406965334, 7224.566526008456, 7389.852202956018, 7452.962735186289, 33548.161295967795, 37103.81448092742, 46140.30789538092, 46628.7668561655, 46859.76570117127, 54202.0, 56282.0, 56869.146962794766, 57239.0, 60764.39235607587, 10552.894471055499, 10966.287191332538, 10990.505427255634, 10991.395473249047, 11218.887811121784, 12059.457324420599, 12066.939665301617, 12085.335306558223, 12109.455074521491, 12224.327661978321, 10562.26064175531, 10774.676759697222, 11498.712532186428, 11586.76826463483, 11773.88226117728, 10657.0, 10890.29213101146, 11157.44212789341, 11503.76992460163, 11710.765784684429, 10994.945025274823, 11085.445727713743, 11171.608993685182, 11672.416379181177, 11704.297742135499, 8829.955850220707, 8969.50667713282, 9492.778097868439, 9822.65620703272, 10031.097201251923, 8291.670408845543, 8571.057183709912, 8881.111888811325, 8982.461052336881, 9005.954970225106], "value": 6335.143246140576, "unit": "score"}], "name": "dromaeo_css", "value": 6335.613403541282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 114.0, 115.0, 114.0, 117.0, 114.0, 113.0, 113.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 130.0, 197.0, 128.0, 122.0, 148.0, 127.0, 179.0, 130.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 133.0, 77.0, 76.0, 75.0, 76.0, 102.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 109.0, 85.0, 85.0, 85.0, 126.0, 85.0, 86.0, 129.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "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, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 88.0, 78.0, 80.0, 90.0, 81.0, 80.0, 80.0, 80.0, 86.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 137.0, 137.0, 134.0, 127.0, 140.0, 136.0, 128.0, 176.0, 126.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 169.0, 166.0, 166.0, 165.0, 166.0, 165.0, 166.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 67.0, 66.0, 65.0, 70.0, 65.0, 65.0, 64.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1538.2, "alertThreshold": 2.0}]} 12:58:37 INFO - Return code: 0 12:58:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:58:37 INFO - # TBPL SUCCESS # 12:58:37 INFO - Running post-action listener: _resource_record_post_action 12:58:37 INFO - [mozharness: 2016-07-29 19:58:37.154209Z] Finished run-tests step (success) 12:58:37 INFO - Running post-run listener: _resource_record_post_run 12:58:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 553078784; Read time: 0; Write time: 454168 12:58:37 INFO - TinderboxPrint: CPU usage
13.0% 12:58:37 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:58:37 INFO - TinderboxPrint: I/O write bytes / time
553,078,784 / 454,168 12:58:37 INFO - TinderboxPrint: CPU idle
8,335.2 (87.0%) 12:58:37 INFO - TinderboxPrint: CPU user
1,198.8 (12.5%) 12:58:37 INFO - TinderboxPrint: Swap in / out
0 / 0 12:58:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264359936; Read time: 0; Write time: 278992 12:58:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288718848; Read time: 0; Write time: 175176 12:58:37 INFO - Running post-run listener: _upload_blobber_files 12:58:37 INFO - Blob upload gear active. 12:58:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:58:37 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 12:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:58:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:58:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:58:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:43 INFO - (blobuploader) - INFO - Done attempting. 12:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:44 INFO - (blobuploader) - INFO - Done attempting. 12:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:58:44 INFO - (blobuploader) - INFO - Done attempting. 12:58:44 INFO - (blobuploader) - INFO - Iteration through files over. 12:58:45 INFO - Return code: 0 12:58:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:58:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:58:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3b072d4b761f0672afcda95c330e141f1f81672125dce52b370e82f413210f702b0cd930c3a829f963c2048cab6d1ae37ad85e6059a403922c2b14f7550985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa287f67c9242d6ac04b38d0debfbe758c6d8dfec163726134be19557a2f2cf6ef11810097775405a17d30eb019014d0dc380de9737919b04959a48c5cdc480c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/697134f84f302379b4cc7a7493aaf7d886120839545d13e4b447f9d7b7384e57a00ace96fc19807206ea58af6a001f0c39cbd0fa979f3103437466228b7152a9"} 12:58:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:58:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:58:45 INFO - Contents: 12:58:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3b072d4b761f0672afcda95c330e141f1f81672125dce52b370e82f413210f702b0cd930c3a829f963c2048cab6d1ae37ad85e6059a403922c2b14f7550985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa287f67c9242d6ac04b38d0debfbe758c6d8dfec163726134be19557a2f2cf6ef11810097775405a17d30eb019014d0dc380de9737919b04959a48c5cdc480c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/697134f84f302379b4cc7a7493aaf7d886120839545d13e4b447f9d7b7384e57a00ace96fc19807206ea58af6a001f0c39cbd0fa979f3103437466228b7152a9"} 12:58:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:58:45 INFO - Copying logs to upload dir... 12:58:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:58:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.228081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-29 12:58:44.773636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 12:58:44.777774) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3b072d4b761f0672afcda95c330e141f1f81672125dce52b370e82f413210f702b0cd930c3a829f963c2048cab6d1ae37ad85e6059a403922c2b14f7550985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa287f67c9242d6ac04b38d0debfbe758c6d8dfec163726134be19557a2f2cf6ef11810097775405a17d30eb019014d0dc380de9737919b04959a48c5cdc480c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/697134f84f302379b4cc7a7493aaf7d886120839545d13e4b447f9d7b7384e57a00ace96fc19807206ea58af6a001f0c39cbd0fa979f3103437466228b7152a9"} build_url:https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/L5AyuK8UQz6hcOgv3CoGOg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bf3b072d4b761f0672afcda95c330e141f1f81672125dce52b370e82f413210f702b0cd930c3a829f963c2048cab6d1ae37ad85e6059a403922c2b14f7550985", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa287f67c9242d6ac04b38d0debfbe758c6d8dfec163726134be19557a2f2cf6ef11810097775405a17d30eb019014d0dc380de9737919b04959a48c5cdc480c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/697134f84f302379b4cc7a7493aaf7d886120839545d13e4b447f9d7b7384e57a00ace96fc19807206ea58af6a001f0c39cbd0fa979f3103437466228b7152a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 12:58:44.807098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:58:44.807457) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1469820953.540240-1322466854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 12:58:44.891634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 12:58:44.892016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 12:58:44.892433) ========= ========= Total master_lag: 0.21 =========