builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1464832892.78 results: success (0) buildid: 20160601163010 builduid: 38d364c38cee4182b8ea3c8422008336 revision: 22047a4eea784c15026c77911c0bd6ea1b70fa68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.777097) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.777621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.777910) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.802059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.802395) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 19:01:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-06-01 19:01:33 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114860 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.944263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.944607) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018970 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:32.996579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 19:01:32.996958) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22047a4eea784c15026c77911c0bd6ea1b70fa68 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 22047a4eea784c15026c77911c0bd6ea1b70fa68 --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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 19:01:33,221 truncating revision to first 12 chars 2016-06-01 19:01:33,221 Setting DEBUG logging. 2016-06-01 19:01:33,221 attempt 1/10 2016-06-01 19:01:33,221 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22047a4eea78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 19:01:34,375 unpacking tar archive at: mozilla-central-22047a4eea78/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 19:01:34.503822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:34.504164) ========= script_repo_revision: 22047a4eea784c15026c77911c0bd6ea1b70fa68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:34.504588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:34.504870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 19:01:34.514637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-01 19:01:34.514956) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:01:34 INFO - MultiFileLogger online at 20160601 19:01:34 in /builds/slave/test 19:01:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:01:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:01:34 INFO - {'append_to_log': False, 19:01:34 INFO - 'base_work_dir': '/builds/slave/test', 19:01:34 INFO - 'blob_upload_branch': 'Firefox', 19:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:01:34 INFO - 'branch': 'Firefox', 19:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:01:34 INFO - 'config_files': ('talos/linux_config.py',), 19:01:34 INFO - 'default_actions': ('clobber', 19:01:34 INFO - 'read-buildbot-config', 19:01:34 INFO - 'download-and-extract', 19:01:34 INFO - 'populate-webroot', 19:01:34 INFO - 'create-virtualenv', 19:01:34 INFO - 'install', 19:01:34 INFO - 'run-tests'), 19:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:01:34 INFO - 'download_minidump_stackwalk': True, 19:01:34 INFO - 'download_symbols': 'ondemand', 19:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:01:34 INFO - 'installer_path': 'installer.exe', 19:01:34 INFO - 'log_level': 'info', 19:01:34 INFO - 'log_name': 'talos', 19:01:34 INFO - 'log_to_console': True, 19:01:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:01:34 INFO - 'opt_config_files': (), 19:01:34 INFO - 'pip_index': False, 19:01:34 INFO - 'sps_profile': False, 19:01:34 INFO - 'sps_profile_interval': 0, 19:01:34 INFO - 'suite': 'dromaeojs-e10s', 19:01:34 INFO - 'system_bits': '32', 19:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:01:34 INFO - 'title': 'talos-linux64-ix-005', 19:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:01:34 INFO - 'use_talos_json': True, 19:01:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:01:34 INFO - 'work_dir': 'build'} 19:01:34 INFO - ##### 19:01:34 INFO - ##### Running clobber step. 19:01:34 INFO - ##### 19:01:34 INFO - Running pre-action listener: _resource_record_pre_action 19:01:34 INFO - Running main action method: clobber 19:01:34 INFO - rmtree: /builds/slave/test/build 19:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:01:35 INFO - Running post-action listener: _resource_record_post_action 19:01:35 INFO - ##### 19:01:35 INFO - ##### Finished clobber step (success) 19:01:35 INFO - ##### 19:01:35 INFO - ##### 19:01:35 INFO - ##### Running read-buildbot-config step. 19:01:35 INFO - ##### 19:01:35 INFO - Running pre-action listener: _resource_record_pre_action 19:01:35 INFO - Running main action method: read_buildbot_config 19:01:35 INFO - Using buildbot properties: 19:01:35 INFO - { 19:01:35 INFO - "project": "", 19:01:35 INFO - "product": "firefox", 19:01:35 INFO - "script_repo_revision": "production", 19:01:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:01:35 INFO - "repository": "", 19:01:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:01:35 INFO - "buildid": "20160601163010", 19:01:35 INFO - "pgo_build": "True", 19:01:35 INFO - "basedir": "/builds/slave/test", 19:01:35 INFO - "buildnumber": 54, 19:01:35 INFO - "slavename": "talos-linux64-ix-005", 19:01:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:01:35 INFO - "platform": "ubuntu64_hw", 19:01:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:01:35 INFO - "branch": "mozilla-central", 19:01:35 INFO - "repo_path": "mozilla-central", 19:01:35 INFO - "revision": "22047a4eea784c15026c77911c0bd6ea1b70fa68", 19:01:35 INFO - "stage_platform": "linux64-pgo", 19:01:35 INFO - "builduid": "38d364c38cee4182b8ea3c8422008336", 19:01:35 INFO - "slavebuilddir": "test" 19:01:35 INFO - } 19:01:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:01:35 INFO - Running post-action listener: _resource_record_post_action 19:01:35 INFO - ##### 19:01:35 INFO - ##### Finished read-buildbot-config step (success) 19:01:35 INFO - ##### 19:01:35 INFO - ##### 19:01:35 INFO - ##### Running download-and-extract step. 19:01:35 INFO - ##### 19:01:35 INFO - Running pre-action listener: _resource_record_pre_action 19:01:35 INFO - Running main action method: download_and_extract 19:01:35 INFO - mkdir: /builds/slave/test/build/tests 19:01: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')]} 19:01:35 INFO - https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:01:36 INFO - Downloaded 1361 bytes. 19:01:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:01:36 INFO - Using the following test package requirements: 19:01:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:01:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:01:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'jsshell-linux-x86_64.zip'], 19:01:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:01:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:01:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:01:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:01:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:01:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:01:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:01:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:01: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')]} 19:01:36 INFO - https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:37 INFO - Downloaded 24422567 bytes. 19:01:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:01:39 INFO - Return code: 0 19:01:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:01:39 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')]} 19:01:39 INFO - https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:01:51 INFO - Downloaded 24422567 bytes. 19:01:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:01:53 INFO - Return code: 0 19:01: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')]} 19:01:53 INFO - https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:01:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:01:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:01:54 INFO - Downloaded 10834055 bytes. 19:01:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:01:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:01:54 INFO - Return code: 0 19:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:54 INFO - https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:01:55 INFO - Downloaded 59024182 bytes. 19:01:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:55 INFO - mkdir: /builds/slave/test/properties 19:01:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:01:55 INFO - Writing to file /builds/slave/test/properties/build_url 19:01:55 INFO - Contents: 19:01:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:01:56 INFO - Running post-action listener: _resource_record_post_action 19:01:56 INFO - Running post-action listener: set_extra_try_arguments 19:01:56 INFO - ##### 19:01:56 INFO - ##### Finished download-and-extract step (success) 19:01:56 INFO - ##### 19:01:56 INFO - ##### 19:01:56 INFO - ##### Running populate-webroot step. 19:01:56 INFO - ##### 19:01:56 INFO - Running pre-action listener: _resource_record_pre_action 19:01:56 INFO - Running main action method: populate_webroot 19:01:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:01:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:01:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:01:56 INFO - '--tppagecycles', 19:01:56 INFO - '7'], 19:01:56 INFO - 'tests': ['tsvgm']}}, 19:01:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:01:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:01:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:01:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:01:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:01:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['damp', 'tps']}, 19:01:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'tests': ['damp', 'tps']}, 19:01:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['dromaeo_dom']}, 19:01:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:01:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'other-e10s': {'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['a11yr', 19:01:56 INFO - 'ts_paint', 19:01:56 INFO - 'tpaint', 19:01:56 INFO - 'sessionrestore', 19:01:56 INFO - 'sessionrestore_no_auto_restore', 19:01:56 INFO - 'tabpaint']}, 19:01:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['tsvgx', 19:01:56 INFO - 'tsvgr_opacity', 19:01:56 INFO - 'tart', 19:01:56 INFO - 'tscrollx', 19:01:56 INFO - 'cart']}, 19:01:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:01:56 INFO - 'tsvgr_opacity', 19:01:56 INFO - 'tart', 19:01:56 INFO - 'tscrollx', 19:01:56 INFO - 'cart']}, 19:01:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'talos_options': ['--disable-e10s'], 19:01:56 INFO - 'tests': ['tp5o']}, 19:01:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'tests': ['tp5o']}, 19:01:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'talos_options': ['--disable-e10s', 19:01:56 INFO - '--xperf_path', 19:01:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:56 INFO - 'tests': ['tp5n']}, 19:01:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:01:56 INFO - 'talos_options': ['--xperf_path', 19:01:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:01:56 INFO - 'tests': ['tp5n']}}, 19:01:56 INFO - 'talos.zip': {'path': '', 19:01:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:01:56 INFO - Running post-action listener: _resource_record_post_action 19:01:56 INFO - ##### 19:01:56 INFO - ##### Finished populate-webroot step (success) 19:01:56 INFO - ##### 19:01:56 INFO - ##### 19:01:56 INFO - ##### Running create-virtualenv step. 19:01:56 INFO - ##### 19:01:56 INFO - Running pre-action listener: _resource_record_pre_action 19:01:56 INFO - Running main action method: create_virtualenv 19:01:56 INFO - Creating virtualenv /builds/slave/test/build/venv 19:01:56 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 19:01:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:01:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:01:56 INFO - Using real prefix '/usr' 19:01:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:01:57 INFO - Installing distribute.............................................................................................................................................................................................done. 19:01:59 INFO - Installing pip.................done. 19:01:59 INFO - Return code: 0 19:01:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:01:59 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')]} 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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')]} 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:01:59 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 19:01:59 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 19:01:59 INFO - Using env: {'DISPLAY': ':0', 19:01:59 INFO - 'HOME': '/home/cltbld', 19:01:59 INFO - 'LANG': 'en_US.UTF-8', 19:01:59 INFO - 'LANGUAGE': 'en_US:en', 19:01:59 INFO - 'LOGNAME': 'cltbld', 19:01:59 INFO - 'MAIL': '/var/mail/cltbld', 19:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:59 INFO - 'MOZ_NO_REMOTE': '1', 19:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:59 INFO - 'NO_EM_RESTART': '1', 19:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:59 INFO - 'PWD': '/builds/slave/test', 19:01:59 INFO - 'SHELL': '/bin/bash', 19:01:59 INFO - 'SHLVL': '1', 19:01:59 INFO - 'TERM': 'linux', 19:01:59 INFO - 'TMOUT': '86400', 19:01:59 INFO - 'USER': 'cltbld', 19:01:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:59 INFO - '_': '/tools/buildbot/bin/python'} 19:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:59 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 19:01:59 INFO - Cleaning up... 19:01:59 INFO - Return code: 0 19:01:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:01:59 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')]} 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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')]} 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:59 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:01:59 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 19:01:59 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 19:01:59 INFO - Using env: {'DISPLAY': ':0', 19:01:59 INFO - 'HOME': '/home/cltbld', 19:01:59 INFO - 'LANG': 'en_US.UTF-8', 19:01:59 INFO - 'LANGUAGE': 'en_US:en', 19:01:59 INFO - 'LOGNAME': 'cltbld', 19:01:59 INFO - 'MAIL': '/var/mail/cltbld', 19:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:59 INFO - 'MOZ_NO_REMOTE': '1', 19:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:59 INFO - 'NO_EM_RESTART': '1', 19:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:59 INFO - 'PWD': '/builds/slave/test', 19:01:59 INFO - 'SHELL': '/bin/bash', 19:01:59 INFO - 'SHLVL': '1', 19:01:59 INFO - 'TERM': 'linux', 19:01:59 INFO - 'TMOUT': '86400', 19:01:59 INFO - 'USER': 'cltbld', 19:01:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:59 INFO - '_': '/tools/buildbot/bin/python'} 19:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:59 INFO - Downloading/unpacking psutil>=3.1.1 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:01 INFO - Installing collected packages: psutil 19:02:01 INFO - Running setup.py install for psutil 19:02:01 INFO - building 'psutil._psutil_linux' extension 19:02:01 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 19:02:02 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 19:02:02 INFO - building 'psutil._psutil_posix' extension 19:02:02 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 19:02:02 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 19:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:02 INFO - Successfully installed psutil 19:02:02 INFO - Cleaning up... 19:02:02 INFO - Return code: 0 19:02:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:02 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:02 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 19:02:02 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 19:02:02 INFO - Using env: {'DISPLAY': ':0', 19:02:02 INFO - 'HOME': '/home/cltbld', 19:02:02 INFO - 'LANG': 'en_US.UTF-8', 19:02:02 INFO - 'LANGUAGE': 'en_US:en', 19:02:02 INFO - 'LOGNAME': 'cltbld', 19:02:02 INFO - 'MAIL': '/var/mail/cltbld', 19:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:02 INFO - 'MOZ_NO_REMOTE': '1', 19:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:02 INFO - 'NO_EM_RESTART': '1', 19:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:02 INFO - 'PWD': '/builds/slave/test', 19:02:02 INFO - 'SHELL': '/bin/bash', 19:02:02 INFO - 'SHLVL': '1', 19:02:02 INFO - 'TERM': 'linux', 19:02:02 INFO - 'TMOUT': '86400', 19:02:02 INFO - 'USER': 'cltbld', 19:02:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:02 INFO - '_': '/tools/buildbot/bin/python'} 19:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:02 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 19:02:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:02:04 INFO - Installing collected packages: mozsystemmonitor 19:02:04 INFO - Running setup.py install for mozsystemmonitor 19:02:04 INFO - Successfully installed mozsystemmonitor 19:02:04 INFO - Cleaning up... 19:02:04 INFO - Return code: 0 19:02:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:04 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:04 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 19:02:04 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 19:02:04 INFO - Using env: {'DISPLAY': ':0', 19:02:04 INFO - 'HOME': '/home/cltbld', 19:02:04 INFO - 'LANG': 'en_US.UTF-8', 19:02:04 INFO - 'LANGUAGE': 'en_US:en', 19:02:04 INFO - 'LOGNAME': 'cltbld', 19:02:04 INFO - 'MAIL': '/var/mail/cltbld', 19:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:04 INFO - 'MOZ_NO_REMOTE': '1', 19:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:04 INFO - 'NO_EM_RESTART': '1', 19:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:04 INFO - 'PWD': '/builds/slave/test', 19:02:04 INFO - 'SHELL': '/bin/bash', 19:02:04 INFO - 'SHLVL': '1', 19:02:04 INFO - 'TERM': 'linux', 19:02:04 INFO - 'TMOUT': '86400', 19:02:04 INFO - 'USER': 'cltbld', 19:02:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:04 INFO - '_': '/tools/buildbot/bin/python'} 19:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:04 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:06 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02:06 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 19:02:06 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 19:02:06 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 19:02:06 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 19:02:06 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 19:02:06 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 19:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:07 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 19:02:07 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 19:02:07 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 19:02:07 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 19:02:07 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 19:02:07 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 19:02:07 INFO - Downloading docopt-0.6.1.tar.gz 19:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:07 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:07 INFO - Running setup.py install for blobuploader 19:02:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:07 INFO - Running setup.py install for requests 19:02:07 INFO - Running setup.py install for docopt 19:02:08 INFO - Successfully installed blobuploader requests docopt 19:02:08 INFO - Cleaning up... 19:02:08 INFO - Return code: 0 19:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:08 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:08 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 19:02:08 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 19:02:08 INFO - Using env: {'DISPLAY': ':0', 19:02:08 INFO - 'HOME': '/home/cltbld', 19:02:08 INFO - 'LANG': 'en_US.UTF-8', 19:02:08 INFO - 'LANGUAGE': 'en_US:en', 19:02:08 INFO - 'LOGNAME': 'cltbld', 19:02:08 INFO - 'MAIL': '/var/mail/cltbld', 19:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:08 INFO - 'MOZ_NO_REMOTE': '1', 19:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:08 INFO - 'NO_EM_RESTART': '1', 19:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:08 INFO - 'PWD': '/builds/slave/test', 19:02:08 INFO - 'SHELL': '/bin/bash', 19:02:08 INFO - 'SHLVL': '1', 19:02:08 INFO - 'TERM': 'linux', 19:02:08 INFO - 'TMOUT': '86400', 19:02:08 INFO - 'USER': 'cltbld', 19:02:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:08 INFO - '_': '/tools/buildbot/bin/python'} 19:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:08 INFO - Running setup.py (path:/tmp/pip-JpU7Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:08 INFO - Running setup.py (path:/tmp/pip-qKZoGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:08 INFO - Running setup.py (path:/tmp/pip-j88iUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:08 INFO - Running setup.py (path:/tmp/pip-rniHAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:08 INFO - Running setup.py (path:/tmp/pip-teBkGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:08 INFO - Running setup.py (path:/tmp/pip-gIrQKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:08 INFO - Running setup.py (path:/tmp/pip-xlSuP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:08 INFO - Running setup.py (path:/tmp/pip-WzjwIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:08 INFO - Running setup.py (path:/tmp/pip-ri9pQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:08 INFO - Running setup.py (path:/tmp/pip-zvDDzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:09 INFO - Running setup.py (path:/tmp/pip-9fQ1TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:09 INFO - Running setup.py (path:/tmp/pip-9MI1X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:09 INFO - Running setup.py (path:/tmp/pip-QeFvPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:09 INFO - Running setup.py (path:/tmp/pip-qY6sWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:09 INFO - Running setup.py (path:/tmp/pip-ljeHo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:09 INFO - Running setup.py (path:/tmp/pip-4pbrWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:09 INFO - Running setup.py (path:/tmp/pip-2ul1PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:09 INFO - Running setup.py install for manifestparser 19:02:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:09 INFO - Running setup.py install for mozcrash 19:02:09 INFO - Running setup.py install for mozdebug 19:02:09 INFO - Running setup.py install for mozdevice 19:02:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:02:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:09 INFO - Running setup.py install for mozfile 19:02:10 INFO - Running setup.py install for mozhttpd 19:02:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for mozinfo 19:02:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for mozInstall 19:02:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for mozleak 19:02:10 INFO - Running setup.py install for mozlog 19:02:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for moznetwork 19:02:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for mozprocess 19:02:10 INFO - Running setup.py install for mozprofile 19:02:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:10 INFO - Running setup.py install for mozrunner 19:02:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:11 INFO - Running setup.py install for mozscreenshot 19:02:11 INFO - Running setup.py install for moztest 19:02:11 INFO - Running setup.py install for mozversion 19:02:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:11 INFO - Cleaning up... 19:02:11 INFO - Return code: 0 19:02:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:11 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 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:11 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 19:02:11 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 19:02:11 INFO - Using env: {'DISPLAY': ':0', 19:02:11 INFO - 'HOME': '/home/cltbld', 19:02:11 INFO - 'LANG': 'en_US.UTF-8', 19:02:11 INFO - 'LANGUAGE': 'en_US:en', 19:02:11 INFO - 'LOGNAME': 'cltbld', 19:02:11 INFO - 'MAIL': '/var/mail/cltbld', 19:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:11 INFO - 'MOZ_NO_REMOTE': '1', 19:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:11 INFO - 'NO_EM_RESTART': '1', 19:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:11 INFO - 'PWD': '/builds/slave/test', 19:02:11 INFO - 'SHELL': '/bin/bash', 19:02:11 INFO - 'SHLVL': '1', 19:02:11 INFO - 'TERM': 'linux', 19:02:11 INFO - 'TMOUT': '86400', 19:02:11 INFO - 'USER': 'cltbld', 19:02:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:11 INFO - '_': '/tools/buildbot/bin/python'} 19:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:11 INFO - Running setup.py (path:/tmp/pip-ZYhbbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:11 INFO - Running setup.py (path:/tmp/pip-K0sCvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:11 INFO - Running setup.py (path:/tmp/pip-15PBnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:11 INFO - Running setup.py (path:/tmp/pip-cZq7J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:11 INFO - Running setup.py (path:/tmp/pip-YKARw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:11 INFO - Running setup.py (path:/tmp/pip-UGTUXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:11 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)) 19:02:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:11 INFO - Running setup.py (path:/tmp/pip-rMlNiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:12 INFO - Running setup.py (path:/tmp/pip-eXef16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:12 INFO - Running setup.py (path:/tmp/pip-CvPhAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:12 INFO - Running setup.py (path:/tmp/pip-Fkkbxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:12 INFO - Running setup.py (path:/tmp/pip-ggGRvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:12 INFO - Running setup.py (path:/tmp/pip-xveH3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:12 INFO - Running setup.py (path:/tmp/pip-Ed9EQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:12 INFO - Running setup.py (path:/tmp/pip-9Y8kEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:12 INFO - Running setup.py (path:/tmp/pip-3XZaAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:12 INFO - Running setup.py (path:/tmp/pip-SzJcIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:12 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)) 19:02:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:12 INFO - Running setup.py (path:/tmp/pip-_X8nNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 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)) 19:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:12 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 19:02:12 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 19:02:12 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 19:02:12 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 19:02:12 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 19:02:12 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 19:02:14 INFO - Downloading blessings-1.6.tar.gz 19:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:14 INFO - Installing collected packages: blessings 19:02:14 INFO - Running setup.py install for blessings 19:02:14 INFO - Successfully installed blessings 19:02:14 INFO - Cleaning up... 19:02:14 INFO - Return code: 0 19:02:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:15 INFO - Reading from file tmpfile_stdout 19:02:15 INFO - Current package versions: 19:02:15 INFO - argparse == 1.2.1 19:02:15 INFO - blessings == 1.6 19:02:15 INFO - blobuploader == 1.2.4 19:02:15 INFO - docopt == 0.6.1 19:02:15 INFO - manifestparser == 1.1 19:02:15 INFO - mozInstall == 1.12 19:02:15 INFO - mozcrash == 0.17 19:02:15 INFO - mozdebug == 0.1 19:02:15 INFO - mozdevice == 0.48 19:02:15 INFO - mozfile == 1.2 19:02:15 INFO - mozhttpd == 0.7 19:02:15 INFO - mozinfo == 0.9 19:02:15 INFO - mozleak == 0.1 19:02:15 INFO - mozlog == 3.2 19:02:15 INFO - moznetwork == 0.27 19:02:15 INFO - mozprocess == 0.22 19:02:15 INFO - mozprofile == 0.28 19:02:15 INFO - mozrunner == 6.11 19:02:15 INFO - mozscreenshot == 0.1 19:02:15 INFO - mozsystemmonitor == 0.3 19:02:15 INFO - moztest == 0.7 19:02:15 INFO - mozversion == 1.4 19:02:15 INFO - psutil == 3.1.1 19:02:15 INFO - requests == 1.2.3 19:02:15 INFO - wsgiref == 0.1.2 19:02:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:02:15 INFO - Using env: {'DISPLAY': ':0', 19:02:15 INFO - 'HOME': '/home/cltbld', 19:02:15 INFO - 'LANG': 'en_US.UTF-8', 19:02:15 INFO - 'LANGUAGE': 'en_US:en', 19:02:15 INFO - 'LOGNAME': 'cltbld', 19:02:15 INFO - 'MAIL': '/var/mail/cltbld', 19:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:15 INFO - 'MOZ_NO_REMOTE': '1', 19:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:15 INFO - 'NO_EM_RESTART': '1', 19:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:15 INFO - 'PWD': '/builds/slave/test', 19:02:15 INFO - 'SHELL': '/bin/bash', 19:02:15 INFO - 'SHLVL': '1', 19:02:15 INFO - 'TERM': 'linux', 19:02:15 INFO - 'TMOUT': '86400', 19:02:15 INFO - 'USER': 'cltbld', 19:02:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:15 INFO - '_': '/tools/buildbot/bin/python'} 19:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:02:15 INFO - Cleaning up... 19:02:15 INFO - Return code: 0 19:02:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:02:15 INFO - Using env: {'DISPLAY': ':0', 19:02:15 INFO - 'HOME': '/home/cltbld', 19:02:15 INFO - 'LANG': 'en_US.UTF-8', 19:02:15 INFO - 'LANGUAGE': 'en_US:en', 19:02:15 INFO - 'LOGNAME': 'cltbld', 19:02:15 INFO - 'MAIL': '/var/mail/cltbld', 19:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:15 INFO - 'MOZ_NO_REMOTE': '1', 19:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:15 INFO - 'NO_EM_RESTART': '1', 19:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:15 INFO - 'PWD': '/builds/slave/test', 19:02:15 INFO - 'SHELL': '/bin/bash', 19:02:15 INFO - 'SHLVL': '1', 19:02:15 INFO - 'TERM': 'linux', 19:02:15 INFO - 'TMOUT': '86400', 19:02:15 INFO - 'USER': 'cltbld', 19:02:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:15 INFO - '_': '/tools/buildbot/bin/python'} 19:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:15 INFO - Downloading/unpacking jsonschema 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:17 INFO - Downloading/unpacking functools32 (from jsonschema) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:17 INFO - warning: no files found matching '*.txt' 19:02:17 INFO - no previously-included directories found matching 'build' 19:02:17 INFO - no previously-included directories found matching 'dist' 19:02:17 INFO - no previously-included directories found matching '.git*' 19:02:17 INFO - Installing collected packages: jsonschema, functools32 19:02:17 INFO - Running setup.py install for functools32 19:02:17 INFO - warning: no files found matching '*.txt' 19:02:17 INFO - no previously-included directories found matching 'build' 19:02:17 INFO - no previously-included directories found matching 'dist' 19:02:17 INFO - no previously-included directories found matching '.git*' 19:02:17 INFO - Successfully installed jsonschema functools32 19:02:17 INFO - Cleaning up... 19:02:17 INFO - Return code: 0 19:02:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf84259f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', '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 19:02: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', 'flake8'] in /builds/slave/test/build 19:02: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 flake8 19:02:17 INFO - Using env: {'DISPLAY': ':0', 19:02:17 INFO - 'HOME': '/home/cltbld', 19:02:17 INFO - 'LANG': 'en_US.UTF-8', 19:02:17 INFO - 'LANGUAGE': 'en_US:en', 19:02:17 INFO - 'LOGNAME': 'cltbld', 19:02:17 INFO - 'MAIL': '/var/mail/cltbld', 19:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:17 INFO - 'MOZ_NO_REMOTE': '1', 19:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:17 INFO - 'NO_EM_RESTART': '1', 19:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:17 INFO - 'PWD': '/builds/slave/test', 19:02:17 INFO - 'SHELL': '/bin/bash', 19:02:17 INFO - 'SHLVL': '1', 19:02:17 INFO - 'TERM': 'linux', 19:02:17 INFO - 'TMOUT': '86400', 19:02:17 INFO - 'USER': 'cltbld', 19:02:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:17 INFO - '_': '/tools/buildbot/bin/python'} 19:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:18 INFO - Downloading/unpacking flake8 19:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:02:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:02:19 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 19:02:19 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 19:02:19 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 19:02:19 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 19:02:19 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 19:02:19 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 19:02:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:02:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:20 INFO - no previously-included directories found matching 'docs/_build' 19:02:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:02:20 INFO - Running setup.py install for pep8 19:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:02:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:02:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:02:20 INFO - no previously-included directories found matching 'docs/_build' 19:02:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:02:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:02:20 INFO - Cleaning up... 19:02:20 INFO - Return code: 0 19:02:20 INFO - Running post-action listener: _resource_record_post_action 19:02:20 INFO - Running post-action listener: _start_resource_monitoring 19:02:20 INFO - Starting resource monitoring. 19:02:20 INFO - ##### 19:02:20 INFO - ##### Finished create-virtualenv step (success) 19:02:20 INFO - ##### 19:02:20 INFO - ##### 19:02:20 INFO - ##### Running install step. 19:02:20 INFO - ##### 19:02:20 INFO - Running pre-action listener: _resource_record_pre_action 19:02:20 INFO - Running main action method: install 19:02:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:21 INFO - Reading from file tmpfile_stdout 19:02:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:21 INFO - Reading from file tmpfile_stdout 19:02:21 INFO - Output received: 19:02:21 INFO - Usage: mozinstall [options] installer 19:02:21 INFO - Options: 19:02:21 INFO - -h, --help show this help message and exit 19:02:21 INFO - -d DEST, --destination=DEST 19:02:21 INFO - Directory to install application into. [default: 19:02:21 INFO - "/builds/slave/test"] 19:02:21 INFO - --app=APP Application being installed. [default: firefox] 19:02:21 INFO - mkdir: /builds/slave/test/build/application 19:02:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:02:38 INFO - Reading from file tmpfile_stdout 19:02:38 INFO - Output received: 19:02:38 INFO - /builds/slave/test/build/application/firefox/firefox 19:02:38 INFO - Running post-action listener: _resource_record_post_action 19:02:38 INFO - ##### 19:02:38 INFO - ##### Finished install step (success) 19:02:38 INFO - ##### 19:02:38 INFO - ##### 19:02:38 INFO - ##### Running run-tests step. 19:02:38 INFO - ##### 19:02:38 INFO - Running pre-action listener: _resource_record_pre_action 19:02:38 INFO - Running main action method: run_tests 19:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:02:38 INFO - Python 2.7.3 19:02:38 INFO - Return code: 0 19:02:38 INFO - grabbing minidump binary from tooltool 19:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:38 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 0x22419c0>, '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 0x22428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:02:38 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 19:02:38 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 19:02:38 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 19:02:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:02:38 INFO - Return code: 0 19:02:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:02:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:02:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:02:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:02:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:02:39 INFO - Return code: 0 19:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:02:39 INFO - Using env: {'DISPLAY': ':0', 19:02:39 INFO - 'HOME': '/home/cltbld', 19:02:39 INFO - 'LANG': 'en_US.UTF-8', 19:02:39 INFO - 'LANGUAGE': 'en_US:en', 19:02:39 INFO - 'LOGNAME': 'cltbld', 19:02:39 INFO - 'MAIL': '/var/mail/cltbld', 19:02:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:02:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:39 INFO - 'MOZ_NO_REMOTE': '1', 19:02:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:02:39 INFO - 'NO_EM_RESTART': '1', 19:02:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:39 INFO - 'PWD': '/builds/slave/test', 19:02:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:02:39 INFO - 'SHELL': '/bin/bash', 19:02:39 INFO - 'SHLVL': '1', 19:02:39 INFO - 'TERM': 'linux', 19:02:39 INFO - 'TMOUT': '86400', 19:02:39 INFO - 'USER': 'cltbld', 19:02:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194', 19:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:39 INFO - '_': '/tools/buildbot/bin/python'} 19:02:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:02:39 INFO - mozversion application_buildid: 20160601163010 19:02:39 INFO - mozversion application_changeset: 22047a4eea784c15026c77911c0bd6ea1b70fa68 19:02:39 INFO - mozversion application_display_name: Nightly 19:02:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:02:39 INFO - mozversion application_name: Firefox 19:02:39 INFO - mozversion application_remotingname: firefox 19:02:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:02:39 INFO - mozversion application_vendor: Mozilla 19:02:39 INFO - mozversion application_version: 49.0a1 19:02:39 INFO - mozversion platform_buildid: 20160601163010 19:02:39 INFO - mozversion platform_changeset: 22047a4eea784c15026c77911c0bd6ea1b70fa68 19:02:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:02:39 INFO - mozversion platform_version: 49.0a1 19:02:39 INFO - using testdate: 1464832959 19:02:39 INFO - actual date: 1464832959 19:02:39 INFO - starting webserver on 'localhost:56169' 19:02:39 INFO - SUITE-START | Running 2 tests 19:02:39 INFO - TEST-START | dromaeo_css 19:02:39 INFO - operating with platform_type : linux_ 19:02:39 INFO - Initialising browser for dromaeo_css test... 19:02:39 INFO - TEST-INFO | started process 14487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeaayOi/profile http://localhost:56169/getInfo.html) 19:02:43 INFO - PROCESS | 14487 | __metrics Screen width/height:1600/1200 19:02:43 INFO - PROCESS | 14487 | colorDepth:24 19:02:43 INFO - PROCESS | 14487 | Browser inner width/height: 1024/697 19:02:43 INFO - PROCESS | 14487 | __metrics 19:02:44 ERROR - PROCESS | 14487 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:02:44 INFO - TEST-INFO | 14487: exit 0 19:02:44 INFO - Browser initialized. 19:02:44 INFO - Running cycle 1/1 for dromaeo_css test... 19:02:44 INFO - TEST-INFO | started process 14605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeaayOi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:56 INFO - PROCESS | 14605 | RSS: Main: 167370752 19:02:56 INFO - PROCESS | 14605 | 19:03:46 INFO - PROCESS | 14605 | 1464833026355 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] 19:05:53 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56169/tests/dromaeo/cssquery-ext.html) 19:05:54 INFO - PROCESS | 14605 | RSS: Main: 171294720 19:05:54 INFO - PROCESS | 14605 | 19:08:56 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-ext.html (next: http://localhost:56169/tests/dromaeo/cssquery-jquery.html) 19:08:57 INFO - PROCESS | 14605 | RSS: Main: 169779200 19:08:57 INFO - PROCESS | 14605 | 19:11:58 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56169/tests/dromaeo/cssquery-mootools.html) 19:11:59 INFO - PROCESS | 14605 | RSS: Main: 171458560 19:11:59 INFO - PROCESS | 14605 | 19:15:01 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56169/tests/dromaeo/cssquery-prototype.html) 19:15:01 INFO - PROCESS | 14605 | RSS: Main: 169271296 19:15:01 INFO - PROCESS | 14605 | 19:18:04 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56169/tests/dromaeo/cssquery-yui.html) 19:18:04 INFO - PROCESS | 14605 | RSS: Main: 170749952 19:18:04 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | Cycle 1(1): loaded http://localhost:56169/tests/dromaeo/cssquery-yui.html (next: http://localhost:56169/tests/dromaeo/cssquery-dojo.html) 19:21:07 INFO - PROCESS | 14605 | RSS: Main: 171667456 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | __start_tp_report 19:21:07 INFO - PROCESS | 14605 | _x_x_mozilla_page_load 19:21:07 INFO - PROCESS | 14605 | _x_x_mozilla_page_load_details 19:21:07 INFO - PROCESS | 14605 | |i|pagename|runs| 19:21:07 INFO - PROCESS | 14605 | |0;dojo.html;3036.8329741864195;3108.3627856289463;3122.609673790776;3140.0265917565544;3149.5118256670225;5329.866753331169;5383.542398896098;5417.1603401472785;5438.374586922505;5453.263809385731;5309.41596424393;5334.5999050071205;5384.300040994675;5391.541718953894;5497;4862.805487780493;4902.730349830758;4927.728974906378;5035.546800787928;5038.395392552899;432.1636141039526;4925.187344088221;5030.622703297249;5037.874053148664;5065.088284108859;4818.879528011793;4871.7320547370055;4890.975545122287;4927.6550641455115;4972.776225069881;4914.950850491485;4941.950580494221;4950.108980383529;4957.925631115536;4984.626153038536;4920.950790492085;4928.063667903087;4947.82682606107;5006.649534532584;5013.523715247045;5309;5327.121025030865;5328.333958255218;5360.865978350534;5364.570834333244;5799.130130480419;5819.592628516006;5850.853728656775;5859.355470898197;5922;5695.800646977377;5762.567807414419;5772.07646776518;5812.941870581325;5835.095560188178;5450.400455949843;5467.234587157801;5476.315460567429;5477.1510415885605;5478.972605136989;5746.166805813134;5934.940650593482;5947.5539334550085;5948.67282299469;5949.702514874239;5600.411956744565;5641.858953526113;5642.548596112301;5656.123300888369;5664.575156863251;5689.9146512802345;5810.680412577264;5814.3313518945015;5821.2141360916585;5833.562482813721;5702.971485142548;5744.540436765049;5777.422257774189;5779.768809247583;5782.508486778671;5788.88422231553;5791.478766910998;5809;5823;5843.474087332161;4394;4420.204363214652;4422.314541246048;4428.778561071934;4454.242778727624;3870.2066076454257;3872.8063596820048;3883.456316115746;3923.313420151462;3962.128331767007;5303.284056652303;5419.729013549307;5472.480114389126;5491.039068163055;5535.363433205233;5834.533237341003;5861.3845546217035;5863.501602363847;5863.560232982543;5878.559108066912;5379.004884096376;5399.622026458111;5458.235846981426;5487.396386397493;5515.917261241085;4946.851594452172;4950;4993.27597498368;4993.90012199754;5020.146575082244;5971.701414929236;5980.401959804072;5999.100134979788;6007.189029481052;6008.669523176267;5699.74351154199;5772.999999999916;5841.269841269841;5842.094475356326;5888.528917686661;6002.159697642421;6020.909686354796;6030.758769649165;6068.120122582289;6078.179445774941;5559.63862348946;5728.112142617901;5735.569832262514;5737.225474560881;5750.712464376848;5788.27646544182;5839.970800145972;5846.649201047951;5851.64890106595;5911.172435858897;5631.88736225265;5643.1535269709875;5662.490375866192;5668.26312579362;5677.716114194356;5505.03661859181;5594.944050559442;5664.801731939362;5690.8577285566535;5701.7149142541875;5564.443555644403;5570.944290557042;5591.161325801162;5598.992181407386;5649.491545760737;5648.124540696199;5696.060150075357;5698.1737648041635;5720.3421606515785;5754.021816291157;5492.038893193595;5506.807261745819;5593.133064374865;5625.634333768292;5666.886662266814 19:21:07 INFO - PROCESS | 14605 | |1;ext.html;576.7519966414443;628.1614045249593;639.529945490065;647.2071712152614;664.5182242873914;39158.41262381067;43265;43504.56495435045;43521.56478435219;43538.56461435385;43200;43566.12867742643;43818.56181438185;43831.12337753243;43862.78068609653;8625.396222264444;8725.738227853175;8791.64833406663;8814.779630509225;8816.823663526726;8709.172628600272;8796.340274479408;8813.515256660881;8831.11688831115;8831.337649676268;8777.517236551987;8786.47281163129;8805.603747831363;8892;8895.911040889605;8802.735917922504;8816.735497935073;8836.646534138627;8842.778930526723;8865.911340886572;8763.693270735557;8810.691625793066;8818.162274583905;8868.467891926504;8870;40757.59242407568;40851.7957410214;41089.589104109175;41207.7939610303;41311.58688413107;2981.7465515431213;3425.160835595295;3603.1352475405715;3605.441156620728;3975.125472396097;29686.851565742032;30168.849155754302;30413;30438;30608;3957.0700885291935;3980.44273801668;4102.712810103294;4111.48606424197;4165.166966606661;315580;315781;316199;316488.41755791305;317849;33999.83000084984;34451;34556.30887382238;34596.82701586476;34705.82647086748;34810.12974675603;36199.81900090483;36336.81831590878;36430.453543196876;36554.8172259137;15454.227288635524;15710.214489275491;15720.842791572166;15726.13506257144;15733.921330393276;12984.285864277555;13009.414576344087;13059.21644701321;13063.216207027608;13120.540781072617;8253.752387428387;8254.174582541818;8298.834023319621;8304.875426868603;8357.8328433431;3176.650568437516;3220.4847224443974;3251.5935508061493;3260.2012506935953;3277.9672203278137;1077.7575045614674;1095.2442814457997;1099.6261271167841;1141.1726498288674;1194.952201911931;32440.513392299134;32558.34883302368;32567.67432325694;32601.836990814892;33242.3351532968;1101.1961268274044;1126.3073209975805;1153.4636394076795;1219.4939100273464;1235.839340885697;15851.841481585267;16045.518634440985;16549.83450165507;16639.584010399838;16736.24686889093;579834;592614;595414;596758;597031;56829.71585142048;58647.70676146592;58748.41251587515;58820;58871.116933246034;1383.3567391162956;1418.5531557559543;1425.0096183152816;1425.6435891027243;1435.2034620785564;29612.111636650934;30836.84581577078;31135.377292454476;31360.372792544476;31423.528647069856;49139.262911055645;50231.24653130133;50431.49568504268;50439.24341134813;50551.74724126356;490124;494779;496552;498172;498762;26877.5810177085;27010.189694309203;27074.593881091405;27186.456270874867;27258.318542036606;46175.76912115418;46884.53115468802;46972.7651361741;47126.52873471359;47753.522464776295;39015.219695606494;40078.396864126276;40267.189863559295;40568.594314057664;40618.39072413857;38781.6121838778;39053;39211.80394098011;40193.79903100466;40676;34844.477332840535;38789.224215514965;39112.60887391203;40466.79766601266;40720.38919416152;33301.50047749237;35553.28893422169;36184.63815361813;36262.4560631596;36532;27066.1880143596;27671.446571068867;27703.168904932885;27839.860800695868;27863.303417414725 19:21:07 INFO - PROCESS | 14605 | |2;jquery.html;389.57536285448873;391.5203875252815;395.28256214969826;397.9542352629445;422.8773655639865;18080.36718714845;19289.903550482264;19607.607847843035;19615.215391384347;20225.898870505665;17332.56668583283;17681.91159044206;17814.376496822613;19101.14044867981;19521.316753913616;5519.39286678465;5540.63985840921;5675.801346952858;5791.507721843648;5801.187833703285;5777.942220577783;5815.534757219433;5816.476517113459;5816.534677225833;5831.5626328025355;5493.587980901429;5630.521405680502;5657.745401456924;5662.971685141589;5771.422857714216;5604.971975140119;5623.578231632623;5625.296837895243;5626.831195064155;5642.097264437712;4938.530839570235;5193.558547523465;5231.686098834082;5237.816676416345;5258.947410525884;22769.77230227693;22820.885895570584;23280.534389312117;23585.882070589538;23605.88197059021;2338.9064437422485;2379.5478859016903;2548.5157820014138;2581.1998280532907;2613.581826907686;9396.812063758754;14287.57137285883;14364.784528232085;14583.854161458356;14858.2570871456;1933.2556965568217;2027.8986050697406;2037.276766747798;2046.069038587454;2050.507878109258;79065.20934790636;80211.5989420055;80842;81060.59469702673;81106.18893811046;10628.46857657114;10718.464076796128;10920.836187457195;10942.617008404826;11225.158113141548;14924.17917014553;14937.626559335886;15046.172460514777;15078.321475533627;15105.848941510663;8081.797955051054;8247.422680412434;8300.626471808782;8420.536870472182;8533.445326053787;8155.306798922158;8194.877076843733;8211.95894020526;8353.791155221168;8374.49753014821;4508.481524624644;4513.526079761644;4527.61515271199;4577.977110114428;4586.151561961048;1908.3893154190803;1958.2265005322818;1991.8406527478057;2041.4998325410072;2056.7017782421467;870.912908709124;958.4712383747911;1062.8777690565685;1106.773111512138;1119.1885882734953;19049.61900761977;19901.64652477735;20084;20102.09540570678;20140.89929550343;927.5686805635412;1007.9344842585208;1023.4115383654429;1082.8143183214368;1101.983470247947;10665.413402262795;11268.492917818718;11274.210805243554;11276.94361528187;11352.432378381049;474838;474939;488490;488843;490754.9792954994;84002.5799871009;88883;93681;97606.51196743971;98724.50637746765;1016.517154351677;1040.1834559870617;1058.4548957287004;1064.7338165458636;1072.5656109275756;18000.729989049913;18123.275068997093;18337;18412.815871841645;18823.34118305853;40140.59859401369;40349.79825100973;41534;42190.36714449347;42438.36342454804;57350.71324643517;58027;58640.120398194915;59023.40976590351;59425.40574594372;7287.198408174991;7630.4277179212895;7798.805029874298;8207.95896020516;8576.356773242156;9324.487153206639;12567.497300107892;13715.314234288446;13836.100653457494;13895.58313250604;5979.491743201703;10796.514156862802;11856.22934509254;11940.343281119622;11972.940135299268;11521.654350369503;11625.18623696333;11854.762904742029;11961.700957476132;12150.696232593902;12132;12273.938630306791;12391.504339826666;12396.504139834306;12449.564265250672;7361.2638736125955;8730.432521886058;8780.473171609723;8904.510251936206;8911.465312081296;10117.79764404693;11814;11977.940110299392;12079.094067944763;12385.62843114708 19:21:07 INFO - PROCESS | 14605 | |3;mootools.html;1431.1699214455614;1487.7173337065956;1615.224692147769;1755.8858674186176;1774.7781527309087;7451.329380355767;7735.535867847926;8057.274845263925;8441.240288374045;8441.577921103943;8095.554744489065;8310.958445207765;8378.581070946459;8405.655095184771;8423.115572864854;2281.977180228193;2288.2220045184636;2291.6906217660653;2312.075169932032;2314.4213946513373;2265.784750448705;2282.087165133951;2308.0767692922796;2312.2947501012186;2320.1067588978194;2239.0484044281116;2265.8074063704603;2274.2494976657663;2296.804771594408;2298.977010229893;2235.150642755759;2240.395093324801;2240.7535171131162;2244.326701989413;2245.1805091141778;2202.3392982105306;2202.757696653367;2203.3720389689024;2220.766819483947;2231.1187081102876;8160.836783264361;8287.95856020722;8289.41974061816;8336.458130221577;8344.707935222237;4868.294097355899;4991.575716064139;5024.824131155428;5024.874378140539;5026.5727413169925;3105.7981231219896;3204.8237346945907;3329.816860072695;3334.899953001414;3368.1579605098727;1120.1654767198409;1135.9091272698165;1149.149629274331;1173.284296579086;1190.8035174196248;11114.388708621023;11145.665630031112;11159.218854680257;11227.157963152797;11233.60682376121;4272.295071313199;4282.957170428318;4412.602865742035;4418.028033832552;4420.557944205618;9654;9655.179309758609;9658.32391732586;9660.71017869465;9668.419894806335;4901.754912254373;4983.50164983506;5002.024605201951;5032.622553308516;5045.445001049881;4087.2234275487563;4499.887502812456;4652.999605084923;4657.99853031593;4660.580547750718;3847.2882516734494;3878.26313000529;3908.5309762828642;3944.3294639911283;3967.504061992251;1250.9429532045408;1281.8718128187293;1291.2123604601186;1295.520657356784;1301.8633043530483;898.380117718772;1001.1090129784498;1017.3590637898077;1020.811149937264;1023.2683631203577;5886.61736987103;5944.64332140073;6000.459958603747;6014.48876845473;6153.753849846045;445.40538381261376;446.21688935917257;451.62515112456583;453.57364077766795;458.2461850256376;4090.9590904091174;4192.0777428965575;4221.071364299849;4239.448871646728;4288.270993931039;9991.650292239738;10154.339967902062;10233.385996840214;10241.641542545975;10352.585896564053;9590.136887680143;9935.254855885838;10140.797184056277;10218.540165692562;10241.795164096826;7715.845683086307;7933;7954.602269886598;7961.920380796118;7970.561619110888;5578.442155784389;5819.7963071294;5892.145638882424;5941.881162376641;5969.73136208863;8957;8969.282457403262;9140.908590914005;9151.816963660822;9158.129977652112;9052.909470905206;9425.858612120961;9428.952855235955;9563.426194428357;9681.757956051155;6754.527183097136;7204;7415.406767458699;7459.701611935462;7561.508501947355;8169.79575510617;8176.223258790405;8180.7954801130445;8189.262966333059;8206.056303524932;7226.927730722836;7360.116785985716;7503.174650788518;7510.061242344707;7678.385729141767;7254.492185547172;7293.598852063187;7332.340089391981;7378.778636640909;7492.400607951242;6726.428253598499;6822.522423430312;6834.897476537756;6835.248122706597;6839.589624622538;4865.70805751656;4895.192293271571;5069.847904562869;5109.412417572027;5147.639665223398;5212.452692467388;5297.867553311198;5323.574114070788;5330.440303768203;5360.2227676987395 19:21:07 INFO - PROCESS | 14605 | |4;prototype.html;319.89763275751756;331.5838622528727;332.4497955883013;335.09357188804285;338.9677980591843;5524.8342549723475;5603.971980140103;5684.914726279104;5755.5971082024225;5770.374479611777;5367.141257398817;5567.916481252774;5580.525655319303;5581.804636837712;5646.802361917334;4380.693351465398;4401.383806267125;4405.118976204756;4414.359917811916;4414.470263568376;4143.875683729493;4375.868723938287;4382.4741031076155;4426.494991702821;4447.599716025557;4305.26810442224;4319.287317592593;4326.961529232993;4347.261095561785;4378.562143785628;4334.739915605074;4350.456192975878;4356.891077723082;4362.803673834669;4363.3018717005125;3685.7419980601367;3776.509053823013;3794.4687743715904;3816.179521402884;3816.732828701992;5355.866103347408;5356.892862142735;5408.080626293539;5408.5402740766685;5422.755975981051;4876.317315575822;4912.231596625212;4912.9508704913205;4913.459519452857;4936.580390666798;5616.297962754656;5846.181534585119;5862.560307976919;5917.171595976567;5947.37552556984;4165.146145040259;4167.10407262437;4174.91650166995;4193.811278492475;4199.748015119103;6147.370946699084;6147.985582378902;6160.353162917919;6244.781432649836;6264.7807326743805;4082;4184.790760461965;4206.002148979211;4223.450951376301;4243.787810609457;4236.364545318227;4253.553376895444;4267.530571637118;4276.743395396224;4277.139444341721;4902.651770763068;4951.415547024917;4957.380327459067;4962.503749625009;4986.152354099811;5826.621269617462;5983.850403739854;6025.9096113558335;6027.517798576104;6057.3336932937345;1472.7113775446485;1495.5812372535706;1497.6779992301708;1502.6093215763763;1506;930.8091841172543;943.7310366545502;951.2912879904377;952.9523523823781;964.2237998411206;4932.482089380564;4983.50164983506;5014.696178993415;5041.571466425322;5050.191969284897;5403.2165336026055;5427.43011983744;5438.483344082306;5443.9585155566665;5491.28613280279;5035.33127442456;5140.871478213075;5180.922286165711;5235;5722.513586345124;3243.9837800810847;3247.318063206753;3248.7888287261253;3256.8371581420834;3270.787398819117;6154.753809847556;6299.307076221612;6385.242993969429;6386.616802991835;6432.967835160888;6173.660448675366;6257.56197066201;6267.871783078998;6299;6330.0821380899515;6289.96855015722;6333.461655759312;6334.239891213084;6350.206224221973;6353.110564520971;5886.823395297976;6073.271207455134;6152.538559608137;6183.3816618337805;6193.783217587363;6044.24446944132;6052.154093001501;6091.42131497507;6106.938930610815;6107.4197951194565;6028.728707208098;6237.313895471585;6238.812835614939;6276.529260305587;6289.465395441439;4242.4272723181975;4292.463442069741;4307;4308.362822127571;4367.061081867414;6108.816735497942;6189.31735617307;6209.441150296495;6237.844053898689;6241.500679945684;5767.3367562729145;5925.377835327401;5969.224000880032;5975.671338076274;6077.662914158878;5867.413258674099;5907.527397808251;5958.34458209588;5988.071848863433;6000.519958403404;5702.600817942704;5829.504492118217;5835.387284335254;5899.52511872032;5902.494863809701;5916.171735957056;5934.643921364732;5956.37458066914;5991.191189189403;6013.496625843539;5765.423457654201;5793.3337666167245;5805.084322173757;5843.181954526454;5862.149988251765 19:21:07 INFO - PROCESS | 14605 | |5;yui.html;744.7207297263526;755.6901670315171;766.4060353226246;771.2403282766475;775.1318523253957;16185.433509827159;16622.08578528179;16717.83282167178;17083.145842707876;17110.486685399428;14309.141451512916;14319.570412887604;14598.927005364985;14782.704345913075;14787.112773233614;793.6031984007996;825.3273582030625;828.0270681948716;829.6764261937849;830.6801881275723;821.6877586517145;822.9300509456704;827.1686954610608;827.7599496146111;834.3742193354984;854.5385491834402;856.7815207122206;857.9184977427135;858.5492616376421;859.5959898847532;839.920207580282;849.664382568888;850.2220468271524;850.3707256630111;850.9446885952424;616.0697347006009;617.4196255519797;618.7927044440073;622.2750495672536;622.3030206169119;14715.411383544646;14746;14794.112353258732;14829;14839.92580037093;14597.854021459862;14725.263736813116;14874.256287185706;14881.7767733483;14890.702185956221;11167.553297868075;11180;11201.383923884183;11245.943770281177;11260.831087533694;3780.2061567070673;3791.9241615167543;3796.8481260749536;3810.1046254130256;3920.8235629396745;63048;63225.683871580804;63796;63851.68074159646;63992.36007639957;11121.16591255643;11148.275362101438;11303.547858085585;11323.943380283046;11334.773304533863;19415;19535.511612209808;19552.51118722015;19555.31556395548;21625.891870540545;8418.663253469793;8419.368547358972;8524.104968978292;8525.062243153248;8632.95683521591;4767.284907263938;4820.276958456259;4862.07620552094;4967;5003.899922001612;3353.346097510962;3396.4226081566194;3404.38721030212;3412.8293585320635;3428.6057103432927;615.796787060278;647.1910112359551;649.1398896462207;653.950953678476;665.6106177885894;672.9804346415185;749.4079677055174;768.1281745219217;771.1170709537548;786.3434032582743;8918.821623567492;9233.630654773868;9355.719328420158;9374.95312523433;9550.904490955141;643.4819969924256;714.9918614753173;762.2034973452644;778.9337906277916;780.8225990948381;4303.806328715215;4431.756253406029;4484.820607175741;4498;4499;76637.61681191558;77876.2212377869;78219.60890195626;78704.60647696725;78752.60623696845;69604.3039569608;70703.64648176829;70738.64630676813;71458;73270.63364683143;61175;63067.68466157732;63630.68184659047;63669;63768.681156594845;8267.255946964802;8362.372822038249;8668;8721.607527661397;8851.380403371959;40255.396169058076;40368;40450;40560.39159412552;42065.15869682528;54579.454205457434;55200;55692.72153639206;55987.88024239574;56479.435205647416;11610.593629222936;11882.64618231937;12064.819027714766;12150.21023633461;12722.04584656173;13102.868971310547;13256.005799564879;13614.589544821945;13646.727065458834;13728;12060.698482537655;12269.87730122723;12557.811632825333;12644.114911956443;13347.332633368487;12061;12140.271583705005;12268.877311226774;12338.938305308417;12670.683232919251;11883.940580297043;12140.635780926586;12302.753944920873;12644.494220231089;13117.737645247233;9865.161461275586;9883.357581757164;10018.849717254101;10354.844677329695;10645.946770266099;10233.334833235816;10414.739631509274;10473.266871318934;10528.842067369149;10694.946525267324 19:21:07 INFO - PROCESS | 14605 | __end_tp_report 19:21:07 INFO - PROCESS | 14605 | __start_cc_report 19:21:07 INFO - PROCESS | 14605 | _x_x_mozilla_cycle_collect,365 19:21:07 INFO - PROCESS | 14605 | __end_cc_report 19:21:07 INFO - PROCESS | 14605 | __startTimestamp1464834067825__endTimestamp 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | ------- Summary: start ------- 19:21:07 INFO - PROCESS | 14605 | Number of tests: 6 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#0] dojo.html Cycles:165 Average:5355.12 Median:5593.13 stddev:727.31 (13.0%) stddev-sans-first:706.44 19:21:07 INFO - PROCESS | 14605 | Values: 3036.8 3108.4 3122.6 3140.0 3149.5 5329.9 5383.5 5417.2 5438.4 5453.3 5309.4 5334.6 5384.3 5391.5 5497.0 4862.8 4902.7 4927.7 5035.5 5038.4 432.2 4925.2 5030.6 5037.9 5065.1 4818.9 4871.7 4891.0 4927.7 4972.8 4915.0 4942.0 4950.1 4957.9 4984.6 4921.0 4928.1 4947.8 5006.6 5013.5 5309.0 5327.1 5328.3 5360.9 5364.6 5799.1 5819.6 5850.9 5859.4 5922.0 5695.8 5762.6 5772.1 5812.9 5835.1 5450.4 5467.2 5476.3 5477.2 5479.0 5746.2 5934.9 5947.6 5948.7 5949.7 5600.4 5641.9 5642.5 5656.1 5664.6 5689.9 5810.7 5814.3 5821.2 5833.6 5703.0 5744.5 5777.4 5779.8 5782.5 5788.9 5791.5 5809.0 5823.0 5843.5 4394.0 4420.2 4422.3 4428.8 4454.2 3870.2 3872.8 3883.5 3923.3 3962.1 5303.3 5419.7 5472.5 5491.0 5535.4 5834.5 5861.4 5863.5 5863.6 5878.6 5379.0 5399.6 5458.2 5487.4 5515.9 4946.9 4950.0 4993.3 4993.9 5020.1 5971.7 5980.4 5999.1 6007.2 6008.7 5699.7 5773.0 5841.3 5842.1 5888.5 6002.2 6020.9 6030.8 6068.1 6078.2 5559.6 5728.1 5735.6 5737.2 5750.7 5788.3 5840.0 5846.6 5851.6 5911.2 5631.9 5643.2 5662.5 5668.3 5677.7 5505.0 5594.9 5664.8 5690.9 5701.7 5564.4 5570.9 5591.2 5599.0 5649.5 5648.1 5696.1 5698.2 5720.3 5754.0 5492.0 5506.8 5593.1 5625.6 5666.9 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#1] ext.html Cycles:180 Average:60357.95 Median:39185.11 stddev:128718.39 (328.5%) stddev-sans-first:129001.22 19:21:07 INFO - PROCESS | 14605 | Values: 576.8 628.2 639.5 647.2 664.5 39158.4 43265.0 43504.6 43521.6 43538.6 43200.0 43566.1 43818.6 43831.1 43862.8 8625.4 8725.7 8791.6 8814.8 8816.8 8709.2 8796.3 8813.5 8831.1 8831.3 8777.5 8786.5 8805.6 8892.0 8895.9 8802.7 8816.7 8836.6 8842.8 8865.9 8763.7 8810.7 8818.2 8868.5 8870.0 40757.6 40851.8 41089.6 41207.8 41311.6 2981.7 3425.2 3603.1 3605.4 3975.1 29686.9 30168.8 30413.0 30438.0 30608.0 3957.1 3980.4 4102.7 4111.5 4165.2 315580.0 315781.0 316199.0 316488.4 317849.0 33999.8 34451.0 34556.3 34596.8 34705.8 34810.1 36199.8 36336.8 36430.5 36554.8 15454.2 15710.2 15720.8 15726.1 15733.9 12984.3 13009.4 13059.2 13063.2 13120.5 8253.8 8254.2 8298.8 8304.9 8357.8 3176.7 3220.5 3251.6 3260.2 3278.0 1077.8 1095.2 1099.6 1141.2 1195.0 32440.5 32558.3 32567.7 32601.8 33242.3 1101.2 1126.3 1153.5 1219.5 1235.8 15851.8 16045.5 16549.8 16639.6 16736.2 579834.0 592614.0 595414.0 596758.0 597031.0 56829.7 58647.7 58748.4 58820.0 58871.1 1383.4 1418.6 1425.0 1425.6 1435.2 29612.1 30836.8 31135.4 31360.4 31423.5 49139.3 50231.2 50431.5 50439.2 50551.7 490124.0 494779.0 496552.0 498172.0 498762.0 26877.6 27010.2 27074.6 27186.5 27258.3 46175.8 46884.5 46972.8 47126.5 47753.5 39015.2 40078.4 40267.2 40568.6 40618.4 38781.6 39053.0 39211.8 40193.8 40676.0 34844.5 38789.2 39112.6 40466.8 40720.4 33301.5 35553.3 36184.6 36262.5 36532.0 27066.2 27671.4 27703.2 27839.9 27863.3 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#2] jquery.html Cycles:180 Average:28904.10 Median:2464.03 stddev:79775.44 (3237.6%) stddev-sans-first:79970.50 19:21:07 INFO - PROCESS | 14605 | Values: 389.6 391.5 395.3 398.0 422.9 18080.4 19289.9 19607.6 19615.2 20225.9 17332.6 17681.9 17814.4 19101.1 19521.3 5519.4 5540.6 5675.8 5791.5 5801.2 5777.9 5815.5 5816.5 5816.5 5831.6 5493.6 5630.5 5657.7 5663.0 5771.4 5605.0 5623.6 5625.3 5626.8 5642.1 4938.5 5193.6 5231.7 5237.8 5258.9 22769.8 22820.9 23280.5 23585.9 23605.9 2338.9 2379.5 2548.5 2581.2 2613.6 9396.8 14287.6 14364.8 14583.9 14858.3 1933.3 2027.9 2037.3 2046.1 2050.5 79065.2 80211.6 80842.0 81060.6 81106.2 10628.5 10718.5 10920.8 10942.6 11225.2 14924.2 14937.6 15046.2 15078.3 15105.8 8081.8 8247.4 8300.6 8420.5 8533.4 8155.3 8194.9 8212.0 8353.8 8374.5 4508.5 4513.5 4527.6 4578.0 4586.2 1908.4 1958.2 1991.8 2041.5 2056.7 870.9 958.5 1062.9 1106.8 1119.2 19049.6 19901.6 20084.0 20102.1 20140.9 927.6 1007.9 1023.4 1082.8 1102.0 10665.4 11268.5 11274.2 11276.9 11352.4 474838.0 474939.0 488490.0 488843.0 490755.0 84002.6 88883.0 93681.0 97606.5 98724.5 1016.5 1040.2 1058.5 1064.7 1072.6 18000.7 18123.3 18337.0 18412.8 18823.3 40140.6 40349.8 41534.0 42190.4 42438.4 57350.7 58027.0 58640.1 59023.4 59425.4 7287.2 7630.4 7798.8 8208.0 8576.4 9324.5 12567.5 13715.3 13836.1 13895.6 5979.5 10796.5 11856.2 11940.3 11972.9 11521.7 11625.2 11854.8 11961.7 12150.7 12132.0 12273.9 12391.5 12396.5 12449.6 7361.3 8730.4 8780.5 8904.5 8911.5 10117.8 11814.0 11977.9 12079.1 12385.6 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#3] mootools.html Cycles:180 Average:5511.11 Median:4987.54 stddev:3038.84 (60.9%) stddev-sans-first:3031.90 19:21:07 INFO - PROCESS | 14605 | Values: 1431.2 1487.7 1615.2 1755.9 1774.8 7451.3 7735.5 8057.3 8441.2 8441.6 8095.6 8311.0 8378.6 8405.7 8423.1 2282.0 2288.2 2291.7 2312.1 2314.4 2265.8 2282.1 2308.1 2312.3 2320.1 2239.0 2265.8 2274.2 2296.8 2299.0 2235.2 2240.4 2240.8 2244.3 2245.2 2202.3 2202.8 2203.4 2220.8 2231.1 8160.8 8288.0 8289.4 8336.5 8344.7 4868.3 4991.6 5024.8 5024.9 5026.6 3105.8 3204.8 3329.8 3334.9 3368.2 1120.2 1135.9 1149.1 1173.3 1190.8 11114.4 11145.7 11159.2 11227.2 11233.6 4272.3 4283.0 4412.6 4418.0 4420.6 9654.0 9655.2 9658.3 9660.7 9668.4 4901.8 4983.5 5002.0 5032.6 5045.4 4087.2 4499.9 4653.0 4658.0 4660.6 3847.3 3878.3 3908.5 3944.3 3967.5 1250.9 1281.9 1291.2 1295.5 1301.9 898.4 1001.1 1017.4 1020.8 1023.3 5886.6 5944.6 6000.5 6014.5 6153.8 445.4 446.2 451.6 453.6 458.2 4091.0 4192.1 4221.1 4239.4 4288.3 9991.7 10154.3 10233.4 10241.6 10352.6 9590.1 9935.3 10140.8 10218.5 10241.8 7715.8 7933.0 7954.6 7961.9 7970.6 5578.4 5819.8 5892.1 5941.9 5969.7 8957.0 8969.3 9140.9 9151.8 9158.1 9052.9 9425.9 9429.0 9563.4 9681.8 6754.5 7204.0 7415.4 7459.7 7561.5 8169.8 8176.2 8180.8 8189.3 8206.1 7226.9 7360.1 7503.2 7510.1 7678.4 7254.5 7293.6 7332.3 7378.8 7492.4 6726.4 6822.5 6834.9 6835.2 6839.6 4865.7 4895.2 5069.8 5109.4 5147.6 5212.5 5297.9 5323.6 5330.4 5360.2 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#4] prototype.html Cycles:180 Average:4927.73 Median:5546.38 stddev:1474.04 (26.6%) stddev-sans-first:1437.03 19:21:07 INFO - PROCESS | 14605 | Values: 319.9 331.6 332.4 335.1 339.0 5524.8 5604.0 5684.9 5755.6 5770.4 5367.1 5567.9 5580.5 5581.8 5646.8 4380.7 4401.4 4405.1 4414.4 4414.5 4143.9 4375.9 4382.5 4426.5 4447.6 4305.3 4319.3 4327.0 4347.3 4378.6 4334.7 4350.5 4356.9 4362.8 4363.3 3685.7 3776.5 3794.5 3816.2 3816.7 5355.9 5356.9 5408.1 5408.5 5422.8 4876.3 4912.2 4913.0 4913.5 4936.6 5616.3 5846.2 5862.6 5917.2 5947.4 4165.1 4167.1 4174.9 4193.8 4199.7 6147.4 6148.0 6160.4 6244.8 6264.8 4082.0 4184.8 4206.0 4223.5 4243.8 4236.4 4253.6 4267.5 4276.7 4277.1 4902.7 4951.4 4957.4 4962.5 4986.2 5826.6 5983.9 6025.9 6027.5 6057.3 1472.7 1495.6 1497.7 1502.6 1506.0 930.8 943.7 951.3 953.0 964.2 4932.5 4983.5 5014.7 5041.6 5050.2 5403.2 5427.4 5438.5 5444.0 5491.3 5035.3 5140.9 5180.9 5235.0 5722.5 3244.0 3247.3 3248.8 3256.8 3270.8 6154.8 6299.3 6385.2 6386.6 6433.0 6173.7 6257.6 6267.9 6299.0 6330.1 6290.0 6333.5 6334.2 6350.2 6353.1 5886.8 6073.3 6152.5 6183.4 6193.8 6044.2 6052.2 6091.4 6106.9 6107.4 6028.7 6237.3 6238.8 6276.5 6289.5 4242.4 4292.5 4307.0 4308.4 4367.1 6108.8 6189.3 6209.4 6237.8 6241.5 5767.3 5925.4 5969.2 5975.7 6077.7 5867.4 5907.5 5958.3 5988.1 6000.5 5702.6 5829.5 5835.4 5899.5 5902.5 5916.2 5934.6 5956.4 5991.2 6013.5 5765.4 5793.3 5805.1 5843.2 5862.1 19:21:07 INFO - PROCESS | 14605 | 19:21:07 INFO - PROCESS | 14605 | [#5] yui.html Cycles:180 Average:16908.06 Median:4914.54 stddev:21485.78 (437.2%) stddev-sans-first:21511.77 19:21:07 INFO - PROCESS | 14605 | Values: 744.7 755.7 766.4 771.2 775.1 16185.4 16622.1 16717.8 17083.1 17110.5 14309.1 14319.6 14598.9 14782.7 14787.1 793.6 825.3 828.0 829.7 830.7 821.7 822.9 827.2 827.8 834.4 854.5 856.8 857.9 858.5 859.6 839.9 849.7 850.2 850.4 850.9 616.1 617.4 618.8 622.3 622.3 14715.4 14746.0 14794.1 14829.0 14839.9 14597.9 14725.3 14874.3 14881.8 14890.7 11167.6 11180.0 11201.4 11245.9 11260.8 3780.2 3791.9 3796.8 3810.1 3920.8 63048.0 63225.7 63796.0 63851.7 63992.4 11121.2 11148.3 11303.5 11323.9 11334.8 19415.0 19535.5 19552.5 19555.3 21625.9 8418.7 8419.4 8524.1 8525.1 8633.0 4767.3 4820.3 4862.1 4967.0 5003.9 3353.3 3396.4 3404.4 3412.8 3428.6 615.8 647.2 649.1 654.0 665.6 673.0 749.4 768.1 771.1 786.3 8918.8 9233.6 9355.7 9375.0 9550.9 643.5 715.0 762.2 778.9 780.8 4303.8 4431.8 4484.8 4498.0 4499.0 76637.6 77876.2 78219.6 78704.6 78752.6 69604.3 70703.6 70738.6 71458.0 73270.6 61175.0 63067.7 63630.7 63669.0 63768.7 8267.3 8362.4 8668.0 8721.6 8851.4 40255.4 40368.0 40450.0 40560.4 42065.2 54579.5 55200.0 55692.7 55987.9 56479.4 11610.6 11882.6 12064.8 12150.2 12722.0 13102.9 13256.0 13614.6 13646.7 13728.0 12060.7 12269.9 12557.8 12644.1 13347.3 12061.0 12140.3 12268.9 12338.9 12670.7 11883.9 12140.6 12302.8 12644.5 13117.7 9865.2 9883.4 10018.8 10354.8 10645.9 10233.3 10414.7 10473.3 10528.8 10694.9 19:21:07 INFO - PROCESS | 14605 | -------- Summary: end -------- 19:21:07 INFO - PROCESS | 14605 | 19:21:08 INFO - TEST-INFO | 14605: exit 0 19:21:08 INFO - TEST-OK | dromaeo_css | took 1109257ms 19:21:08 INFO - TEST-START | kraken 19:21:08 INFO - operating with platform_type : linux_ 19:21:08 INFO - Initialising browser for kraken test... 19:21:08 INFO - TEST-INFO | started process 14839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2ss9g/profile http://localhost:56169/getInfo.html) 19:21:12 INFO - PROCESS | 14839 | __metrics Screen width/height:1600/1200 19:21:12 INFO - PROCESS | 14839 | colorDepth:24 19:21:12 INFO - PROCESS | 14839 | Browser inner width/height: 1024/697 19:21:12 INFO - PROCESS | 14839 | __metrics 19:21:13 ERROR - PROCESS | 14839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 19:21:14 INFO - TEST-INFO | 14839: exit 0 19:21:14 INFO - Browser initialized. 19:21:14 INFO - Running cycle 1/1 for kraken test... 19:21:14 INFO - TEST-INFO | started process 14961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO2ss9g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:25 INFO - PROCESS | 14961 | RSS: Main: 167235584 19:21:25 INFO - PROCESS | 14961 | 19:21:28 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56169/tests/kraken/driver.html?testName=audio-beat-detection) 19:21:29 INFO - PROCESS | 14961 | RSS: Main: 172220416 19:21:29 INFO - PROCESS | 14961 | 19:21:32 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56169/tests/kraken/driver.html?testName=audio-dft) 19:21:32 INFO - PROCESS | 14961 | RSS: Main: 172011520 19:21:32 INFO - PROCESS | 14961 | 19:21:35 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56169/tests/kraken/driver.html?testName=audio-fft) 19:21:36 INFO - PROCESS | 14961 | RSS: Main: 166727680 19:21:36 INFO - PROCESS | 14961 | 19:21:38 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56169/tests/kraken/driver.html?testName=audio-oscillator) 19:21:38 INFO - PROCESS | 14961 | RSS: Main: 167546880 19:21:38 INFO - PROCESS | 14961 | 19:21:41 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:21:41 INFO - PROCESS | 14961 | RSS: Main: 168136704 19:21:41 INFO - PROCESS | 14961 | 19:21:44 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56169/tests/kraken/driver.html?testName=imaging-darkroom) 19:21:45 INFO - PROCESS | 14961 | RSS: Main: 167477248 19:21:45 INFO - PROCESS | 14961 | 19:21:48 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56169/tests/kraken/driver.html?testName=imaging-desaturate) 19:21:49 INFO - PROCESS | 14961 | RSS: Main: 166035456 19:21:49 INFO - PROCESS | 14961 | 19:21:52 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56169/tests/kraken/driver.html?testName=json-parse-financial) 19:21:52 INFO - PROCESS | 14961 | RSS: Main: 167444480 19:21:52 INFO - PROCESS | 14961 | 19:21:54 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:21:55 INFO - PROCESS | 14961 | RSS: Main: 167841792 19:21:55 INFO - PROCESS | 14961 | 19:21:56 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:21:57 INFO - PROCESS | 14961 | RSS: Main: 168009728 19:21:57 INFO - PROCESS | 14961 | 19:21:59 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:00 INFO - PROCESS | 14961 | RSS: Main: 168022016 19:22:00 INFO - PROCESS | 14961 | 19:22:02 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:03 INFO - PROCESS | 14961 | RSS: Main: 167972864 19:22:03 INFO - PROCESS | 14961 | 19:22:06 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:06 INFO - PROCESS | 14961 | RSS: Main: 168030208 19:22:06 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | Cycle 1(1): loaded http://localhost:56169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56169/tests/kraken/driver.html?testName=ai-astar) 19:22:08 INFO - PROCESS | 14961 | RSS: Main: 169029632 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | __start_tp_report 19:22:08 INFO - PROCESS | 14961 | _x_x_mozilla_page_load 19:22:08 INFO - PROCESS | 14961 | _x_x_mozilla_page_load_details 19:22:08 INFO - PROCESS | 14961 | |i|pagename|runs| 19:22:08 INFO - PROCESS | 14961 | |0;ai-astar;110;105;109;111;112;111;112;111;111;110 19:22:08 INFO - PROCESS | 14961 | |1;audio-beat-detection;160;127;151;182;142;151;155;127;177;134 19:22:08 INFO - PROCESS | 14961 | |2;audio-dft;162;163;162;162;163;165;167;164;163;162 19:22:08 INFO - PROCESS | 14961 | |3;audio-fft;75;77;75;161;77;75;75;74;167;75 19:22:08 INFO - PROCESS | 14961 | |4;audio-oscillator;83;83;148;83;83;84;138;82;85;148 19:22:08 INFO - PROCESS | 14961 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;118;120;117 19:22:08 INFO - PROCESS | 14961 | |6;imaging-darkroom;155;146;146;147;148;150;147;147;147;151 19:22:08 INFO - PROCESS | 14961 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;95 19:22:08 INFO - PROCESS | 14961 | |8;json-parse-financial;57;55;54;55;59;55;58;55;59;55 19:22:08 INFO - PROCESS | 14961 | |9;json-stringify-tinderbox;61;62;62;62;63;62;62;63;62;62 19:22:08 INFO - PROCESS | 14961 | |10;stanford-crypto-aes;82;79;83;82;79;80;81;82;114;78 19:22:08 INFO - PROCESS | 14961 | |11;stanford-crypto-ccm;135;140;133;121;142;129;132;128;126;135 19:22:08 INFO - PROCESS | 14961 | |12;stanford-crypto-pbkdf2;164;160;163;167;162;157;159;158;158;160 19:22:08 INFO - PROCESS | 14961 | |13;stanford-crypto-sha256-iterative;69;65;66;64;68;62;66;64;62;66 19:22:08 INFO - PROCESS | 14961 | __end_tp_report 19:22:08 INFO - PROCESS | 14961 | __start_cc_report 19:22:08 INFO - PROCESS | 14961 | _x_x_mozilla_cycle_collect,851 19:22:08 INFO - PROCESS | 14961 | __end_cc_report 19:22:08 INFO - PROCESS | 14961 | __startTimestamp1464834128893__endTimestamp 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | ------- Summary: start ------- 19:22:08 INFO - PROCESS | 14961 | Number of tests: 14 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:2.17 19:22:08 INFO - PROCESS | 14961 | Values: 110.0 105.0 109.0 111.0 112.0 111.0 112.0 111.0 111.0 110.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:153.00 stddev:19.02 (12.4%) stddev-sans-first:19.86 19:22:08 INFO - PROCESS | 14961 | Values: 160.0 127.0 151.0 182.0 142.0 151.0 155.0 127.0 177.0 134.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 19:22:08 INFO - PROCESS | 14961 | Values: 162.0 163.0 162.0 162.0 163.0 165.0 167.0 164.0 163.0 162.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.00 stddev:37.41 (49.9%) stddev-sans-first:39.10 19:22:08 INFO - PROCESS | 14961 | Values: 75.0 77.0 75.0 161.0 77.0 75.0 75.0 74.0 167.0 75.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.00 stddev:29.78 (35.9%) stddev-sans-first:30.81 19:22:08 INFO - PROCESS | 14961 | Values: 83.0 83.0 148.0 83.0 83.0 84.0 138.0 82.0 85.0 148.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 19:22:08 INFO - PROCESS | 14961 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 120.0 117.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:147.50 stddev:2.84 (1.9%) stddev-sans-first:1.73 19:22:08 INFO - PROCESS | 14961 | Values: 155.0 146.0 146.0 147.0 148.0 150.0 147.0 147.0 147.0 151.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:22:08 INFO - PROCESS | 14961 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.87 (3.3%) stddev-sans-first:1.96 19:22:08 INFO - PROCESS | 14961 | Values: 57.0 55.0 54.0 55.0 59.0 55.0 58.0 55.0 59.0 55.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 19:22:08 INFO - PROCESS | 14961 | Values: 61.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 62.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.50 stddev:10.67 (13.1%) stddev-sans-first:11.29 19:22:08 INFO - PROCESS | 14961 | Values: 82.0 79.0 83.0 82.0 79.0 80.0 81.0 82.0 114.0 78.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:134.00 stddev:6.37 (4.8%) stddev-sans-first:6.67 19:22:08 INFO - PROCESS | 14961 | Values: 135.0 140.0 133.0 121.0 142.0 129.0 132.0 128.0 126.0 135.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:3.16 (2.0%) stddev-sans-first:3.13 19:22:08 INFO - PROCESS | 14961 | Values: 164.0 160.0 163.0 167.0 162.0 157.0 159.0 158.0 158.0 160.0 19:22:08 INFO - PROCESS | 14961 | 19:22:08 INFO - PROCESS | 14961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:2.30 (3.5%) stddev-sans-first:1.99 19:22:08 INFO - PROCESS | 14961 | Values: 69.0 65.0 66.0 64.0 68.0 62.0 66.0 64.0 62.0 66.0 19:22:08 INFO - PROCESS | 14961 | -------- Summary: end -------- 19:22:08 INFO - PROCESS | 14961 | 19:22:09 INFO - TEST-INFO | 14961: exit 0 19:22:09 INFO - TEST-OK | kraken | took 61328ms 19:22:09 INFO - SUITE-END | took 1170s 19:22:10 INFO - Completed test suite (00:19:30) 19:22:10 INFO - javascript benchmark 19:22:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7087.9607765251785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.8329741864195, 3108.3627856289463, 3122.609673790776, 3140.0265917565544, 3149.5118256670225, 5329.866753331169, 5383.542398896098, 5417.1603401472785, 5438.374586922505, 5453.263809385731, 5309.41596424393, 5334.5999050071205, 5384.300040994675, 5391.541718953894, 5497.0, 4862.805487780493, 4902.730349830758, 4927.728974906378, 5035.546800787928, 5038.395392552899, 432.1636141039526, 4925.187344088221, 5030.622703297249, 5037.874053148664, 5065.088284108859, 4818.879528011793, 4871.7320547370055, 4890.975545122287, 4927.6550641455115, 4972.776225069881, 4914.950850491485, 4941.950580494221, 4950.108980383529, 4957.925631115536, 4984.626153038536, 4920.950790492085, 4928.063667903087, 4947.82682606107, 5006.649534532584, 5013.523715247045, 5309.0, 5327.121025030865, 5328.333958255218, 5360.865978350534, 5364.570834333244, 5799.130130480419, 5819.592628516006, 5850.853728656775, 5859.355470898197, 5922.0, 5695.800646977377, 5762.567807414419, 5772.07646776518, 5812.941870581325, 5835.095560188178, 5450.400455949843, 5467.234587157801, 5476.315460567429, 5477.1510415885605, 5478.972605136989, 5746.166805813134, 5934.940650593482, 5947.5539334550085, 5948.67282299469, 5949.702514874239, 5600.411956744565, 5641.858953526113, 5642.548596112301, 5656.123300888369, 5664.575156863251, 5689.9146512802345, 5810.680412577264, 5814.3313518945015, 5821.2141360916585, 5833.562482813721, 5702.971485142548, 5744.540436765049, 5777.422257774189, 5779.768809247583, 5782.508486778671, 5788.88422231553, 5791.478766910998, 5809.0, 5823.0, 5843.474087332161, 4394.0, 4420.204363214652, 4422.314541246048, 4428.778561071934, 4454.242778727624, 3870.2066076454257, 3872.8063596820048, 3883.456316115746, 3923.313420151462, 3962.128331767007, 5303.284056652303, 5419.729013549307, 5472.480114389126, 5491.039068163055, 5535.363433205233, 5834.533237341003, 5861.3845546217035, 5863.501602363847, 5863.560232982543, 5878.559108066912, 5379.004884096376, 5399.622026458111, 5458.235846981426, 5487.396386397493, 5515.917261241085, 4946.851594452172, 4950.0, 4993.27597498368, 4993.90012199754, 5020.146575082244, 5971.701414929236, 5980.401959804072, 5999.100134979788, 6007.189029481052, 6008.669523176267, 5699.74351154199, 5772.999999999916, 5841.269841269841, 5842.094475356326, 5888.528917686661, 6002.159697642421, 6020.909686354796, 6030.758769649165, 6068.120122582289, 6078.179445774941, 5559.63862348946, 5728.112142617901, 5735.569832262514, 5737.225474560881, 5750.712464376848, 5788.27646544182, 5839.970800145972, 5846.649201047951, 5851.64890106595, 5911.172435858897, 5631.88736225265, 5643.1535269709875, 5662.490375866192, 5668.26312579362, 5677.716114194356, 5505.03661859181, 5594.944050559442, 5664.801731939362, 5690.8577285566535, 5701.7149142541875, 5564.443555644403, 5570.944290557042, 5591.161325801162, 5598.992181407386, 5649.491545760737, 5648.124540696199, 5696.060150075357, 5698.1737648041635, 5720.3421606515785, 5754.021816291157, 5492.038893193595, 5506.807261745819, 5593.133064374865, 5625.634333768292, 5666.886662266814], "value": 5307.976627039408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7519966414443, 628.1614045249593, 639.529945490065, 647.2071712152614, 664.5182242873914, 39158.41262381067, 43265.0, 43504.56495435045, 43521.56478435219, 43538.56461435385, 43200.0, 43566.12867742643, 43818.56181438185, 43831.12337753243, 43862.78068609653, 8625.396222264444, 8725.738227853175, 8791.64833406663, 8814.779630509225, 8816.823663526726, 8709.172628600272, 8796.340274479408, 8813.515256660881, 8831.11688831115, 8831.337649676268, 8777.517236551987, 8786.47281163129, 8805.603747831363, 8892.0, 8895.911040889605, 8802.735917922504, 8816.735497935073, 8836.646534138627, 8842.778930526723, 8865.911340886572, 8763.693270735557, 8810.691625793066, 8818.162274583905, 8868.467891926504, 8870.0, 40757.59242407568, 40851.7957410214, 41089.589104109175, 41207.7939610303, 41311.58688413107, 2981.7465515431213, 3425.160835595295, 3603.1352475405715, 3605.441156620728, 3975.125472396097, 29686.851565742032, 30168.849155754302, 30413.0, 30438.0, 30608.0, 3957.0700885291935, 3980.44273801668, 4102.712810103294, 4111.48606424197, 4165.166966606661, 315580.0, 315781.0, 316199.0, 316488.41755791305, 317849.0, 33999.83000084984, 34451.0, 34556.30887382238, 34596.82701586476, 34705.82647086748, 34810.12974675603, 36199.81900090483, 36336.81831590878, 36430.453543196876, 36554.8172259137, 15454.227288635524, 15710.214489275491, 15720.842791572166, 15726.13506257144, 15733.921330393276, 12984.285864277555, 13009.414576344087, 13059.21644701321, 13063.216207027608, 13120.540781072617, 8253.752387428387, 8254.174582541818, 8298.834023319621, 8304.875426868603, 8357.8328433431, 3176.650568437516, 3220.4847224443974, 3251.5935508061493, 3260.2012506935953, 3277.9672203278137, 1077.7575045614674, 1095.2442814457997, 1099.6261271167841, 1141.1726498288674, 1194.952201911931, 32440.513392299134, 32558.34883302368, 32567.67432325694, 32601.836990814892, 33242.3351532968, 1101.1961268274044, 1126.3073209975805, 1153.4636394076795, 1219.4939100273464, 1235.839340885697, 15851.841481585267, 16045.518634440985, 16549.83450165507, 16639.584010399838, 16736.24686889093, 579834.0, 592614.0, 595414.0, 596758.0, 597031.0, 56829.71585142048, 58647.70676146592, 58748.41251587515, 58820.0, 58871.116933246034, 1383.3567391162956, 1418.5531557559543, 1425.0096183152816, 1425.6435891027243, 1435.2034620785564, 29612.111636650934, 30836.84581577078, 31135.377292454476, 31360.372792544476, 31423.528647069856, 49139.262911055645, 50231.24653130133, 50431.49568504268, 50439.24341134813, 50551.74724126356, 490124.0, 494779.0, 496552.0, 498172.0, 498762.0, 26877.5810177085, 27010.189694309203, 27074.593881091405, 27186.456270874867, 27258.318542036606, 46175.76912115418, 46884.53115468802, 46972.7651361741, 47126.52873471359, 47753.522464776295, 39015.219695606494, 40078.396864126276, 40267.189863559295, 40568.594314057664, 40618.39072413857, 38781.6121838778, 39053.0, 39211.80394098011, 40193.79903100466, 40676.0, 34844.477332840535, 38789.224215514965, 39112.60887391203, 40466.79766601266, 40720.38919416152, 33301.50047749237, 35553.28893422169, 36184.63815361813, 36262.4560631596, 36532.0, 27066.1880143596, 27671.446571068867, 27703.168904932885, 27839.860800695868, 27863.303417414725], "value": 18581.291044221005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.57536285448873, 391.5203875252815, 395.28256214969826, 397.9542352629445, 422.8773655639865, 18080.36718714845, 19289.903550482264, 19607.607847843035, 19615.215391384347, 20225.898870505665, 17332.56668583283, 17681.91159044206, 17814.376496822613, 19101.14044867981, 19521.316753913616, 5519.39286678465, 5540.63985840921, 5675.801346952858, 5791.507721843648, 5801.187833703285, 5777.942220577783, 5815.534757219433, 5816.476517113459, 5816.534677225833, 5831.5626328025355, 5493.587980901429, 5630.521405680502, 5657.745401456924, 5662.971685141589, 5771.422857714216, 5604.971975140119, 5623.578231632623, 5625.296837895243, 5626.831195064155, 5642.097264437712, 4938.530839570235, 5193.558547523465, 5231.686098834082, 5237.816676416345, 5258.947410525884, 22769.77230227693, 22820.885895570584, 23280.534389312117, 23585.882070589538, 23605.88197059021, 2338.9064437422485, 2379.5478859016903, 2548.5157820014138, 2581.1998280532907, 2613.581826907686, 9396.812063758754, 14287.57137285883, 14364.784528232085, 14583.854161458356, 14858.2570871456, 1933.2556965568217, 2027.8986050697406, 2037.276766747798, 2046.069038587454, 2050.507878109258, 79065.20934790636, 80211.5989420055, 80842.0, 81060.59469702673, 81106.18893811046, 10628.46857657114, 10718.464076796128, 10920.836187457195, 10942.617008404826, 11225.158113141548, 14924.17917014553, 14937.626559335886, 15046.172460514777, 15078.321475533627, 15105.848941510663, 8081.797955051054, 8247.422680412434, 8300.626471808782, 8420.536870472182, 8533.445326053787, 8155.306798922158, 8194.877076843733, 8211.95894020526, 8353.791155221168, 8374.49753014821, 4508.481524624644, 4513.526079761644, 4527.61515271199, 4577.977110114428, 4586.151561961048, 1908.3893154190803, 1958.2265005322818, 1991.8406527478057, 2041.4998325410072, 2056.7017782421467, 870.912908709124, 958.4712383747911, 1062.8777690565685, 1106.773111512138, 1119.1885882734953, 19049.61900761977, 19901.64652477735, 20084.0, 20102.09540570678, 20140.89929550343, 927.5686805635412, 1007.9344842585208, 1023.4115383654429, 1082.8143183214368, 1101.983470247947, 10665.413402262795, 11268.492917818718, 11274.210805243554, 11276.94361528187, 11352.432378381049, 474838.0, 474939.0, 488490.0, 488843.0, 490754.9792954994, 84002.5799871009, 88883.0, 93681.0, 97606.51196743971, 98724.50637746765, 1016.517154351677, 1040.1834559870617, 1058.4548957287004, 1064.7338165458636, 1072.5656109275756, 18000.729989049913, 18123.275068997093, 18337.0, 18412.815871841645, 18823.34118305853, 40140.59859401369, 40349.79825100973, 41534.0, 42190.36714449347, 42438.36342454804, 57350.71324643517, 58027.0, 58640.120398194915, 59023.40976590351, 59425.40574594372, 7287.198408174991, 7630.4277179212895, 7798.805029874298, 8207.95896020516, 8576.356773242156, 9324.487153206639, 12567.497300107892, 13715.314234288446, 13836.100653457494, 13895.58313250604, 5979.491743201703, 10796.514156862802, 11856.22934509254, 11940.343281119622, 11972.940135299268, 11521.654350369503, 11625.18623696333, 11854.762904742029, 11961.700957476132, 12150.696232593902, 12132.0, 12273.938630306791, 12391.504339826666, 12396.504139834306, 12449.564265250672, 7361.2638736125955, 8730.432521886058, 8780.473171609723, 8904.510251936206, 8911.465312081296, 10117.79764404693, 11814.0, 11977.940110299392, 12079.094067944763, 12385.62843114708], "value": 9301.338047251806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.1699214455614, 1487.7173337065956, 1615.224692147769, 1755.8858674186176, 1774.7781527309087, 7451.329380355767, 7735.535867847926, 8057.274845263925, 8441.240288374045, 8441.577921103943, 8095.554744489065, 8310.958445207765, 8378.581070946459, 8405.655095184771, 8423.115572864854, 2281.977180228193, 2288.2220045184636, 2291.6906217660653, 2312.075169932032, 2314.4213946513373, 2265.784750448705, 2282.087165133951, 2308.0767692922796, 2312.2947501012186, 2320.1067588978194, 2239.0484044281116, 2265.8074063704603, 2274.2494976657663, 2296.804771594408, 2298.977010229893, 2235.150642755759, 2240.395093324801, 2240.7535171131162, 2244.326701989413, 2245.1805091141778, 2202.3392982105306, 2202.757696653367, 2203.3720389689024, 2220.766819483947, 2231.1187081102876, 8160.836783264361, 8287.95856020722, 8289.41974061816, 8336.458130221577, 8344.707935222237, 4868.294097355899, 4991.575716064139, 5024.824131155428, 5024.874378140539, 5026.5727413169925, 3105.7981231219896, 3204.8237346945907, 3329.816860072695, 3334.899953001414, 3368.1579605098727, 1120.1654767198409, 1135.9091272698165, 1149.149629274331, 1173.284296579086, 1190.8035174196248, 11114.388708621023, 11145.665630031112, 11159.218854680257, 11227.157963152797, 11233.60682376121, 4272.295071313199, 4282.957170428318, 4412.602865742035, 4418.028033832552, 4420.557944205618, 9654.0, 9655.179309758609, 9658.32391732586, 9660.71017869465, 9668.419894806335, 4901.754912254373, 4983.50164983506, 5002.024605201951, 5032.622553308516, 5045.445001049881, 4087.2234275487563, 4499.887502812456, 4652.999605084923, 4657.99853031593, 4660.580547750718, 3847.2882516734494, 3878.26313000529, 3908.5309762828642, 3944.3294639911283, 3967.504061992251, 1250.9429532045408, 1281.8718128187293, 1291.2123604601186, 1295.520657356784, 1301.8633043530483, 898.380117718772, 1001.1090129784498, 1017.3590637898077, 1020.811149937264, 1023.2683631203577, 5886.61736987103, 5944.64332140073, 6000.459958603747, 6014.48876845473, 6153.753849846045, 445.40538381261376, 446.21688935917257, 451.62515112456583, 453.57364077766795, 458.2461850256376, 4090.9590904091174, 4192.0777428965575, 4221.071364299849, 4239.448871646728, 4288.270993931039, 9991.650292239738, 10154.339967902062, 10233.385996840214, 10241.641542545975, 10352.585896564053, 9590.136887680143, 9935.254855885838, 10140.797184056277, 10218.540165692562, 10241.795164096826, 7715.845683086307, 7933.0, 7954.602269886598, 7961.920380796118, 7970.561619110888, 5578.442155784389, 5819.7963071294, 5892.145638882424, 5941.881162376641, 5969.73136208863, 8957.0, 8969.282457403262, 9140.908590914005, 9151.816963660822, 9158.129977652112, 9052.909470905206, 9425.858612120961, 9428.952855235955, 9563.426194428357, 9681.757956051155, 6754.527183097136, 7204.0, 7415.406767458699, 7459.701611935462, 7561.508501947355, 8169.79575510617, 8176.223258790405, 8180.7954801130445, 8189.262966333059, 8206.056303524932, 7226.927730722836, 7360.116785985716, 7503.174650788518, 7510.061242344707, 7678.385729141767, 7254.492185547172, 7293.598852063187, 7332.340089391981, 7378.778636640909, 7492.400607951242, 6726.428253598499, 6822.522423430312, 6834.897476537756, 6835.248122706597, 6839.589624622538, 4865.70805751656, 4895.192293271571, 5069.847904562869, 5109.412417572027, 5147.639665223398, 5212.452692467388, 5297.867553311198, 5323.574114070788, 5330.440303768203, 5360.2227676987395], "value": 4398.557981974431, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.89763275751756, 331.5838622528727, 332.4497955883013, 335.09357188804285, 338.9677980591843, 5524.8342549723475, 5603.971980140103, 5684.914726279104, 5755.5971082024225, 5770.374479611777, 5367.141257398817, 5567.916481252774, 5580.525655319303, 5581.804636837712, 5646.802361917334, 4380.693351465398, 4401.383806267125, 4405.118976204756, 4414.359917811916, 4414.470263568376, 4143.875683729493, 4375.868723938287, 4382.4741031076155, 4426.494991702821, 4447.599716025557, 4305.26810442224, 4319.287317592593, 4326.961529232993, 4347.261095561785, 4378.562143785628, 4334.739915605074, 4350.456192975878, 4356.891077723082, 4362.803673834669, 4363.3018717005125, 3685.7419980601367, 3776.509053823013, 3794.4687743715904, 3816.179521402884, 3816.732828701992, 5355.866103347408, 5356.892862142735, 5408.080626293539, 5408.5402740766685, 5422.755975981051, 4876.317315575822, 4912.231596625212, 4912.9508704913205, 4913.459519452857, 4936.580390666798, 5616.297962754656, 5846.181534585119, 5862.560307976919, 5917.171595976567, 5947.37552556984, 4165.146145040259, 4167.10407262437, 4174.91650166995, 4193.811278492475, 4199.748015119103, 6147.370946699084, 6147.985582378902, 6160.353162917919, 6244.781432649836, 6264.7807326743805, 4082.0, 4184.790760461965, 4206.002148979211, 4223.450951376301, 4243.787810609457, 4236.364545318227, 4253.553376895444, 4267.530571637118, 4276.743395396224, 4277.139444341721, 4902.651770763068, 4951.415547024917, 4957.380327459067, 4962.503749625009, 4986.152354099811, 5826.621269617462, 5983.850403739854, 6025.9096113558335, 6027.517798576104, 6057.3336932937345, 1472.7113775446485, 1495.5812372535706, 1497.6779992301708, 1502.6093215763763, 1506.0, 930.8091841172543, 943.7310366545502, 951.2912879904377, 952.9523523823781, 964.2237998411206, 4932.482089380564, 4983.50164983506, 5014.696178993415, 5041.571466425322, 5050.191969284897, 5403.2165336026055, 5427.43011983744, 5438.483344082306, 5443.9585155566665, 5491.28613280279, 5035.33127442456, 5140.871478213075, 5180.922286165711, 5235.0, 5722.513586345124, 3243.9837800810847, 3247.318063206753, 3248.7888287261253, 3256.8371581420834, 3270.787398819117, 6154.753809847556, 6299.307076221612, 6385.242993969429, 6386.616802991835, 6432.967835160888, 6173.660448675366, 6257.56197066201, 6267.871783078998, 6299.0, 6330.0821380899515, 6289.96855015722, 6333.461655759312, 6334.239891213084, 6350.206224221973, 6353.110564520971, 5886.823395297976, 6073.271207455134, 6152.538559608137, 6183.3816618337805, 6193.783217587363, 6044.24446944132, 6052.154093001501, 6091.42131497507, 6106.938930610815, 6107.4197951194565, 6028.728707208098, 6237.313895471585, 6238.812835614939, 6276.529260305587, 6289.465395441439, 4242.4272723181975, 4292.463442069741, 4307.0, 4308.362822127571, 4367.061081867414, 6108.816735497942, 6189.31735617307, 6209.441150296495, 6237.844053898689, 6241.500679945684, 5767.3367562729145, 5925.377835327401, 5969.224000880032, 5975.671338076274, 6077.662914158878, 5867.413258674099, 5907.527397808251, 5958.34458209588, 5988.071848863433, 6000.519958403404, 5702.600817942704, 5829.504492118217, 5835.387284335254, 5899.52511872032, 5902.494863809701, 5916.171735957056, 5934.643921364732, 5956.37458066914, 5991.191189189403, 6013.496625843539, 5765.423457654201, 5793.3337666167245, 5805.084322173757, 5843.181954526454, 5862.149988251765], "value": 4450.828321498204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.7207297263526, 755.6901670315171, 766.4060353226246, 771.2403282766475, 775.1318523253957, 16185.433509827159, 16622.08578528179, 16717.83282167178, 17083.145842707876, 17110.486685399428, 14309.141451512916, 14319.570412887604, 14598.927005364985, 14782.704345913075, 14787.112773233614, 793.6031984007996, 825.3273582030625, 828.0270681948716, 829.6764261937849, 830.6801881275723, 821.6877586517145, 822.9300509456704, 827.1686954610608, 827.7599496146111, 834.3742193354984, 854.5385491834402, 856.7815207122206, 857.9184977427135, 858.5492616376421, 859.5959898847532, 839.920207580282, 849.664382568888, 850.2220468271524, 850.3707256630111, 850.9446885952424, 616.0697347006009, 617.4196255519797, 618.7927044440073, 622.2750495672536, 622.3030206169119, 14715.411383544646, 14746.0, 14794.112353258732, 14829.0, 14839.92580037093, 14597.854021459862, 14725.263736813116, 14874.256287185706, 14881.7767733483, 14890.702185956221, 11167.553297868075, 11180.0, 11201.383923884183, 11245.943770281177, 11260.831087533694, 3780.2061567070673, 3791.9241615167543, 3796.8481260749536, 3810.1046254130256, 3920.8235629396745, 63048.0, 63225.683871580804, 63796.0, 63851.68074159646, 63992.36007639957, 11121.16591255643, 11148.275362101438, 11303.547858085585, 11323.943380283046, 11334.773304533863, 19415.0, 19535.511612209808, 19552.51118722015, 19555.31556395548, 21625.891870540545, 8418.663253469793, 8419.368547358972, 8524.104968978292, 8525.062243153248, 8632.95683521591, 4767.284907263938, 4820.276958456259, 4862.07620552094, 4967.0, 5003.899922001612, 3353.346097510962, 3396.4226081566194, 3404.38721030212, 3412.8293585320635, 3428.6057103432927, 615.796787060278, 647.1910112359551, 649.1398896462207, 653.950953678476, 665.6106177885894, 672.9804346415185, 749.4079677055174, 768.1281745219217, 771.1170709537548, 786.3434032582743, 8918.821623567492, 9233.630654773868, 9355.719328420158, 9374.95312523433, 9550.904490955141, 643.4819969924256, 714.9918614753173, 762.2034973452644, 778.9337906277916, 780.8225990948381, 4303.806328715215, 4431.756253406029, 4484.820607175741, 4498.0, 4499.0, 76637.61681191558, 77876.2212377869, 78219.60890195626, 78704.60647696725, 78752.60623696845, 69604.3039569608, 70703.64648176829, 70738.64630676813, 71458.0, 73270.63364683143, 61175.0, 63067.68466157732, 63630.68184659047, 63669.0, 63768.681156594845, 8267.255946964802, 8362.372822038249, 8668.0, 8721.607527661397, 8851.380403371959, 40255.396169058076, 40368.0, 40450.0, 40560.39159412552, 42065.15869682528, 54579.454205457434, 55200.0, 55692.72153639206, 55987.88024239574, 56479.435205647416, 11610.593629222936, 11882.64618231937, 12064.819027714766, 12150.21023633461, 12722.04584656173, 13102.868971310547, 13256.005799564879, 13614.589544821945, 13646.727065458834, 13728.0, 12060.698482537655, 12269.87730122723, 12557.811632825333, 12644.114911956443, 13347.332633368487, 12061.0, 12140.271583705005, 12268.877311226774, 12338.938305308417, 12670.683232919251, 11883.940580297043, 12140.635780926586, 12302.753944920873, 12644.494220231089, 13117.737645247233, 9865.161461275586, 9883.357581757164, 10018.849717254101, 10354.844677329695, 10645.946770266099, 10233.334833235816, 10414.739631509274, 10473.266871318934, 10528.842067369149, 10694.946525267324], "value": 7059.6681084610855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 151.0, 182.0, 142.0, 151.0, 155.0, 127.0, 177.0, 134.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 163.0, 165.0, 167.0, 164.0, 163.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 161.0, 77.0, 75.0, 75.0, 74.0, 167.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 148.0, 83.0, 83.0, 84.0, 138.0, 82.0, 85.0, 148.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 120.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 146.0, 146.0, 147.0, 148.0, 150.0, 147.0, 147.0, 147.0, 151.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 55.0, 59.0, 55.0, 58.0, 55.0, 59.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 83.0, 82.0, 79.0, 80.0, 81.0, 82.0, 114.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 133.0, 121.0, 142.0, 129.0, 132.0, 128.0, 126.0, 135.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 163.0, 167.0, 162.0, 157.0, 159.0, 158.0, 158.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 64.0, 68.0, 62.0, 66.0, 64.0, 62.0, 66.0], "value": 65.2, "unit": "score"}]}]} 19:22:10 INFO - Return code: 0 19:22:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:22:10 ERROR - # TBPL SUCCESS # 19:22:10 INFO - Running post-action listener: _resource_record_post_action 19:22:10 INFO - ##### 19:22:10 INFO - ##### Finished run-tests step (success) 19:22:10 INFO - ##### 19:22:10 INFO - Running post-run listener: _resource_record_post_run 19:22:10 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 542543872; Read time: 0; Write time: 414960 19:22:10 INFO - TinderboxPrint: CPU usage
13.5% 19:22:10 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:22:10 INFO - TinderboxPrint: I/O write bytes / time
542,543,872 / 414,960 19:22:10 INFO - TinderboxPrint: CPU idle
8,209.4 (86.5%) 19:22:10 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 19:22:10 INFO - TinderboxPrint: Swap in / out
0 / 0 19:22:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247537664; Read time: 0; Write time: 212444 19:22:10 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292384768; Read time: 0; Write time: 202332 19:22:10 INFO - Running post-run listener: _upload_blobber_files 19:22:10 INFO - Blob upload gear active. 19:22:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:22:10 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 19:22:10 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:22:10 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:22:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:11 INFO - (blobuploader) - INFO - Done attempting. 19:22:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:22:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:12 INFO - (blobuploader) - INFO - Done attempting. 19:22:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:22:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:22:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:22:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:22:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:22:16 INFO - (blobuploader) - INFO - Done attempting. 19:22:16 INFO - (blobuploader) - INFO - Iteration through files over. 19:22:16 INFO - Return code: 0 19:22:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:22:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:22:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed79e5d5fb01d183fcd09c995f61f009434cb7956c46a1ac11999ff758d4a5d10798b2dea84c1a6bfcf8aeb9f4ae0d218ace227d73fbb26a848a4ea7088182f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/050145161554a5102194e1af7ed2ad45c5280870d92cfc252783eedcbdc99fd2e118768a7e489cb26b3abd32294d1df55f822142192961874260281f83f05941", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52eda29a87eceb381d49edd81d28ace7262831b55db746a47fb69ef334bf1e094cd6645a789d3bd8cc826bc39fff7210fd769be4aaaa50db4206ea4089bf4524"} 19:22:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:22:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:22:16 INFO - Contents: 19:22:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed79e5d5fb01d183fcd09c995f61f009434cb7956c46a1ac11999ff758d4a5d10798b2dea84c1a6bfcf8aeb9f4ae0d218ace227d73fbb26a848a4ea7088182f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/050145161554a5102194e1af7ed2ad45c5280870d92cfc252783eedcbdc99fd2e118768a7e489cb26b3abd32294d1df55f822142192961874260281f83f05941", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52eda29a87eceb381d49edd81d28ace7262831b55db746a47fb69ef334bf1e094cd6645a789d3bd8cc826bc39fff7210fd769be4aaaa50db4206ea4089bf4524"} 19:22:16 INFO - Running post-run listener: copy_logs_to_upload_dir 19:22:16 INFO - Copying logs to upload dir... 19:22:16 INFO - mkdir: /builds/slave/test/build/upload/logs 19:22:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.889412 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-01 19:22:16.418344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:22:16.421919) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed79e5d5fb01d183fcd09c995f61f009434cb7956c46a1ac11999ff758d4a5d10798b2dea84c1a6bfcf8aeb9f4ae0d218ace227d73fbb26a848a4ea7088182f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/050145161554a5102194e1af7ed2ad45c5280870d92cfc252783eedcbdc99fd2e118768a7e489cb26b3abd32294d1df55f822142192961874260281f83f05941", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52eda29a87eceb381d49edd81d28ace7262831b55db746a47fb69ef334bf1e094cd6645a789d3bd8cc826bc39fff7210fd769be4aaaa50db4206ea4089bf4524"} build_url:https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011532 build_url: 'https://queue.taskcluster.net/v1/task/PU2_KnZcSw2vbcJ5LXqOdQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed79e5d5fb01d183fcd09c995f61f009434cb7956c46a1ac11999ff758d4a5d10798b2dea84c1a6bfcf8aeb9f4ae0d218ace227d73fbb26a848a4ea7088182f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/050145161554a5102194e1af7ed2ad45c5280870d92cfc252783eedcbdc99fd2e118768a7e489cb26b3abd32294d1df55f822142192961874260281f83f05941", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52eda29a87eceb381d49edd81d28ace7262831b55db746a47fb69ef334bf1e094cd6645a789d3bd8cc826bc39fff7210fd769be4aaaa50db4206ea4089bf4524"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 19:22:16.447983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:22:16.448294) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1464830347.176901-1094046194 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 19:22:16.536369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:22:16.536700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 19:22:16.536993) ========= ========= Total master_lag: 0.19 =========