builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1464219858.43 results: success (0) buildid: 20160525153444 builduid: c2fdd9332ae44f6fae63df7475211c41 revision: 1012461fa7bb33adf728ec631020cb18153da6f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.429097) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.429729) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.430167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.459238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.459889) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 16:44:18-- 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% 40.5M=0s 2016-05-25 16:44:18 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.614191) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.614937) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.667106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:18.667470) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1012461fa7bb33adf728ec631020cb18153da6f0 --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 1012461fa7bb33adf728ec631020cb18153da6f0 --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=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 16:44:18,700 truncating revision to first 12 chars 2016-05-25 16:44:18,700 Setting DEBUG logging. 2016-05-25 16:44:18,700 attempt 1/10 2016-05-25 16:44:18,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1012461fa7bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 16:44:19,040 unpacking tar archive at: mozilla-central-1012461fa7bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:19.376551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:19.376891) ========= script_repo_revision: 1012461fa7bb33adf728ec631020cb18153da6f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:19.377339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:19.377684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 16:44:19.390970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-25 16:44:19.391288) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:44:19 INFO - MultiFileLogger online at 20160525 16:44:19 in /builds/slave/test 16:44:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:44:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:19 INFO - {'append_to_log': False, 16:44:19 INFO - 'base_work_dir': '/builds/slave/test', 16:44:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:44:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:19 INFO - 'branch': 'Firefox-Non-PGO', 16:44:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:19 INFO - 'config_files': ('talos/linux_config.py',), 16:44:19 INFO - 'default_actions': ('clobber', 16:44:19 INFO - 'read-buildbot-config', 16:44:19 INFO - 'download-and-extract', 16:44:19 INFO - 'populate-webroot', 16:44:19 INFO - 'create-virtualenv', 16:44:19 INFO - 'install', 16:44:19 INFO - 'run-tests'), 16:44:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:19 INFO - 'download_minidump_stackwalk': True, 16:44:19 INFO - 'download_symbols': 'ondemand', 16:44:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:19 INFO - 'installer_path': 'installer.exe', 16:44:19 INFO - 'log_level': 'info', 16:44:19 INFO - 'log_name': 'talos', 16:44:19 INFO - 'log_to_console': True, 16:44:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:44:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:44:19 INFO - 'opt_config_files': (), 16:44:19 INFO - 'pip_index': False, 16:44:19 INFO - 'sps_profile': False, 16:44:19 INFO - 'sps_profile_interval': 0, 16:44:19 INFO - 'suite': 'dromaeojs', 16:44:19 INFO - 'system_bits': '32', 16:44:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:19 INFO - 'title': 'talos-linux64-ix-060', 16:44:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:19 INFO - 'use_talos_json': True, 16:44:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:19 INFO - 'work_dir': 'build'} 16:44:19 INFO - ##### 16:44:19 INFO - ##### Running clobber step. 16:44:19 INFO - ##### 16:44:19 INFO - Running pre-action listener: _resource_record_pre_action 16:44:19 INFO - Running main action method: clobber 16:44:19 INFO - rmtree: /builds/slave/test/build 16:44:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:19 INFO - Running post-action listener: _resource_record_post_action 16:44:19 INFO - ##### 16:44:19 INFO - ##### Finished clobber step (success) 16:44:19 INFO - ##### 16:44:19 INFO - ##### 16:44:19 INFO - ##### Running read-buildbot-config step. 16:44:19 INFO - ##### 16:44:19 INFO - Running pre-action listener: _resource_record_pre_action 16:44:19 INFO - Running main action method: read_buildbot_config 16:44:19 INFO - Using buildbot properties: 16:44:19 INFO - { 16:44:19 INFO - "project": "", 16:44:19 INFO - "product": "firefox", 16:44:19 INFO - "script_repo_revision": "production", 16:44:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:44:19 INFO - "repository": "", 16:44:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:44:19 INFO - "buildid": "20160525153444", 16:44:19 INFO - "pgo_build": "False", 16:44:19 INFO - "basedir": "/builds/slave/test", 16:44:19 INFO - "buildnumber": 99, 16:44:19 INFO - "slavename": "talos-linux64-ix-060", 16:44:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:44:19 INFO - "platform": "ubuntu64_hw", 16:44:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:44:19 INFO - "branch": "mozilla-central", 16:44:19 INFO - "repo_path": "mozilla-central", 16:44:19 INFO - "revision": "1012461fa7bb33adf728ec631020cb18153da6f0", 16:44:19 INFO - "stage_platform": "linux64", 16:44:19 INFO - "builduid": "c2fdd9332ae44f6fae63df7475211c41", 16:44:19 INFO - "slavebuilddir": "test" 16:44:19 INFO - } 16:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:44:19 INFO - Running post-action listener: _resource_record_post_action 16:44:19 INFO - ##### 16:44:19 INFO - ##### Finished read-buildbot-config step (success) 16:44:19 INFO - ##### 16:44:19 INFO - ##### 16:44:19 INFO - ##### Running download-and-extract step. 16:44:19 INFO - ##### 16:44:19 INFO - Running pre-action listener: _resource_record_pre_action 16:44:19 INFO - Running main action method: download_and_extract 16:44:19 INFO - mkdir: /builds/slave/test/build/tests 16:44:19 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')]} 16:44:19 INFO - https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:25 INFO - Downloaded 1361 bytes. 16:44:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:44:25 INFO - Using the following test package requirements: 16:44:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:44:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:44:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'jsshell-linux-x86_64.zip'], 16:44:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:44:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:44:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:44:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:44:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:44:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:44:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:44:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:25 INFO - https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:43 INFO - Downloaded 22835891 bytes. 16:44:43 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'] 16:44:43 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 16:44:44 INFO - Return code: 0 16:44:44 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 16:44:44 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')]} 16:44:44 INFO - https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:44:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:46 INFO - Downloaded 22835891 bytes. 16:44:46 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'] 16:44:46 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 16:44:47 INFO - Return code: 0 16:44:47 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')]} 16:44:47 INFO - https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:48 INFO - Downloaded 10834034 bytes. 16:44:48 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'] 16:44:48 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 16:44:48 INFO - Return code: 0 16:44:48 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')]} 16:44:48 INFO - https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/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 16:44:50 INFO - Downloaded 54833616 bytes. 16:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:50 INFO - mkdir: /builds/slave/test/properties 16:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:50 INFO - Contents: 16:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:44:51 INFO - Running post-action listener: _resource_record_post_action 16:44:51 INFO - Running post-action listener: set_extra_try_arguments 16:44:51 INFO - ##### 16:44:51 INFO - ##### Finished download-and-extract step (success) 16:44:51 INFO - ##### 16:44:51 INFO - ##### 16:44:51 INFO - ##### Running populate-webroot step. 16:44:51 INFO - ##### 16:44:51 INFO - Running pre-action listener: _resource_record_pre_action 16:44:51 INFO - Running main action method: populate_webroot 16:44:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:51 INFO - '--tppagecycles', 16:44:51 INFO - '7'], 16:44:51 INFO - 'tests': ['tsvgm']}}, 16:44:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:44:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:44:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['damp', 'tps']}, 16:44:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'tests': ['damp', 'tps']}, 16:44:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['dromaeo_dom']}, 16:44:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['a11yr', 16:44:51 INFO - 'ts_paint', 16:44:51 INFO - 'tpaint', 16:44:51 INFO - 'sessionrestore', 16:44:51 INFO - 'sessionrestore_no_auto_restore', 16:44:51 INFO - 'tabpaint']}, 16:44:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['tsvgx', 16:44:51 INFO - 'tsvgr_opacity', 16:44:51 INFO - 'tart', 16:44:51 INFO - 'tscrollx', 16:44:51 INFO - 'cart']}, 16:44:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:44:51 INFO - 'tsvgr_opacity', 16:44:51 INFO - 'tart', 16:44:51 INFO - 'tscrollx', 16:44:51 INFO - 'cart']}, 16:44:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'talos_options': ['--disable-e10s'], 16:44:51 INFO - 'tests': ['tp5o']}, 16:44:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'tests': ['tp5o']}, 16:44:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'talos_options': ['--disable-e10s', 16:44:51 INFO - '--xperf_path', 16:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:51 INFO - 'tests': ['tp5n']}, 16:44:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:51 INFO - 'talos_options': ['--xperf_path', 16:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:51 INFO - 'tests': ['tp5n']}}, 16:44:51 INFO - 'talos.zip': {'path': '', 16:44:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:51 INFO - Running post-action listener: _resource_record_post_action 16:44:51 INFO - ##### 16:44:51 INFO - ##### Finished populate-webroot step (success) 16:44:51 INFO - ##### 16:44:51 INFO - ##### 16:44:51 INFO - ##### Running create-virtualenv step. 16:44:51 INFO - ##### 16:44:51 INFO - Running pre-action listener: _resource_record_pre_action 16:44:51 INFO - Running main action method: create_virtualenv 16:44:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:51 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 16:44:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:51 INFO - Using real prefix '/usr' 16:44:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:54 INFO - Installing pip.................done. 16:44:54 INFO - Return code: 0 16:44:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:44:54 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 16:44:54 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 16:44:54 INFO - Using env: {'DISPLAY': ':0', 16:44:54 INFO - 'HOME': '/home/cltbld', 16:44:54 INFO - 'LANG': 'en_US.UTF-8', 16:44:54 INFO - 'LANGUAGE': 'en_US:en', 16:44:54 INFO - 'LOGNAME': 'cltbld', 16:44:54 INFO - 'MAIL': '/var/mail/cltbld', 16:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:54 INFO - 'MOZ_NO_REMOTE': '1', 16:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:54 INFO - 'NO_EM_RESTART': '1', 16:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:54 INFO - 'PWD': '/builds/slave/test', 16:44:54 INFO - 'SHELL': '/bin/bash', 16:44:54 INFO - 'SHLVL': '1', 16:44:54 INFO - 'TERM': 'linux', 16:44:54 INFO - 'TMOUT': '86400', 16:44:54 INFO - 'USER': 'cltbld', 16:44:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:54 INFO - '_': '/tools/buildbot/bin/python'} 16:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:54 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 16:44:54 INFO - Cleaning up... 16:44:54 INFO - Return code: 0 16:44:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:44:54 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 16:44:54 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 16:44:54 INFO - Using env: {'DISPLAY': ':0', 16:44:54 INFO - 'HOME': '/home/cltbld', 16:44:54 INFO - 'LANG': 'en_US.UTF-8', 16:44:54 INFO - 'LANGUAGE': 'en_US:en', 16:44:54 INFO - 'LOGNAME': 'cltbld', 16:44:54 INFO - 'MAIL': '/var/mail/cltbld', 16:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:54 INFO - 'MOZ_NO_REMOTE': '1', 16:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:54 INFO - 'NO_EM_RESTART': '1', 16:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:54 INFO - 'PWD': '/builds/slave/test', 16:44:54 INFO - 'SHELL': '/bin/bash', 16:44:54 INFO - 'SHLVL': '1', 16:44:54 INFO - 'TERM': 'linux', 16:44:54 INFO - 'TMOUT': '86400', 16:44:54 INFO - 'USER': 'cltbld', 16:44:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:54 INFO - '_': '/tools/buildbot/bin/python'} 16:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:54 INFO - Downloading/unpacking psutil>=3.1.1 16:44:54 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 16:44:54 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 16:44:54 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 16:44:54 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 16:44:54 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 16:44:54 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 16:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:56 INFO - Installing collected packages: psutil 16:44:56 INFO - Running setup.py install for psutil 16:44:56 INFO - building 'psutil._psutil_linux' extension 16:44:56 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 16:44:57 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 16:44:57 INFO - building 'psutil._psutil_posix' extension 16:44:57 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 16:44:57 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 16:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:57 INFO - Successfully installed psutil 16:44:57 INFO - Cleaning up... 16:44:57 INFO - Return code: 0 16:44:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:44:57 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')]} 16:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:57 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')]} 16:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:57 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:44:57 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 16:44:57 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 16:44:57 INFO - Using env: {'DISPLAY': ':0', 16:44:57 INFO - 'HOME': '/home/cltbld', 16:44:57 INFO - 'LANG': 'en_US.UTF-8', 16:44:57 INFO - 'LANGUAGE': 'en_US:en', 16:44:57 INFO - 'LOGNAME': 'cltbld', 16:44:57 INFO - 'MAIL': '/var/mail/cltbld', 16:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:57 INFO - 'MOZ_NO_REMOTE': '1', 16:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:57 INFO - 'NO_EM_RESTART': '1', 16:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:57 INFO - 'PWD': '/builds/slave/test', 16:44:57 INFO - 'SHELL': '/bin/bash', 16:44:57 INFO - 'SHLVL': '1', 16:44:57 INFO - 'TERM': 'linux', 16:44:57 INFO - 'TMOUT': '86400', 16:44:57 INFO - 'USER': 'cltbld', 16:44:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:57 INFO - '_': '/tools/buildbot/bin/python'} 16:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:44:57 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 16:44:57 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 16:44:57 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 16:44:57 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 16:44:57 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 16:44:57 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 16:44:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:44:59 INFO - Installing collected packages: mozsystemmonitor 16:44:59 INFO - Running setup.py install for mozsystemmonitor 16:44:59 INFO - Successfully installed mozsystemmonitor 16:44:59 INFO - Cleaning up... 16:45:00 INFO - Return code: 0 16:45:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:00 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:00 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 16:45:00 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 16:45:00 INFO - Using env: {'DISPLAY': ':0', 16:45:00 INFO - 'HOME': '/home/cltbld', 16:45:00 INFO - 'LANG': 'en_US.UTF-8', 16:45:00 INFO - 'LANGUAGE': 'en_US:en', 16:45:00 INFO - 'LOGNAME': 'cltbld', 16:45:00 INFO - 'MAIL': '/var/mail/cltbld', 16:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:00 INFO - 'MOZ_NO_REMOTE': '1', 16:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:00 INFO - 'NO_EM_RESTART': '1', 16:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:00 INFO - 'PWD': '/builds/slave/test', 16:45:00 INFO - 'SHELL': '/bin/bash', 16:45:00 INFO - 'SHLVL': '1', 16:45:00 INFO - 'TERM': 'linux', 16:45:00 INFO - 'TMOUT': '86400', 16:45:00 INFO - 'USER': 'cltbld', 16:45:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:00 INFO - '_': '/tools/buildbot/bin/python'} 16:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:00 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 16:45:00 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 16:45:00 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 16:45:00 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 16:45:00 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 16:45:00 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 16:45:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:03 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 16:45:03 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 16:45:03 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 16:45:03 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 16:45:03 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 16:45:03 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 16:45:03 INFO - Downloading docopt-0.6.1.tar.gz 16:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:03 INFO - Running setup.py install for blobuploader 16:45:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:03 INFO - Running setup.py install for requests 16:45:04 INFO - Running setup.py install for docopt 16:45:04 INFO - Successfully installed blobuploader requests docopt 16:45:04 INFO - Cleaning up... 16:45:04 INFO - Return code: 0 16:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:04 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:04 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 16:45:04 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 16:45:04 INFO - Using env: {'DISPLAY': ':0', 16:45:04 INFO - 'HOME': '/home/cltbld', 16:45:04 INFO - 'LANG': 'en_US.UTF-8', 16:45:04 INFO - 'LANGUAGE': 'en_US:en', 16:45:04 INFO - 'LOGNAME': 'cltbld', 16:45:04 INFO - 'MAIL': '/var/mail/cltbld', 16:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:04 INFO - 'MOZ_NO_REMOTE': '1', 16:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:04 INFO - 'NO_EM_RESTART': '1', 16:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:04 INFO - 'PWD': '/builds/slave/test', 16:45:04 INFO - 'SHELL': '/bin/bash', 16:45:04 INFO - 'SHLVL': '1', 16:45:04 INFO - 'TERM': 'linux', 16:45:04 INFO - 'TMOUT': '86400', 16:45:04 INFO - 'USER': 'cltbld', 16:45:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:04 INFO - '_': '/tools/buildbot/bin/python'} 16:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:04 INFO - Running setup.py (path:/tmp/pip-l3e3sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:04 INFO - Running setup.py (path:/tmp/pip-utSGrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:04 INFO - Running setup.py (path:/tmp/pip-r1YCwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:04 INFO - Running setup.py (path:/tmp/pip-PaKMqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:04 INFO - Running setup.py (path:/tmp/pip-SHBIZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:04 INFO - Running setup.py (path:/tmp/pip-_TCq_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:04 INFO - Running setup.py (path:/tmp/pip-nF8LKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:04 INFO - Running setup.py (path:/tmp/pip-u2S4lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:05 INFO - Running setup.py (path:/tmp/pip-aLdFsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:05 INFO - Running setup.py (path:/tmp/pip-ZOiLPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:05 INFO - Running setup.py (path:/tmp/pip-HXRATx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:05 INFO - Running setup.py (path:/tmp/pip-Mutx6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:05 INFO - Running setup.py (path:/tmp/pip-AC4u_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:05 INFO - Running setup.py (path:/tmp/pip-G155kB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:05 INFO - Running setup.py (path:/tmp/pip-aGDNVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:05 INFO - Running setup.py (path:/tmp/pip-ukrdNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:05 INFO - Running setup.py (path:/tmp/pip-FqA3Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:05 INFO - Running setup.py install for manifestparser 16:45:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:05 INFO - Running setup.py install for mozcrash 16:45:05 INFO - Running setup.py install for mozdebug 16:45:05 INFO - Running setup.py install for mozdevice 16:45:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for mozfile 16:45:06 INFO - Running setup.py install for mozhttpd 16:45:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for mozinfo 16:45:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for mozInstall 16:45:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for mozleak 16:45:06 INFO - Running setup.py install for mozlog 16:45:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for moznetwork 16:45:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Running setup.py install for mozprocess 16:45:06 INFO - Running setup.py install for mozprofile 16:45:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:07 INFO - Running setup.py install for mozrunner 16:45:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:07 INFO - Running setup.py install for mozscreenshot 16:45:07 INFO - Running setup.py install for moztest 16:45:07 INFO - Running setup.py install for mozversion 16:45:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:07 INFO - Cleaning up... 16:45:07 INFO - Return code: 0 16:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:07 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:07 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 16:45:07 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 16:45:07 INFO - Using env: {'DISPLAY': ':0', 16:45:07 INFO - 'HOME': '/home/cltbld', 16:45:07 INFO - 'LANG': 'en_US.UTF-8', 16:45:07 INFO - 'LANGUAGE': 'en_US:en', 16:45:07 INFO - 'LOGNAME': 'cltbld', 16:45:07 INFO - 'MAIL': '/var/mail/cltbld', 16:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:07 INFO - 'MOZ_NO_REMOTE': '1', 16:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:07 INFO - 'NO_EM_RESTART': '1', 16:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:07 INFO - 'PWD': '/builds/slave/test', 16:45:07 INFO - 'SHELL': '/bin/bash', 16:45:07 INFO - 'SHLVL': '1', 16:45:07 INFO - 'TERM': 'linux', 16:45:07 INFO - 'TMOUT': '86400', 16:45:07 INFO - 'USER': 'cltbld', 16:45:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:07 INFO - '_': '/tools/buildbot/bin/python'} 16:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:07 INFO - Running setup.py (path:/tmp/pip-DrhgDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:07 INFO - Running setup.py (path:/tmp/pip-V8LTCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:07 INFO - Running setup.py (path:/tmp/pip-UMoVwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:07 INFO - Running setup.py (path:/tmp/pip-eo71tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:07 INFO - Running setup.py (path:/tmp/pip-Ns127H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:08 INFO - Running setup.py (path:/tmp/pip-Z0RzEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:08 INFO - Running setup.py (path:/tmp/pip-25eJuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:08 INFO - Running setup.py (path:/tmp/pip-e7Puso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:08 INFO - Running setup.py (path:/tmp/pip-YxyBFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:08 INFO - Running setup.py (path:/tmp/pip-EjGZRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:08 INFO - Running setup.py (path:/tmp/pip-wjbwib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:08 INFO - Running setup.py (path:/tmp/pip-SR2BVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:08 INFO - Running setup.py (path:/tmp/pip-Y4bW80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:08 INFO - Running setup.py (path:/tmp/pip-NGXiv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:08 INFO - Running setup.py (path:/tmp/pip-j_ylQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:08 INFO - Running setup.py (path:/tmp/pip-_i8P_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:08 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)) 16:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:08 INFO - Running setup.py (path:/tmp/pip-1CeaUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:08 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)) 16:45:08 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)) 16:45:08 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)) 16:45:08 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)) 16:45:08 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)) 16:45:08 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)) 16:45:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:08 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 16:45:08 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 16:45:08 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 16:45:08 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 16:45:08 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 16:45:08 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 16:45:10 INFO - Downloading blessings-1.6.tar.gz 16:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:10 INFO - Installing collected packages: blessings 16:45:10 INFO - Running setup.py install for blessings 16:45:10 INFO - Successfully installed blessings 16:45:10 INFO - Cleaning up... 16:45:11 INFO - Return code: 0 16:45:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:11 INFO - Reading from file tmpfile_stdout 16:45:11 INFO - Current package versions: 16:45:11 INFO - argparse == 1.2.1 16:45:11 INFO - blessings == 1.6 16:45:11 INFO - blobuploader == 1.2.4 16:45:11 INFO - docopt == 0.6.1 16:45:11 INFO - manifestparser == 1.1 16:45:11 INFO - mozInstall == 1.12 16:45:11 INFO - mozcrash == 0.17 16:45:11 INFO - mozdebug == 0.1 16:45:11 INFO - mozdevice == 0.48 16:45:11 INFO - mozfile == 1.2 16:45:11 INFO - mozhttpd == 0.7 16:45:11 INFO - mozinfo == 0.9 16:45:11 INFO - mozleak == 0.1 16:45:11 INFO - mozlog == 3.2 16:45:11 INFO - moznetwork == 0.27 16:45:11 INFO - mozprocess == 0.22 16:45:11 INFO - mozprofile == 0.28 16:45:11 INFO - mozrunner == 6.11 16:45:11 INFO - mozscreenshot == 0.1 16:45:11 INFO - mozsystemmonitor == 0.3 16:45:11 INFO - moztest == 0.7 16:45:11 INFO - mozversion == 1.4 16:45:11 INFO - psutil == 3.1.1 16:45:11 INFO - requests == 1.2.3 16:45:11 INFO - wsgiref == 0.1.2 16:45:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:11 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:11 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 16:45:11 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 16:45:11 INFO - Using env: {'DISPLAY': ':0', 16:45:11 INFO - 'HOME': '/home/cltbld', 16:45:11 INFO - 'LANG': 'en_US.UTF-8', 16:45:11 INFO - 'LANGUAGE': 'en_US:en', 16:45:11 INFO - 'LOGNAME': 'cltbld', 16:45:11 INFO - 'MAIL': '/var/mail/cltbld', 16:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:11 INFO - 'MOZ_NO_REMOTE': '1', 16:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:11 INFO - 'NO_EM_RESTART': '1', 16:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:11 INFO - 'PWD': '/builds/slave/test', 16:45:11 INFO - 'SHELL': '/bin/bash', 16:45:11 INFO - 'SHLVL': '1', 16:45:11 INFO - 'TERM': 'linux', 16:45:11 INFO - 'TMOUT': '86400', 16:45:11 INFO - 'USER': 'cltbld', 16:45:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:11 INFO - '_': '/tools/buildbot/bin/python'} 16:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 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)) 16:45:11 INFO - Cleaning up... 16:45:11 INFO - Return code: 0 16:45:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:11 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:11 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 16:45:11 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 16:45:11 INFO - Using env: {'DISPLAY': ':0', 16:45:11 INFO - 'HOME': '/home/cltbld', 16:45:11 INFO - 'LANG': 'en_US.UTF-8', 16:45:11 INFO - 'LANGUAGE': 'en_US:en', 16:45:11 INFO - 'LOGNAME': 'cltbld', 16:45:11 INFO - 'MAIL': '/var/mail/cltbld', 16:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:11 INFO - 'MOZ_NO_REMOTE': '1', 16:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:11 INFO - 'NO_EM_RESTART': '1', 16:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:11 INFO - 'PWD': '/builds/slave/test', 16:45:11 INFO - 'SHELL': '/bin/bash', 16:45:11 INFO - 'SHLVL': '1', 16:45:11 INFO - 'TERM': 'linux', 16:45:11 INFO - 'TMOUT': '86400', 16:45:11 INFO - 'USER': 'cltbld', 16:45:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:11 INFO - '_': '/tools/buildbot/bin/python'} 16:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:11 INFO - Downloading/unpacking jsonschema 16:45:11 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 16:45:11 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 16:45:11 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 16:45:11 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 16:45:11 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 16:45:11 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 16:45:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:13 INFO - Downloading/unpacking functools32 (from jsonschema) 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:13 INFO - warning: no files found matching '*.txt' 16:45:13 INFO - no previously-included directories found matching 'build' 16:45:13 INFO - no previously-included directories found matching 'dist' 16:45:13 INFO - no previously-included directories found matching '.git*' 16:45:13 INFO - Installing collected packages: jsonschema, functools32 16:45:13 INFO - Running setup.py install for functools32 16:45:13 INFO - warning: no files found matching '*.txt' 16:45:13 INFO - no previously-included directories found matching 'build' 16:45:13 INFO - no previously-included directories found matching 'dist' 16:45:13 INFO - no previously-included directories found matching '.git*' 16:45:14 INFO - Successfully installed jsonschema functools32 16:45:14 INFO - Cleaning up... 16:45:14 INFO - Return code: 0 16:45:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:45:14 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')]} 16:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:14 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')]} 16:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:14 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 0x7f0bcd48cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', '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 16:45:14 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 16:45:14 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 16:45:14 INFO - Using env: {'DISPLAY': ':0', 16:45:14 INFO - 'HOME': '/home/cltbld', 16:45:14 INFO - 'LANG': 'en_US.UTF-8', 16:45:14 INFO - 'LANGUAGE': 'en_US:en', 16:45:14 INFO - 'LOGNAME': 'cltbld', 16:45:14 INFO - 'MAIL': '/var/mail/cltbld', 16:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:14 INFO - 'MOZ_NO_REMOTE': '1', 16:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:14 INFO - 'NO_EM_RESTART': '1', 16:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:14 INFO - 'PWD': '/builds/slave/test', 16:45:14 INFO - 'SHELL': '/bin/bash', 16:45:14 INFO - 'SHLVL': '1', 16:45:14 INFO - 'TERM': 'linux', 16:45:14 INFO - 'TMOUT': '86400', 16:45:14 INFO - 'USER': 'cltbld', 16:45:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:14 INFO - '_': '/tools/buildbot/bin/python'} 16:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:14 INFO - Downloading/unpacking flake8 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:45:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:45:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 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 16:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:16 INFO - no previously-included directories found matching 'docs/_build' 16:45:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:45:16 INFO - Running setup.py install for pep8 16:45:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:17 INFO - no previously-included directories found matching 'docs/_build' 16:45:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:45:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:45:17 INFO - Cleaning up... 16:45:17 INFO - Return code: 0 16:45:17 INFO - Running post-action listener: _resource_record_post_action 16:45:17 INFO - Running post-action listener: _start_resource_monitoring 16:45:17 INFO - Starting resource monitoring. 16:45:17 INFO - ##### 16:45:17 INFO - ##### Finished create-virtualenv step (success) 16:45:17 INFO - ##### 16:45:17 INFO - ##### 16:45:17 INFO - ##### Running install step. 16:45:17 INFO - ##### 16:45:17 INFO - Running pre-action listener: _resource_record_pre_action 16:45:17 INFO - Running main action method: install 16:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:45:17 INFO - Reading from file tmpfile_stdout 16:45:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:45:17 INFO - Reading from file tmpfile_stdout 16:45:17 INFO - Output received: 16:45:17 INFO - Usage: mozinstall [options] installer 16:45:17 INFO - Options: 16:45:17 INFO - -h, --help show this help message and exit 16:45:17 INFO - -d DEST, --destination=DEST 16:45:17 INFO - Directory to install application into. [default: 16:45:17 INFO - "/builds/slave/test"] 16:45:17 INFO - --app=APP Application being installed. [default: firefox] 16:45:17 INFO - mkdir: /builds/slave/test/build/application 16:45:17 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'] 16:45:17 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 16:45:33 INFO - Reading from file tmpfile_stdout 16:45:33 INFO - Output received: 16:45:33 INFO - /builds/slave/test/build/application/firefox/firefox 16:45:33 INFO - Running post-action listener: _resource_record_post_action 16:45:33 INFO - ##### 16:45:33 INFO - ##### Finished install step (success) 16:45:33 INFO - ##### 16:45:33 INFO - ##### 16:45:33 INFO - ##### Running run-tests step. 16:45:33 INFO - ##### 16:45:33 INFO - Running pre-action listener: _resource_record_pre_action 16:45:33 INFO - Running main action method: run_tests 16:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:33 INFO - Python 2.7.3 16:45:33 INFO - Return code: 0 16:45:33 INFO - grabbing minidump binary from tooltool 16:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:33 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 0x1d2d9c0>, '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 0x1d2e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:33 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 16:45:33 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 16:45:33 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 16:45:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:33 INFO - Return code: 0 16:45:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:45:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:45:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:45:34 INFO - Return code: 0 16:45:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:45:34 INFO - Using env: {'DISPLAY': ':0', 16:45:34 INFO - 'HOME': '/home/cltbld', 16:45:34 INFO - 'LANG': 'en_US.UTF-8', 16:45:34 INFO - 'LANGUAGE': 'en_US:en', 16:45:34 INFO - 'LOGNAME': 'cltbld', 16:45:34 INFO - 'MAIL': '/var/mail/cltbld', 16:45:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:34 INFO - 'MOZ_NO_REMOTE': '1', 16:45:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:34 INFO - 'NO_EM_RESTART': '1', 16:45:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:34 INFO - 'PWD': '/builds/slave/test', 16:45:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:34 INFO - 'SHELL': '/bin/bash', 16:45:34 INFO - 'SHLVL': '1', 16:45:34 INFO - 'TERM': 'linux', 16:45:34 INFO - 'TMOUT': '86400', 16:45:34 INFO - 'USER': 'cltbld', 16:45:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869', 16:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:34 INFO - '_': '/tools/buildbot/bin/python'} 16:45:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:45:34 INFO - mozversion application_buildid: 20160525153444 16:45:34 INFO - mozversion application_changeset: 1012461fa7bb33adf728ec631020cb18153da6f0 16:45:34 INFO - mozversion application_display_name: Nightly 16:45:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:34 INFO - mozversion application_name: Firefox 16:45:34 INFO - mozversion application_remotingname: firefox 16:45:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:45:34 INFO - mozversion application_vendor: Mozilla 16:45:34 INFO - mozversion application_version: 49.0a1 16:45:34 INFO - mozversion platform_buildid: 20160525153444 16:45:34 INFO - mozversion platform_changeset: 1012461fa7bb33adf728ec631020cb18153da6f0 16:45:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:45:34 INFO - mozversion platform_version: 49.0a1 16:45:34 INFO - using testdate: 1464219934 16:45:34 INFO - actual date: 1464219934 16:45:34 INFO - starting webserver on 'localhost:51293' 16:45:34 INFO - SUITE-START | Running 2 tests 16:45:34 INFO - TEST-START | dromaeo_css 16:45:34 INFO - operating with platform_type : linux_ 16:45:34 INFO - Initialising browser for dromaeo_css test... 16:45:34 INFO - TEST-INFO | started process 6284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparXhRm/profile http://localhost:51293/getInfo.html) 16:45:38 INFO - PROCESS | 6284 | __metrics Screen width/height:1600/1200 16:45:38 INFO - PROCESS | 6284 | colorDepth:24 16:45:38 INFO - PROCESS | 6284 | Browser inner width/height: 1024/697 16:45:38 INFO - PROCESS | 6284 | __metrics 16:45:39 ERROR - PROCESS | 6284 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:45:40 INFO - TEST-INFO | 6284: exit 0 16:45:40 INFO - Browser initialized. 16:45:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:40 INFO - TEST-INFO | started process 6367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparXhRm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:52 INFO - PROCESS | 6367 | RSS: Main: 156708864 16:45:52 INFO - PROCESS | 6367 | 16:46:44 INFO - PROCESS | 6367 | 1464220004467 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] 16:48:56 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51293/tests/dromaeo/cssquery-ext.html) 16:48:57 INFO - PROCESS | 6367 | RSS: Main: 233902080 16:48:57 INFO - PROCESS | 6367 | 16:51:59 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-ext.html (next: http://localhost:51293/tests/dromaeo/cssquery-jquery.html) 16:52:00 INFO - PROCESS | 6367 | RSS: Main: 239378432 16:52:00 INFO - PROCESS | 6367 | 16:55:02 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51293/tests/dromaeo/cssquery-mootools.html) 16:55:03 INFO - PROCESS | 6367 | RSS: Main: 232280064 16:55:03 INFO - PROCESS | 6367 | 16:58:05 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51293/tests/dromaeo/cssquery-prototype.html) 16:58:05 INFO - PROCESS | 6367 | RSS: Main: 233238528 16:58:05 INFO - PROCESS | 6367 | 17:01:08 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51293/tests/dromaeo/cssquery-yui.html) 17:01:09 INFO - PROCESS | 6367 | RSS: Main: 215392256 17:01:09 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | Cycle 1(1): loaded http://localhost:51293/tests/dromaeo/cssquery-yui.html (next: http://localhost:51293/tests/dromaeo/cssquery-dojo.html) 17:04:12 INFO - PROCESS | 6367 | RSS: Main: 272846848 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | __start_tp_report 17:04:12 INFO - PROCESS | 6367 | _x_x_mozilla_page_load 17:04:12 INFO - PROCESS | 6367 | _x_x_mozilla_page_load_details 17:04:12 INFO - PROCESS | 6367 | |i|pagename|runs| 17:04:12 INFO - PROCESS | 6367 | |0;dojo.html;2695.9999999999995;2712.9321766955813;2731.521983652861;2744.7255274472554;2766.6126742256088;4538.160440318535;4577.2218722817115;4666.323383109451;4750.049990001996;4790.209615413457;4663.60359369454;4666.23007203811;4685.695429797061;4687.062587482508;4690.5074967128385;4096.487939007624;4246.681498887588;4357;4383.276759334706;4403.6256918162;4318.52496225415;4355.216061108999;4356.651467882578;4371.868843934687;4403.273459879116;4224.345226489883;4268.573142685737;4296.892577685551;4314.201872653538;4329.090890912912;4270.807813648394;4306.461692288464;4326.156399502099;4356.063446359017;4387.166438376698;4319;4332.696711230215;4346.978265108686;4361.454818147731;4382.956170438287;4484.417025786627;4577.862664120082;4604.815807367701;4622.745748983804;4637.95362046382;5122.590192784605;5158.613104017214;5159.5614372778355;5164.173732202829;5170.870728231786;5139.948600514022;5181.559567436772;5183.50756678115;5197.636165468419;5201.219817027439;4613.723176609415;4742.099001189832;4785.066911952136;4786.994731106437;4816.903661926742;5291.3121294231505;5328.600354973392;5332.466753324637;5332.893342133136;5336.653117547347;4897.094037603055;5043.722595257223;5104.106781313255;5105.259737338065;5105.953279577678;5012.373453318335;5043.924341134886;5062.088824011639;5085;5108.540231379119;5014.724190169502;5016.2224855147515;5035.093683137071;5040.420351659533;5077.898442031139;4832.299316599144;4957.752112394366;5010.298558201855;5013.674111182761;5020.824271150565;4300.526942036374;4343.131373725268;4351.5430879757805;4365.236083685342;4388.210122178039;3759.2293579816073;3779.5653499847867;3789;3824.694024478035;3840.558335791364;4202.159568086395;4245.023644561768;4268.530461649216;4331.588499092644;4342.82628694855;5045.5459008689395;5102.668326558762;5112.130937740593;5115.2071428928575;5158.587313014949;4289.699721019499;4321.330193819963;4321.524632290446;4362.432883725159;4374.12517496502;4497.550244975476;4522.547745225517;4530.365748795171;4592.747398893026;4610.331501932201;4712.575868171881;4755.690880092783;4772.141014617402;4776.713397196179;4824.565789079;5097.617678674188;5120.948790512047;5123.74381280927;5124.56441202502;5146.0737067326745;4609.4699109602825;4711.034237981275;4746.098241334135;4769.093872164278;4832.251001094836;5015.824446144367;5027.949720502748;5040.117979353672;5044.722540260321;5085.949140508696;5082.822101226439;5085.262636917552;5085.415177254663;5134.281200631989;5134.9743251285;4822;4901.460839307744;4937.8271760488215;4949.82675606352;4959.057779021974;4949.925751113664;4957.03337849116;4963.081829861487;4971.403431588233;5023.045621331935;4903.5586797188425;4916.803327866988;4918.286848407032;4980.078685443204;4985.825496107764;4836.322914791862;4902.117618828645;4931.580815630568;4945.6043516517875;4963.726995015309;4833.081714474239;4865.1242776300605;4872.049950259807;4874.610031197567;4924.212126059813 17:04:12 INFO - PROCESS | 6367 | |1;ext.html;576.8990426675331;594.5986459140081;602.9216201893753;604.5496105401477;610.9602875813072;27014.72985270147;29734.851325743395;29808.701912980865;29860.850695746543;43474.782626086904;41092.17815643685;41461.58538414615;41734.165316693645;41737.791311043475;41759;7695.846083078335;7879.96060019702;7880.172581878906;7881.684732610689;7883.684652613889;7677.270659287359;7820.139784623687;7824.921750782505;7826.843463130734;7834.216578342149;7820.061592608867;7866.606669666522;7882.448228623999;7886.250806173433;7889.289963903248;7807.375409967218;7856.567888766115;7864.331531819802;7869.2130786921425;7871.17352677972;7646.235376462309;7719.807004824925;7723.189065148134;7734.613269336567;7740.342070923978;35792.28415431677;36128;36144;36191.199924007866;36214.8189259052;3010.729034386894;3074.0777766669908;3087.552304915797;3105.223694076481;3179.920501987469;28757.281067973257;29046.709532904613;29159.125226243246;29345;29981.100566983027;3490.3891818931584;3545.3795585772646;3558.5551806024246;3598.946015809765;3637.0725465006517;275491;278670;279181;279831;280007;55040.44959550433;56339.15491267634;56371.71814140903;56403.43596564064;56449.74201031995;32315.35369292648;33515;33681.15797105092;35698.28603427917;35730;15091.849081509265;15222;15257.237138143048;15263.160526170945;15268.3892644293;11465.369404682822;11545.595904143314;11555.902189292005;11559.190856640123;11559.479823407966;18518;18526.722099168524;18574.814251857308;18613.627727445375;18653.533661658297;6954.756583519553;7011.964940175267;7070.611116388545;7098.68055937484;7115.181754098241;795.1769918134703;862.66787286895;930.8650245714333;991.3704797453524;1039.6725031615017;27385.863070684518;28341.291467713472;28612.42775144527;29074;29091.27271818179;812.5084323984023;949.8052899155656;960.8030353777459;978.4471773447979;997.5162046407487;14971.850281497263;15154.772678409832;15261.9236903817;15325.157116358707;15362.078275303518;384421;385598;388215;388323;389397;50904;51411.228831567554;51627.74186129045;51654.741726291126;51682;1096.5613754498106;1209.3832145605804;1250.1061740855332;1266.9873301267053;1365.6108009217128;26192.8690356547;29316.267093322836;29830.25424364408;29849.25376865596;30283.545746813375;42858.35712464378;43669.78165109154;43716.56283437125;43760.56239437565;43762;367584;378007;378377;379646;379683;32648.673513264563;33462.832685836416;33464.665353347125;35777.64222357743;37057.81471092627;35848.82075589606;39852.2029559413;40502.1899562013;40568;40575.59424405718;34918.65081349255;34958.475622866186;34958.65041349554;35383.64616353803;35946.64053359433;34830.30339393249;34989.125271868405;35234.47148292829;35381.646183537836;35567.28865422729;34271;34686.13284667904;34872.30255394929;34926.650733493356;35160;31183.84408077945;31289.8435507821;31511.684883151793;31751.682483175795;31878.203044924063;24051.639225411982;24068.39829004289;24156.51686966286;24594.020715162143;24795.752042480064 17:04:12 INFO - PROCESS | 6367 | |2;jquery.html;362.43279267945644;376.3526734017489;377.29069349622705;380.35339922132374;387.0729602601769;15366.769498457517;15988.200589970484;16315.10266935318;16374.508764737062;16752;14171.858281417182;15895.920520397382;16115.355385784584;16141.192940352994;16175.676486470264;4866.31871537985;5043.067032598962;5082.898342033176;5084.110280700863;5085.821996230115;3739.551253849528;3891.8248678809523;5051.267566202917;5602.915956260659;5911.083782013795;5941.792037278696;5944.583879128462;5965.1052342148805;5973.133895585138;5982.8803423931495;5683.147527870811;5825.097109947965;5878.559108066891;5966.433188847052;5974.044152935509;3332.8500217490273;4785.569298763093;5016.974915125437;5046.646734728571;5059.3169922060415;19717.30989415378;20538.486537836525;20555.89722051395;20644.38066857997;20651.69022464664;1927.1809480970671;2083.114676262582;2222.3999520129473;2340.707411573553;2442.5237078769646;12604.621861344174;12990;13001.479940802357;13610.251436171007;13640.386182621805;1717.4074944144375;1748.7027205375116;1761.4329495075779;1766.1169415292354;1839.1815642039298;63514.68242658757;65602.99999999952;66386.33613663849;66694.66652666754;67924.6603766978;8964.955175224213;9159.450432974043;9328;9388.765280868032;9665.9033409665;12758.872411275768;12836.743265134644;12868.22790632565;12888.677783055498;12891.35543222835;7398.186199518049;7449.180590135081;7480.438967077491;7607.277308655669;7631.465797394129;7223.530470519399;7316.231795661485;7316.926830731624;7383.630818459055;7436.182019977907;5959.195508606369;6088.11722300264;6135.355787642323;6138.005148326812;6263.968680156661;1593.9920300398423;1666.1003058348356;1675.572728954109;1700.3113738935751;1708.9658206835793;847.1020718038775;851.1828644501348;879.76246413468;919.4023884475012;946.1768261612441;16361.427350042692;17502.91248543749;17508.649827003388;17646.558836029202;17777.555561111076;866.1728049712509;898.7124120281578;913.8172365526921;938.5823308627595;940.8695825326821;10052.145567626687;10199.898001020043;10226.897731022595;10339.327943683636;10339.948300258451;278455;279142;381349;390810;391125;77071.61464192755;78483;79581;80258.5987070061;82332;943.7687766497252;974.931754777173;990.0249003238586;990.3562684255147;992.3599278465349;14986.584323895224;15477.5356739298;15712.842871571595;15731.134787586334;15987.360505579647;34428.48357274693;34738;35097.473537897466;36114;36138.8193059033;45195;46970;47472.52527474819;52115.513097933515;52333.21500177424;7675.846483070196;7711.228877112244;7854.960725196337;7879.369650427838;7915.485493442908;7189.784306470814;8902.777430564287;9950.651727189514;12208.389580520761;12240.143189976616;6393.808185754435;9777.604486900755;9943;10040.548175331982;10211.84682229782;10257.333273337508;10299.12457441096;10319.226058045826;10386;10805;9755.609775608897;9882.407055576688;9931.155851752683;10051.346662466916;10431.582736690447;7398.741044063432;7668.386529077772;7758.146603873683;7774.028246469192;7880.763577092696;7364.668589913574;9028.638854445748;9678.177354924628;10070.798584028425;10281.383117013003 17:04:12 INFO - PROCESS | 6367 | |3;mootools.html;1200.8739082396353;1445.4507287230851;1456.468389038001;1597.321138516131;1754.7367894815777;6772.796816095519;7572.962135189323;7829.960850195741;7839.529628222296;7861.292483676475;7529.811754706135;7605.543667379961;7666.31003209711;7902.802429939255;7907.327877130437;1901.6672082385596;2155.3210738617363;2182.388931099291;2228.1198926424054;2229.4314949687805;2181.8581792183536;2200.3948914048683;2202.537467131904;2204.790544898232;2205.547862688145;2151.6880052392394;2166.869987800729;2176.249194028058;2189.5292512109895;2197.5824593327297;1797.3529529369416;2038.4292398128548;2095.0258129969484;2112.7570329412083;2149.7312835895514;2132.296342207068;2161.3623980925663;2163.707899433572;2165.761766205716;2167.533980194266;7774.961125194338;7848;7853.136155022943;7859.449838511307;7861.842763144762;4326.459192600925;4443.46678398591;4443.5556444355625;4444.777761111932;4446.088551846864;2884.0915111739946;2950.6606740224934;3024.4102400032;3039.1338468536583;3047.649520305149;890.3767362846033;929.2287401456774;937.1659223291276;981.2640519610293;981.5239608789731;10740.570377184904;10984.505697243643;10998.230123891331;11015.173861960386;11015.779684406267;4242.830286788494;4311.9784401077795;4326.805293761789;4335.501417336984;4381.3208952612395;9499.43003419797;9508.90491095094;9510.38182518134;9527.857082143773;9528.094830991045;4448.065906159678;4448.488423831236;4450.866474005785;4451.955480445219;4456.264716321835;3487.5989261234777;3968.523777146761;3989.840406383712;4112.218678451085;4120.763770868727;3733.0853940784136;3735.7571757835653;3794.867179648699;3831.1571454280015;3847.1920896612023;1202.7233736240714;1205.5900993662196;1208.6796998795326;1211.981820272679;1224.344975438154;611.5260672978477;660.1022609251414;671.768239957214;736.6059158350364;806.4999700185922;4866.124097662384;4866.221404575251;4967.428745694219;5003.974980125149;5060.240963855451;799.2726618776885;817;825.1377310710322;833.6790335720791;879.2350654930124;3434.7252219822853;3491.809550307808;3513.7364697647267;3543.8228088595984;3600.207954250061;9719;9978.600855965826;10016.198704103654;10028;10057.949710251549;9297.302702297355;9662.75843103914;9857.950710246403;9940.055694708992;9957.253206009578;7218.314260145278;7328.120625524971;7369.373603243785;7394.926050739531;7401.5189012714;5057.7724002419245;5260.473952604709;5300.496452836975;5338.225957236256;5380.596455265949;8929.776755580902;9066.546672666209;9080.091990800867;9438.575264112995;9456.858147127936;9430.62277508892;9471.715848524555;9543.236541076558;9571.1864491519;9583;6671.26616072222;6920;6939.965300173467;7555.622218889143;7764.06831180262;6739.66301684904;6805.081314022544;7653.158152603321;7662.348700360531;7919.643616037177;6775.661216939232;6904.516683832285;6943.375096241362;6981.3367730065565;7114.679839407136;6749.898751518633;6924.307569243036;7002.894956575554;7089.82275443118;7112.03987461686;6336.524760643062;6427.807165785034;6439.742410303723;6698.39714425704;6746.527743057939;4303.870883873489;4321.78391080451;4399.208142534247;4409.514953355192;4420.977895110504;4361.760103194355;4444.066745983379;4566.611837993808;4579.175748365326;4659.998100408293 17:04:12 INFO - PROCESS | 6367 | |4;prototype.html;281.317804324513;283.62183094750515;288.4001277343126;291.52772508536145;293.8486679360129;4716.85849424517;4725.8582242532775;4755.833545825897;4758.1197478466465;4805.126000859667;4374;4446.666500012496;4507.594316511513;4676.883077923054;4688.554587314208;3623.1884057971015;3627.727920405967;3632.963670363289;3674.2810320363005;3684.9815750921275;3631.963680363189;3641.253543023687;3650.3794354959587;3651.8174091295464;3661.8718344857934;3483;3527.276908233806;3630.4735813307057;3639.5450568678916;3663.7069034477313;3623.601403845575;3625.492431059654;3636.945445818328;3637.8908632740795;3656.963430365689;3208.230024794056;3221.1624977505785;3227.564278822376;3227.6610955849533;3240.821754803485;4395.450568678915;4417.845375411877;4535.546445355471;4535.841245556423;4539.341795439643;4115.218108559394;4176.749395036277;4183.581641835823;4185.644220241283;4189.329707246857;4824.372831531913;4833;4836.371271734687;4849.563539281482;4871.12319782439;3485.4074807282823;3504.754667173299;3505.526753888218;3534.6288639692975;3538.080099174233;4892.828750993698;5087.262346959707;5087.364079490064;5100.821471248526;5147.871303217412;3539.8761043363875;3575.1419659282105;3576.6959808416577;3592.7485076044427;3593.748437609342;3640.927181456356;3662.7619204751604;3664.4136938089778;3678.356287649704;3686.2258925625383;3989.5212574491247;4094.651954583834;4140.565240649748;4180.163967206571;4192.538820729717;4828.589569886529;4838.661293709407;4848.418189817245;4854.441739200037;4855.95144048555;1185.2829038431796;1210.6549633354452;1226.3316492511424;1261.3630116791146;1262.0408489547826;805.2229598437536;817.2767101115555;827.8882350882553;828.2173346187794;834.7746108550779;3838.1747924196434;3850.634189752025;3905.628965248297;3906.2382835347403;3907.941380879289;4432.889177770581;4487.461504619467;4508;4517.983453722886;4548.795304211319;3873.922521549553;3882.184741204322;3896.785676787804;3901.882943511699;3917.804109794499;2415.357556861351;2435.8294919355476;2501.6122501012374;2712.0236714782664;2726.8636568171514;4758.906081324206;4792.760361981887;4812.8796780080775;4814.253790662453;4815.374001379798;5194.4026436959475;5216.60875434344;5221.7128057956415;5221.791128354899;5233.4243233244315;4676.859694209179;4743.549362810528;4810.759462026815;4812.639052071108;4841.806327746921;5053.924191137063;5089.541941225308;5096.23556466533;5125.795438071976;5149.639525233348;4947.48051454592;4998.1253280676465;5003.424606170337;5005.774740136775;5012.924806127984;4672.995306009224;4723.126221649006;4836.081144582518;4841.346418233494;4846.224604063333;3518.7712798668003;3531.9293614128087;3535;3542.220711443478;3551.9467207992416;4854.95145048545;5055.5702765263895;5099.413567439792;5109.565686916654;5126.641440018473;4842.58837998774;4918.729469879191;4919.532644398776;4938.209886418156;4938.358013458227;4889.657723959289;4896.7758060484875;4899.3385892904;4929.112759703288;4946.752662366939;4607.285870690049;4809.254565542346;4834.6374021947795;4864.659473836798;4879.829205977774;4989.501049895127;4989.72556509381;4993.226049962262;4998.800047998039;5010.749462526932;4902.828401005948;4920.8769780755765;4920.975395123145;4927.260910863256;4930.408350997904 17:04:12 INFO - PROCESS | 6367 | |5;yui.html;647.6405594894833;748.5134662469391;764.1899586438376;767.4167632599226;772.9072511298644;12174.878251217486;12679.429425675844;12880.67798305043;12888.548900788473;12888.999999999989;13008;13554.932225338884;13563.389647465863;13580.253086080287;13602.659933501667;640.1262276991896;783.4437549339975;799.2327365728893;801.2988634944423;816.0982114763191;797.4457751862458;811.8457493076326;812.8861959325699;813.2152472863685;813.3168138763438;855.2943821347383;860.2300940658107;861.1775754154767;861.4314552395421;861.6553378648559;497.1573183454047;826.4132465949123;843.4475418600765;856.4304737349655;857.652650676477;625.9029850373154;626.264139635926;627.2191122053073;627.5481653209682;627.7112528237017;13016;13036.283004434752;13037.54368597104;13039.739205215938;13094.86905130946;11602.187846850724;12179.939100304531;12260.81608775869;12334.53309338127;12484.250944943242;9860;10229.539670714836;10292.794144117075;10506.212034097396;11278.887211127947;3257.5765150530515;3291.078498020558;3325.567676202078;3330.633630300665;3405.506201600754;46596.534034659555;47097.76451117757;47274.29088563674;47624;48095;9865.408075515492;9941.919204487109;10040.096391324816;10264.538095785707;10306.227032972407;18526.444206673823;18531.35140270111;18592;18604.34884779026;18624.16191271396;6684;6822.181338239443;6828.897566536506;6924.58452492852;6967.965160174268;3774.6602805747616;3810.6951443884977;3828.2534905693124;3876.8836934891997;3890.4164375343357;2787.8466684332557;2874.8275103493856;2875.56866470027;2876.453473839964;2883.226815508489;495.62332627203585;524.4702850121329;529.2722506553489;534.5536477041713;540.6296686769575;414.49638688992417;469.3452633576142;519.732337846002;567.8154599755013;574.5920396518519;7055.3650171484815;7273.27267273279;7364.77905662831;7409.110906691231;7493.625318734042;544.6024402186426;553.914143307788;558.2352177516827;562.0220815780513;566.3091028944681;3331.06730115568;3366.259422926952;3370.6292307846115;3438.9312213755584;3446.5347178131133;51844.481555183964;54249.72875135599;54618.180727289124;54836;55325.446745532834;48646.513534864906;49232.753836231306;49690.254646180336;50313;50385.49614503808;45067;45222.32166517505;45952.77023614928;46102;46293.5370646296;6644.46844252449;6670.499712521483;6698.765543205965;6746.156730408699;6788.9660551696925;29695;30381.392372152874;31331.216719582193;31355.372892542477;31401.37197256088;37475.625243748305;39120.80439597784;39354.409683854195;39908.401373978835;40475.797621011705;9702.175315098295;10192;10234.692959211236;10234.795304094025;10315.48422578883;9823.803523929624;10058.54736536843;10186.745331366776;10293.330933489298;10491.265611407129;9168.174864262248;9378.390404623678;9524.666636667684;9607.471589062668;9749.9025009749;9207.125323094564;9338.439693618404;9367.5784589695;9554.665586704432;9706.126448619658;8962.283017358726;9180.311476639145;9418.246540276625;9491.288153388385;9591.808163836544;7510.62446877643;7761.534307941542;7780.649870755717;7963.243491868263;7989.2809647132035;7663;7908.723194688158;7931.286184243446;8086.474379165335;8187.5087494750505 17:04:12 INFO - PROCESS | 6367 | __end_tp_report 17:04:12 INFO - PROCESS | 6367 | __start_cc_report 17:04:12 INFO - PROCESS | 6367 | _x_x_mozilla_cycle_collect,1034 17:04:12 INFO - PROCESS | 6367 | __end_cc_report 17:04:12 INFO - PROCESS | 6367 | __startTimestamp1464221052390__endTimestamp 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | ------- Summary: start ------- 17:04:12 INFO - PROCESS | 6367 | Number of tests: 6 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#0] dojo.html Cycles:165 Average:4685.33 Median:4816.90 stddev:496.80 (10.3%) stddev-sans-first:473.18 17:04:12 INFO - PROCESS | 6367 | Values: 2696.0 2712.9 2731.5 2744.7 2766.6 4538.2 4577.2 4666.3 4750.0 4790.2 4663.6 4666.2 4685.7 4687.1 4690.5 4096.5 4246.7 4357.0 4383.3 4403.6 4318.5 4355.2 4356.7 4371.9 4403.3 4224.3 4268.6 4296.9 4314.2 4329.1 4270.8 4306.5 4326.2 4356.1 4387.2 4319.0 4332.7 4347.0 4361.5 4383.0 4484.4 4577.9 4604.8 4622.7 4638.0 5122.6 5158.6 5159.6 5164.2 5170.9 5139.9 5181.6 5183.5 5197.6 5201.2 4613.7 4742.1 4785.1 4787.0 4816.9 5291.3 5328.6 5332.5 5332.9 5336.7 4897.1 5043.7 5104.1 5105.3 5106.0 5012.4 5043.9 5062.1 5085.0 5108.5 5014.7 5016.2 5035.1 5040.4 5077.9 4832.3 4957.8 5010.3 5013.7 5020.8 4300.5 4343.1 4351.5 4365.2 4388.2 3759.2 3779.6 3789.0 3824.7 3840.6 4202.2 4245.0 4268.5 4331.6 4342.8 5045.5 5102.7 5112.1 5115.2 5158.6 4289.7 4321.3 4321.5 4362.4 4374.1 4497.6 4522.5 4530.4 4592.7 4610.3 4712.6 4755.7 4772.1 4776.7 4824.6 5097.6 5120.9 5123.7 5124.6 5146.1 4609.5 4711.0 4746.1 4769.1 4832.3 5015.8 5027.9 5040.1 5044.7 5085.9 5082.8 5085.3 5085.4 5134.3 5135.0 4822.0 4901.5 4937.8 4949.8 4959.1 4949.9 4957.0 4963.1 4971.4 5023.0 4903.6 4916.8 4918.3 4980.1 4985.8 4836.3 4902.1 4931.6 4945.6 4963.7 4833.1 4865.1 4872.0 4874.6 4924.2 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#1] ext.html Cycles:180 Average:49342.95 Median:35784.96 stddev:92547.08 (258.6%) stddev-sans-first:92734.27 17:04:12 INFO - PROCESS | 6367 | Values: 576.9 594.6 602.9 604.5 611.0 27014.7 29734.9 29808.7 29860.9 43474.8 41092.2 41461.6 41734.2 41737.8 41759.0 7695.8 7880.0 7880.2 7881.7 7883.7 7677.3 7820.1 7824.9 7826.8 7834.2 7820.1 7866.6 7882.4 7886.3 7889.3 7807.4 7856.6 7864.3 7869.2 7871.2 7646.2 7719.8 7723.2 7734.6 7740.3 35792.3 36128.0 36144.0 36191.2 36214.8 3010.7 3074.1 3087.6 3105.2 3179.9 28757.3 29046.7 29159.1 29345.0 29981.1 3490.4 3545.4 3558.6 3598.9 3637.1 275491.0 278670.0 279181.0 279831.0 280007.0 55040.4 56339.2 56371.7 56403.4 56449.7 32315.4 33515.0 33681.2 35698.3 35730.0 15091.8 15222.0 15257.2 15263.2 15268.4 11465.4 11545.6 11555.9 11559.2 11559.5 18518.0 18526.7 18574.8 18613.6 18653.5 6954.8 7012.0 7070.6 7098.7 7115.2 795.2 862.7 930.9 991.4 1039.7 27385.9 28341.3 28612.4 29074.0 29091.3 812.5 949.8 960.8 978.4 997.5 14971.9 15154.8 15261.9 15325.2 15362.1 384421.0 385598.0 388215.0 388323.0 389397.0 50904.0 51411.2 51627.7 51654.7 51682.0 1096.6 1209.4 1250.1 1267.0 1365.6 26192.9 29316.3 29830.3 29849.3 30283.5 42858.4 43669.8 43716.6 43760.6 43762.0 367584.0 378007.0 378377.0 379646.0 379683.0 32648.7 33462.8 33464.7 35777.6 37057.8 35848.8 39852.2 40502.2 40568.0 40575.6 34918.7 34958.5 34958.7 35383.6 35946.6 34830.3 34989.1 35234.5 35381.6 35567.3 34271.0 34686.1 34872.3 34926.7 35160.0 31183.8 31289.8 31511.7 31751.7 31878.2 24051.6 24068.4 24156.5 24594.0 24795.8 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#2] jquery.html Cycles:180 Average:22925.76 Median:4941.65 stddev:57809.39 (1169.8%) stddev-sans-first:57946.74 17:04:12 INFO - PROCESS | 6367 | Values: 362.4 376.4 377.3 380.4 387.1 15366.8 15988.2 16315.1 16374.5 16752.0 14171.9 15895.9 16115.4 16141.2 16175.7 4866.3 5043.1 5082.9 5084.1 5085.8 3739.6 3891.8 5051.3 5602.9 5911.1 5941.8 5944.6 5965.1 5973.1 5982.9 5683.1 5825.1 5878.6 5966.4 5974.0 3332.9 4785.6 5017.0 5046.6 5059.3 19717.3 20538.5 20555.9 20644.4 20651.7 1927.2 2083.1 2222.4 2340.7 2442.5 12604.6 12990.0 13001.5 13610.3 13640.4 1717.4 1748.7 1761.4 1766.1 1839.2 63514.7 65603.0 66386.3 66694.7 67924.7 8965.0 9159.5 9328.0 9388.8 9665.9 12758.9 12836.7 12868.2 12888.7 12891.4 7398.2 7449.2 7480.4 7607.3 7631.5 7223.5 7316.2 7316.9 7383.6 7436.2 5959.2 6088.1 6135.4 6138.0 6264.0 1594.0 1666.1 1675.6 1700.3 1709.0 847.1 851.2 879.8 919.4 946.2 16361.4 17502.9 17508.6 17646.6 17777.6 866.2 898.7 913.8 938.6 940.9 10052.1 10199.9 10226.9 10339.3 10339.9 278455.0 279142.0 381349.0 390810.0 391125.0 77071.6 78483.0 79581.0 80258.6 82332.0 943.8 974.9 990.0 990.4 992.4 14986.6 15477.5 15712.8 15731.1 15987.4 34428.5 34738.0 35097.5 36114.0 36138.8 45195.0 46970.0 47472.5 52115.5 52333.2 7675.8 7711.2 7855.0 7879.4 7915.5 7189.8 8902.8 9950.7 12208.4 12240.1 6393.8 9777.6 9943.0 10040.5 10211.8 10257.3 10299.1 10319.2 10386.0 10805.0 9755.6 9882.4 9931.2 10051.3 10431.6 7398.7 7668.4 7758.1 7774.0 7880.8 7364.7 9028.6 9678.2 10070.8 10281.4 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#3] mootools.html Cycles:180 Average:5187.76 Median:4985.70 stddev:2985.09 (59.9%) stddev-sans-first:2978.43 17:04:12 INFO - PROCESS | 6367 | Values: 1200.9 1445.5 1456.5 1597.3 1754.7 6772.8 7573.0 7830.0 7839.5 7861.3 7529.8 7605.5 7666.3 7902.8 7907.3 1901.7 2155.3 2182.4 2228.1 2229.4 2181.9 2200.4 2202.5 2204.8 2205.5 2151.7 2166.9 2176.2 2189.5 2197.6 1797.4 2038.4 2095.0 2112.8 2149.7 2132.3 2161.4 2163.7 2165.8 2167.5 7775.0 7848.0 7853.1 7859.4 7861.8 4326.5 4443.5 4443.6 4444.8 4446.1 2884.1 2950.7 3024.4 3039.1 3047.6 890.4 929.2 937.2 981.3 981.5 10740.6 10984.5 10998.2 11015.2 11015.8 4242.8 4312.0 4326.8 4335.5 4381.3 9499.4 9508.9 9510.4 9527.9 9528.1 4448.1 4448.5 4450.9 4452.0 4456.3 3487.6 3968.5 3989.8 4112.2 4120.8 3733.1 3735.8 3794.9 3831.2 3847.2 1202.7 1205.6 1208.7 1212.0 1224.3 611.5 660.1 671.8 736.6 806.5 4866.1 4866.2 4967.4 5004.0 5060.2 799.3 817.0 825.1 833.7 879.2 3434.7 3491.8 3513.7 3543.8 3600.2 9719.0 9978.6 10016.2 10028.0 10057.9 9297.3 9662.8 9858.0 9940.1 9957.3 7218.3 7328.1 7369.4 7394.9 7401.5 5057.8 5260.5 5300.5 5338.2 5380.6 8929.8 9066.5 9080.1 9438.6 9456.9 9430.6 9471.7 9543.2 9571.2 9583.0 6671.3 6920.0 6940.0 7555.6 7764.1 6739.7 6805.1 7653.2 7662.3 7919.6 6775.7 6904.5 6943.4 6981.3 7114.7 6749.9 6924.3 7002.9 7089.8 7112.0 6336.5 6427.8 6439.7 6698.4 6746.5 4303.9 4321.8 4399.2 4409.5 4421.0 4361.8 4444.1 4566.6 4579.2 4660.0 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#4] prototype.html Cycles:180 Average:4035.86 Median:4537.59 stddev:1185.63 (26.1%) stddev-sans-first:1154.98 17:04:12 INFO - PROCESS | 6367 | Values: 281.3 283.6 288.4 291.5 293.8 4716.9 4725.9 4755.8 4758.1 4805.1 4374.0 4446.7 4507.6 4676.9 4688.6 3623.2 3627.7 3633.0 3674.3 3685.0 3632.0 3641.3 3650.4 3651.8 3661.9 3483.0 3527.3 3630.5 3639.5 3663.7 3623.6 3625.5 3636.9 3637.9 3657.0 3208.2 3221.2 3227.6 3227.7 3240.8 4395.5 4417.8 4535.5 4535.8 4539.3 4115.2 4176.7 4183.6 4185.6 4189.3 4824.4 4833.0 4836.4 4849.6 4871.1 3485.4 3504.8 3505.5 3534.6 3538.1 4892.8 5087.3 5087.4 5100.8 5147.9 3539.9 3575.1 3576.7 3592.7 3593.7 3640.9 3662.8 3664.4 3678.4 3686.2 3989.5 4094.7 4140.6 4180.2 4192.5 4828.6 4838.7 4848.4 4854.4 4856.0 1185.3 1210.7 1226.3 1261.4 1262.0 805.2 817.3 827.9 828.2 834.8 3838.2 3850.6 3905.6 3906.2 3907.9 4432.9 4487.5 4508.0 4518.0 4548.8 3873.9 3882.2 3896.8 3901.9 3917.8 2415.4 2435.8 2501.6 2712.0 2726.9 4758.9 4792.8 4812.9 4814.3 4815.4 5194.4 5216.6 5221.7 5221.8 5233.4 4676.9 4743.5 4810.8 4812.6 4841.8 5053.9 5089.5 5096.2 5125.8 5149.6 4947.5 4998.1 5003.4 5005.8 5012.9 4673.0 4723.1 4836.1 4841.3 4846.2 3518.8 3531.9 3535.0 3542.2 3551.9 4855.0 5055.6 5099.4 5109.6 5126.6 4842.6 4918.7 4919.5 4938.2 4938.4 4889.7 4896.8 4899.3 4929.1 4946.8 4607.3 4809.3 4834.6 4864.7 4879.8 4989.5 4989.7 4993.2 4998.8 5010.7 4902.8 4920.9 4921.0 4927.3 4930.4 17:04:12 INFO - PROCESS | 6367 | 17:04:12 INFO - PROCESS | 6367 | [#5] yui.html Cycles:180 Average:12839.87 Median:522.10 stddev:15228.78 (2916.8%) stddev-sans-first:15243.98 17:04:12 INFO - PROCESS | 6367 | Values: 647.6 748.5 764.2 767.4 772.9 12174.9 12679.4 12880.7 12888.5 12889.0 13008.0 13554.9 13563.4 13580.3 13602.7 640.1 783.4 799.2 801.3 816.1 797.4 811.8 812.9 813.2 813.3 855.3 860.2 861.2 861.4 861.7 497.2 826.4 843.4 856.4 857.7 625.9 626.3 627.2 627.5 627.7 13016.0 13036.3 13037.5 13039.7 13094.9 11602.2 12179.9 12260.8 12334.5 12484.3 9860.0 10229.5 10292.8 10506.2 11278.9 3257.6 3291.1 3325.6 3330.6 3405.5 46596.5 47097.8 47274.3 47624.0 48095.0 9865.4 9941.9 10040.1 10264.5 10306.2 18526.4 18531.4 18592.0 18604.3 18624.2 6684.0 6822.2 6828.9 6924.6 6968.0 3774.7 3810.7 3828.3 3876.9 3890.4 2787.8 2874.8 2875.6 2876.5 2883.2 495.6 524.5 529.3 534.6 540.6 414.5 469.3 519.7 567.8 574.6 7055.4 7273.3 7364.8 7409.1 7493.6 544.6 553.9 558.2 562.0 566.3 3331.1 3366.3 3370.6 3438.9 3446.5 51844.5 54249.7 54618.2 54836.0 55325.4 48646.5 49232.8 49690.3 50313.0 50385.5 45067.0 45222.3 45952.8 46102.0 46293.5 6644.5 6670.5 6698.8 6746.2 6789.0 29695.0 30381.4 31331.2 31355.4 31401.4 37475.6 39120.8 39354.4 39908.4 40475.8 9702.2 10192.0 10234.7 10234.8 10315.5 9823.8 10058.5 10186.7 10293.3 10491.3 9168.2 9378.4 9524.7 9607.5 9749.9 9207.1 9338.4 9367.6 9554.7 9706.1 8962.3 9180.3 9418.2 9491.3 9591.8 7510.6 7761.5 7780.6 7963.2 7989.3 7663.0 7908.7 7931.3 8086.5 8187.5 17:04:12 INFO - PROCESS | 6367 | -------- Summary: end -------- 17:04:12 INFO - PROCESS | 6367 | 17:04:13 INFO - TEST-INFO | 6367: exit 0 17:04:13 INFO - TEST-OK | dromaeo_css | took 1118622ms 17:04:13 INFO - TEST-START | kraken 17:04:13 INFO - operating with platform_type : linux_ 17:04:13 INFO - Initialising browser for kraken test... 17:04:13 INFO - TEST-INFO | started process 6546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp45TkMv/profile http://localhost:51293/getInfo.html) 17:04:17 INFO - PROCESS | 6546 | __metrics Screen width/height:1600/1200 17:04:17 INFO - PROCESS | 6546 | colorDepth:24 17:04:17 INFO - PROCESS | 6546 | Browser inner width/height: 1024/697 17:04:17 INFO - PROCESS | 6546 | __metrics 17:04:18 ERROR - PROCESS | 6546 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:04:19 INFO - TEST-INFO | 6546: exit 0 17:04:19 INFO - Browser initialized. 17:04:19 INFO - Running cycle 1/1 for kraken test... 17:04:19 INFO - TEST-INFO | started process 6625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp45TkMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:31 INFO - PROCESS | 6625 | RSS: Main: 156581888 17:04:31 INFO - PROCESS | 6625 | 17:04:33 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:34 INFO - PROCESS | 6625 | RSS: Main: 211038208 17:04:34 INFO - PROCESS | 6625 | 17:04:37 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-dft) 17:04:38 INFO - PROCESS | 6625 | RSS: Main: 198946816 17:04:38 INFO - PROCESS | 6625 | 17:04:41 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-fft) 17:04:42 INFO - PROCESS | 6625 | RSS: Main: 269864960 17:04:42 INFO - PROCESS | 6625 | 17:04:44 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51293/tests/kraken/driver.html?testName=audio-oscillator) 17:04:44 INFO - PROCESS | 6625 | RSS: Main: 178806784 17:04:44 INFO - PROCESS | 6625 | 17:04:47 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:47 INFO - PROCESS | 6625 | RSS: Main: 182595584 17:04:47 INFO - PROCESS | 6625 | 17:04:50 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:51 INFO - PROCESS | 6625 | RSS: Main: 218611712 17:04:51 INFO - PROCESS | 6625 | 17:04:55 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51293/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:55 INFO - PROCESS | 6625 | RSS: Main: 216625152 17:04:55 INFO - PROCESS | 6625 | 17:04:58 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51293/tests/kraken/driver.html?testName=json-parse-financial) 17:04:59 INFO - PROCESS | 6625 | RSS: Main: 217473024 17:04:59 INFO - PROCESS | 6625 | 17:05:00 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:01 INFO - PROCESS | 6625 | RSS: Main: 207876096 17:05:01 INFO - PROCESS | 6625 | 17:05:03 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:04 INFO - PROCESS | 6625 | RSS: Main: 212332544 17:05:04 INFO - PROCESS | 6625 | 17:05:06 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:06 INFO - PROCESS | 6625 | RSS: Main: 221773824 17:05:06 INFO - PROCESS | 6625 | 17:05:09 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:10 INFO - PROCESS | 6625 | RSS: Main: 225918976 17:05:10 INFO - PROCESS | 6625 | 17:05:13 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:13 INFO - PROCESS | 6625 | RSS: Main: 222142464 17:05:13 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | Cycle 1(1): loaded http://localhost:51293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51293/tests/kraken/driver.html?testName=ai-astar) 17:05:15 INFO - PROCESS | 6625 | RSS: Main: 268517376 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | __start_tp_report 17:05:15 INFO - PROCESS | 6625 | _x_x_mozilla_page_load 17:05:15 INFO - PROCESS | 6625 | _x_x_mozilla_page_load_details 17:05:15 INFO - PROCESS | 6625 | |i|pagename|runs| 17:05:15 INFO - PROCESS | 6625 | |0;ai-astar;112;107;111;114;114;112;112;112;111;111 17:05:15 INFO - PROCESS | 6625 | |1;audio-beat-detection;169;129;132;168;129;157;162;130;191;129 17:05:15 INFO - PROCESS | 6625 | |2;audio-dft;160;162;160;161;161;160;163;161;162;160 17:05:15 INFO - PROCESS | 6625 | |3;audio-fft;77;75;76;113;77;77;75;76;120;78 17:05:15 INFO - PROCESS | 6625 | |4;audio-oscillator;85;84;121;84;85;84;119;85;85;129 17:05:15 INFO - PROCESS | 6625 | |5;imaging-gaussian-blur;117;117;117;116;117;118;116;117;117;117 17:05:15 INFO - PROCESS | 6625 | |6;imaging-darkroom;146;148;148;146;146;146;147;146;147;147 17:05:15 INFO - PROCESS | 6625 | |7;imaging-desaturate;95;94;95;95;95;95;95;94;95;95 17:05:15 INFO - PROCESS | 6625 | |8;json-parse-financial;65;66;75;65;66;65;66;82;63;64 17:05:15 INFO - PROCESS | 6625 | |9;json-stringify-tinderbox;64;66;65;66;64;65;70;65;66;66 17:05:15 INFO - PROCESS | 6625 | |10;stanford-crypto-aes;82;82;83;83;83;84;89;84;86;83 17:05:15 INFO - PROCESS | 6625 | |11;stanford-crypto-ccm;148;134;142;129;139;129;130;128;169;141 17:05:15 INFO - PROCESS | 6625 | |12;stanford-crypto-pbkdf2;170;172;173;171;171;175;177;177;169;170 17:05:15 INFO - PROCESS | 6625 | |13;stanford-crypto-sha256-iterative;67;66;67;68;68;66;67;65;64;66 17:05:15 INFO - PROCESS | 6625 | __end_tp_report 17:05:15 INFO - PROCESS | 6625 | __start_cc_report 17:05:15 INFO - PROCESS | 6625 | _x_x_mozilla_cycle_collect,1887 17:05:15 INFO - PROCESS | 6625 | __end_cc_report 17:05:15 INFO - PROCESS | 6625 | __startTimestamp1464221115819__endTimestamp 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | ------- Summary: start ------- 17:05:15 INFO - PROCESS | 6625 | Number of tests: 14 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 17:05:15 INFO - PROCESS | 6625 | Values: 112.0 107.0 111.0 114.0 114.0 112.0 112.0 112.0 111.0 111.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:159.50 stddev:22.62 (14.2%) stddev-sans-first:22.88 17:05:15 INFO - PROCESS | 6625 | Values: 169.0 129.0 132.0 168.0 129.0 157.0 162.0 130.0 191.0 129.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 17:05:15 INFO - PROCESS | 6625 | Values: 160.0 162.0 160.0 161.0 161.0 160.0 163.0 161.0 162.0 160.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#3] audio-fft Cycles:10 Average:84.40 Median:76.50 stddev:17.02 (22.3%) stddev-sans-first:17.85 17:05:15 INFO - PROCESS | 6625 | Values: 77.0 75.0 76.0 113.0 77.0 77.0 75.0 76.0 120.0 78.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:84.50 stddev:18.73 (22.2%) stddev-sans-first:19.44 17:05:15 INFO - PROCESS | 6625 | Values: 85.0 84.0 121.0 84.0 85.0 84.0 119.0 85.0 85.0 129.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:05:15 INFO - PROCESS | 6625 | Values: 117.0 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 117.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:05:15 INFO - PROCESS | 6625 | Values: 146.0 148.0 148.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:05:15 INFO - PROCESS | 6625 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:66.00 stddev:6.00 (9.1%) stddev-sans-first:6.28 17:05:15 INFO - PROCESS | 6625 | Values: 65.0 66.0 75.0 65.0 66.0 65.0 66.0 82.0 63.0 64.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.69 17:05:15 INFO - PROCESS | 6625 | Values: 64.0 66.0 65.0 66.0 64.0 65.0 70.0 65.0 66.0 66.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.13 (2.6%) stddev-sans-first:2.15 17:05:15 INFO - PROCESS | 6625 | Values: 82.0 82.0 83.0 83.0 83.0 84.0 89.0 84.0 86.0 83.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:140.00 stddev:12.56 (9.0%) stddev-sans-first:12.89 17:05:15 INFO - PROCESS | 6625 | Values: 148.0 134.0 142.0 129.0 139.0 129.0 130.0 128.0 169.0 141.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:2.92 (1.7%) stddev-sans-first:2.95 17:05:15 INFO - PROCESS | 6625 | Values: 170.0 172.0 173.0 171.0 171.0 175.0 177.0 177.0 169.0 170.0 17:05:15 INFO - PROCESS | 6625 | 17:05:15 INFO - PROCESS | 6625 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 17:05:15 INFO - PROCESS | 6625 | Values: 67.0 66.0 67.0 68.0 68.0 66.0 67.0 65.0 64.0 66.0 17:05:15 INFO - PROCESS | 6625 | -------- Summary: end -------- 17:05:15 INFO - PROCESS | 6625 | 17:05:16 INFO - TEST-INFO | 6625: exit 0 17:05:16 INFO - TEST-OK | kraken | took 63827ms 17:05:16 INFO - SUITE-END | took 1182s 17:05:16 INFO - Completed test suite (00:19:42) 17:05:16 INFO - javascript benchmark 17:05:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.9999999999995, 2712.9321766955813, 2731.521983652861, 2744.7255274472554, 2766.6126742256088, 4538.160440318535, 4577.2218722817115, 4666.323383109451, 4750.049990001996, 4790.209615413457, 4663.60359369454, 4666.23007203811, 4685.695429797061, 4687.062587482508, 4690.5074967128385, 4096.487939007624, 4246.681498887588, 4357.0, 4383.276759334706, 4403.6256918162, 4318.52496225415, 4355.216061108999, 4356.651467882578, 4371.868843934687, 4403.273459879116, 4224.345226489883, 4268.573142685737, 4296.892577685551, 4314.201872653538, 4329.090890912912, 4270.807813648394, 4306.461692288464, 4326.156399502099, 4356.063446359017, 4387.166438376698, 4319.0, 4332.696711230215, 4346.978265108686, 4361.454818147731, 4382.956170438287, 4484.417025786627, 4577.862664120082, 4604.815807367701, 4622.745748983804, 4637.95362046382, 5122.590192784605, 5158.613104017214, 5159.5614372778355, 5164.173732202829, 5170.870728231786, 5139.948600514022, 5181.559567436772, 5183.50756678115, 5197.636165468419, 5201.219817027439, 4613.723176609415, 4742.099001189832, 4785.066911952136, 4786.994731106437, 4816.903661926742, 5291.3121294231505, 5328.600354973392, 5332.466753324637, 5332.893342133136, 5336.653117547347, 4897.094037603055, 5043.722595257223, 5104.106781313255, 5105.259737338065, 5105.953279577678, 5012.373453318335, 5043.924341134886, 5062.088824011639, 5085.0, 5108.540231379119, 5014.724190169502, 5016.2224855147515, 5035.093683137071, 5040.420351659533, 5077.898442031139, 4832.299316599144, 4957.752112394366, 5010.298558201855, 5013.674111182761, 5020.824271150565, 4300.526942036374, 4343.131373725268, 4351.5430879757805, 4365.236083685342, 4388.210122178039, 3759.2293579816073, 3779.5653499847867, 3789.0, 3824.694024478035, 3840.558335791364, 4202.159568086395, 4245.023644561768, 4268.530461649216, 4331.588499092644, 4342.82628694855, 5045.5459008689395, 5102.668326558762, 5112.130937740593, 5115.2071428928575, 5158.587313014949, 4289.699721019499, 4321.330193819963, 4321.524632290446, 4362.432883725159, 4374.12517496502, 4497.550244975476, 4522.547745225517, 4530.365748795171, 4592.747398893026, 4610.331501932201, 4712.575868171881, 4755.690880092783, 4772.141014617402, 4776.713397196179, 4824.565789079, 5097.617678674188, 5120.948790512047, 5123.74381280927, 5124.56441202502, 5146.0737067326745, 4609.4699109602825, 4711.034237981275, 4746.098241334135, 4769.093872164278, 4832.251001094836, 5015.824446144367, 5027.949720502748, 5040.117979353672, 5044.722540260321, 5085.949140508696, 5082.822101226439, 5085.262636917552, 5085.415177254663, 5134.281200631989, 5134.9743251285, 4822.0, 4901.460839307744, 4937.8271760488215, 4949.82675606352, 4959.057779021974, 4949.925751113664, 4957.03337849116, 4963.081829861487, 4971.403431588233, 5023.045621331935, 4903.5586797188425, 4916.803327866988, 4918.286848407032, 4980.078685443204, 4985.825496107764, 4836.322914791862, 4902.117618828645, 4931.580815630568, 4945.6043516517875, 4963.726995015309, 4833.081714474239, 4865.1242776300605, 4872.049950259807, 4874.610031197567, 4924.212126059813], "value": 4654.299427091392, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8990426675331, 594.5986459140081, 602.9216201893753, 604.5496105401477, 610.9602875813072, 27014.72985270147, 29734.851325743395, 29808.701912980865, 29860.850695746543, 43474.782626086904, 41092.17815643685, 41461.58538414615, 41734.165316693645, 41737.791311043475, 41759.0, 7695.846083078335, 7879.96060019702, 7880.172581878906, 7881.684732610689, 7883.684652613889, 7677.270659287359, 7820.139784623687, 7824.921750782505, 7826.843463130734, 7834.216578342149, 7820.061592608867, 7866.606669666522, 7882.448228623999, 7886.250806173433, 7889.289963903248, 7807.375409967218, 7856.567888766115, 7864.331531819802, 7869.2130786921425, 7871.17352677972, 7646.235376462309, 7719.807004824925, 7723.189065148134, 7734.613269336567, 7740.342070923978, 35792.28415431677, 36128.0, 36144.0, 36191.199924007866, 36214.8189259052, 3010.729034386894, 3074.0777766669908, 3087.552304915797, 3105.223694076481, 3179.920501987469, 28757.281067973257, 29046.709532904613, 29159.125226243246, 29345.0, 29981.100566983027, 3490.3891818931584, 3545.3795585772646, 3558.5551806024246, 3598.946015809765, 3637.0725465006517, 275491.0, 278670.0, 279181.0, 279831.0, 280007.0, 55040.44959550433, 56339.15491267634, 56371.71814140903, 56403.43596564064, 56449.74201031995, 32315.35369292648, 33515.0, 33681.15797105092, 35698.28603427917, 35730.0, 15091.849081509265, 15222.0, 15257.237138143048, 15263.160526170945, 15268.3892644293, 11465.369404682822, 11545.595904143314, 11555.902189292005, 11559.190856640123, 11559.479823407966, 18518.0, 18526.722099168524, 18574.814251857308, 18613.627727445375, 18653.533661658297, 6954.756583519553, 7011.964940175267, 7070.611116388545, 7098.68055937484, 7115.181754098241, 795.1769918134703, 862.66787286895, 930.8650245714333, 991.3704797453524, 1039.6725031615017, 27385.863070684518, 28341.291467713472, 28612.42775144527, 29074.0, 29091.27271818179, 812.5084323984023, 949.8052899155656, 960.8030353777459, 978.4471773447979, 997.5162046407487, 14971.850281497263, 15154.772678409832, 15261.9236903817, 15325.157116358707, 15362.078275303518, 384421.0, 385598.0, 388215.0, 388323.0, 389397.0, 50904.0, 51411.228831567554, 51627.74186129045, 51654.741726291126, 51682.0, 1096.5613754498106, 1209.3832145605804, 1250.1061740855332, 1266.9873301267053, 1365.6108009217128, 26192.8690356547, 29316.267093322836, 29830.25424364408, 29849.25376865596, 30283.545746813375, 42858.35712464378, 43669.78165109154, 43716.56283437125, 43760.56239437565, 43762.0, 367584.0, 378007.0, 378377.0, 379646.0, 379683.0, 32648.673513264563, 33462.832685836416, 33464.665353347125, 35777.64222357743, 37057.81471092627, 35848.82075589606, 39852.2029559413, 40502.1899562013, 40568.0, 40575.59424405718, 34918.65081349255, 34958.475622866186, 34958.65041349554, 35383.64616353803, 35946.64053359433, 34830.30339393249, 34989.125271868405, 35234.47148292829, 35381.646183537836, 35567.28865422729, 34271.0, 34686.13284667904, 34872.30255394929, 34926.650733493356, 35160.0, 31183.84408077945, 31289.8435507821, 31511.684883151793, 31751.682483175795, 31878.203044924063, 24051.639225411982, 24068.39829004289, 24156.51686966286, 24594.020715162143, 24795.752042480064], "value": 17582.44975173885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.43279267945644, 376.3526734017489, 377.29069349622705, 380.35339922132374, 387.0729602601769, 15366.769498457517, 15988.200589970484, 16315.10266935318, 16374.508764737062, 16752.0, 14171.858281417182, 15895.920520397382, 16115.355385784584, 16141.192940352994, 16175.676486470264, 4866.31871537985, 5043.067032598962, 5082.898342033176, 5084.110280700863, 5085.821996230115, 3739.551253849528, 3891.8248678809523, 5051.267566202917, 5602.915956260659, 5911.083782013795, 5941.792037278696, 5944.583879128462, 5965.1052342148805, 5973.133895585138, 5982.8803423931495, 5683.147527870811, 5825.097109947965, 5878.559108066891, 5966.433188847052, 5974.044152935509, 3332.8500217490273, 4785.569298763093, 5016.974915125437, 5046.646734728571, 5059.3169922060415, 19717.30989415378, 20538.486537836525, 20555.89722051395, 20644.38066857997, 20651.69022464664, 1927.1809480970671, 2083.114676262582, 2222.3999520129473, 2340.707411573553, 2442.5237078769646, 12604.621861344174, 12990.0, 13001.479940802357, 13610.251436171007, 13640.386182621805, 1717.4074944144375, 1748.7027205375116, 1761.4329495075779, 1766.1169415292354, 1839.1815642039298, 63514.68242658757, 65602.99999999952, 66386.33613663849, 66694.66652666754, 67924.6603766978, 8964.955175224213, 9159.450432974043, 9328.0, 9388.765280868032, 9665.9033409665, 12758.872411275768, 12836.743265134644, 12868.22790632565, 12888.677783055498, 12891.35543222835, 7398.186199518049, 7449.180590135081, 7480.438967077491, 7607.277308655669, 7631.465797394129, 7223.530470519399, 7316.231795661485, 7316.926830731624, 7383.630818459055, 7436.182019977907, 5959.195508606369, 6088.11722300264, 6135.355787642323, 6138.005148326812, 6263.968680156661, 1593.9920300398423, 1666.1003058348356, 1675.572728954109, 1700.3113738935751, 1708.9658206835793, 847.1020718038775, 851.1828644501348, 879.76246413468, 919.4023884475012, 946.1768261612441, 16361.427350042692, 17502.91248543749, 17508.649827003388, 17646.558836029202, 17777.555561111076, 866.1728049712509, 898.7124120281578, 913.8172365526921, 938.5823308627595, 940.8695825326821, 10052.145567626687, 10199.898001020043, 10226.897731022595, 10339.327943683636, 10339.948300258451, 278455.0, 279142.0, 381349.0, 390810.0, 391125.0, 77071.61464192755, 78483.0, 79581.0, 80258.5987070061, 82332.0, 943.7687766497252, 974.931754777173, 990.0249003238586, 990.3562684255147, 992.3599278465349, 14986.584323895224, 15477.5356739298, 15712.842871571595, 15731.134787586334, 15987.360505579647, 34428.48357274693, 34738.0, 35097.473537897466, 36114.0, 36138.8193059033, 45195.0, 46970.0, 47472.52527474819, 52115.513097933515, 52333.21500177424, 7675.846483070196, 7711.228877112244, 7854.960725196337, 7879.369650427838, 7915.485493442908, 7189.784306470814, 8902.777430564287, 9950.651727189514, 12208.389580520761, 12240.143189976616, 6393.808185754435, 9777.604486900755, 9943.0, 10040.548175331982, 10211.84682229782, 10257.333273337508, 10299.12457441096, 10319.226058045826, 10386.0, 10805.0, 9755.609775608897, 9882.407055576688, 9931.155851752683, 10051.346662466916, 10431.582736690447, 7398.741044063432, 7668.386529077772, 7758.146603873683, 7774.028246469192, 7880.763577092696, 7364.668589913574, 9028.638854445748, 9678.177354924628, 10070.798584028425, 10281.383117013003], "value": 8253.28979224314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.8739082396353, 1445.4507287230851, 1456.468389038001, 1597.321138516131, 1754.7367894815777, 6772.796816095519, 7572.962135189323, 7829.960850195741, 7839.529628222296, 7861.292483676475, 7529.811754706135, 7605.543667379961, 7666.31003209711, 7902.802429939255, 7907.327877130437, 1901.6672082385596, 2155.3210738617363, 2182.388931099291, 2228.1198926424054, 2229.4314949687805, 2181.8581792183536, 2200.3948914048683, 2202.537467131904, 2204.790544898232, 2205.547862688145, 2151.6880052392394, 2166.869987800729, 2176.249194028058, 2189.5292512109895, 2197.5824593327297, 1797.3529529369416, 2038.4292398128548, 2095.0258129969484, 2112.7570329412083, 2149.7312835895514, 2132.296342207068, 2161.3623980925663, 2163.707899433572, 2165.761766205716, 2167.533980194266, 7774.961125194338, 7848.0, 7853.136155022943, 7859.449838511307, 7861.842763144762, 4326.459192600925, 4443.46678398591, 4443.5556444355625, 4444.777761111932, 4446.088551846864, 2884.0915111739946, 2950.6606740224934, 3024.4102400032, 3039.1338468536583, 3047.649520305149, 890.3767362846033, 929.2287401456774, 937.1659223291276, 981.2640519610293, 981.5239608789731, 10740.570377184904, 10984.505697243643, 10998.230123891331, 11015.173861960386, 11015.779684406267, 4242.830286788494, 4311.9784401077795, 4326.805293761789, 4335.501417336984, 4381.3208952612395, 9499.43003419797, 9508.90491095094, 9510.38182518134, 9527.857082143773, 9528.094830991045, 4448.065906159678, 4448.488423831236, 4450.866474005785, 4451.955480445219, 4456.264716321835, 3487.5989261234777, 3968.523777146761, 3989.840406383712, 4112.218678451085, 4120.763770868727, 3733.0853940784136, 3735.7571757835653, 3794.867179648699, 3831.1571454280015, 3847.1920896612023, 1202.7233736240714, 1205.5900993662196, 1208.6796998795326, 1211.981820272679, 1224.344975438154, 611.5260672978477, 660.1022609251414, 671.768239957214, 736.6059158350364, 806.4999700185922, 4866.124097662384, 4866.221404575251, 4967.428745694219, 5003.974980125149, 5060.240963855451, 799.2726618776885, 817.0, 825.1377310710322, 833.6790335720791, 879.2350654930124, 3434.7252219822853, 3491.809550307808, 3513.7364697647267, 3543.8228088595984, 3600.207954250061, 9719.0, 9978.600855965826, 10016.198704103654, 10028.0, 10057.949710251549, 9297.302702297355, 9662.75843103914, 9857.950710246403, 9940.055694708992, 9957.253206009578, 7218.314260145278, 7328.120625524971, 7369.373603243785, 7394.926050739531, 7401.5189012714, 5057.7724002419245, 5260.473952604709, 5300.496452836975, 5338.225957236256, 5380.596455265949, 8929.776755580902, 9066.546672666209, 9080.091990800867, 9438.575264112995, 9456.858147127936, 9430.62277508892, 9471.715848524555, 9543.236541076558, 9571.1864491519, 9583.0, 6671.26616072222, 6920.0, 6939.965300173467, 7555.622218889143, 7764.06831180262, 6739.66301684904, 6805.081314022544, 7653.158152603321, 7662.348700360531, 7919.643616037177, 6775.661216939232, 6904.516683832285, 6943.375096241362, 6981.3367730065565, 7114.679839407136, 6749.898751518633, 6924.307569243036, 7002.894956575554, 7089.82275443118, 7112.03987461686, 6336.524760643062, 6427.807165785034, 6439.742410303723, 6698.39714425704, 6746.527743057939, 4303.870883873489, 4321.78391080451, 4399.208142534247, 4409.514953355192, 4420.977895110504, 4361.760103194355, 4444.066745983379, 4566.611837993808, 4579.175748365326, 4659.998100408293], "value": 4132.335794853554, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.317804324513, 283.62183094750515, 288.4001277343126, 291.52772508536145, 293.8486679360129, 4716.85849424517, 4725.8582242532775, 4755.833545825897, 4758.1197478466465, 4805.126000859667, 4374.0, 4446.666500012496, 4507.594316511513, 4676.883077923054, 4688.554587314208, 3623.1884057971015, 3627.727920405967, 3632.963670363289, 3674.2810320363005, 3684.9815750921275, 3631.963680363189, 3641.253543023687, 3650.3794354959587, 3651.8174091295464, 3661.8718344857934, 3483.0, 3527.276908233806, 3630.4735813307057, 3639.5450568678916, 3663.7069034477313, 3623.601403845575, 3625.492431059654, 3636.945445818328, 3637.8908632740795, 3656.963430365689, 3208.230024794056, 3221.1624977505785, 3227.564278822376, 3227.6610955849533, 3240.821754803485, 4395.450568678915, 4417.845375411877, 4535.546445355471, 4535.841245556423, 4539.341795439643, 4115.218108559394, 4176.749395036277, 4183.581641835823, 4185.644220241283, 4189.329707246857, 4824.372831531913, 4833.0, 4836.371271734687, 4849.563539281482, 4871.12319782439, 3485.4074807282823, 3504.754667173299, 3505.526753888218, 3534.6288639692975, 3538.080099174233, 4892.828750993698, 5087.262346959707, 5087.364079490064, 5100.821471248526, 5147.871303217412, 3539.8761043363875, 3575.1419659282105, 3576.6959808416577, 3592.7485076044427, 3593.748437609342, 3640.927181456356, 3662.7619204751604, 3664.4136938089778, 3678.356287649704, 3686.2258925625383, 3989.5212574491247, 4094.651954583834, 4140.565240649748, 4180.163967206571, 4192.538820729717, 4828.589569886529, 4838.661293709407, 4848.418189817245, 4854.441739200037, 4855.95144048555, 1185.2829038431796, 1210.6549633354452, 1226.3316492511424, 1261.3630116791146, 1262.0408489547826, 805.2229598437536, 817.2767101115555, 827.8882350882553, 828.2173346187794, 834.7746108550779, 3838.1747924196434, 3850.634189752025, 3905.628965248297, 3906.2382835347403, 3907.941380879289, 4432.889177770581, 4487.461504619467, 4508.0, 4517.983453722886, 4548.795304211319, 3873.922521549553, 3882.184741204322, 3896.785676787804, 3901.882943511699, 3917.804109794499, 2415.357556861351, 2435.8294919355476, 2501.6122501012374, 2712.0236714782664, 2726.8636568171514, 4758.906081324206, 4792.760361981887, 4812.8796780080775, 4814.253790662453, 4815.374001379798, 5194.4026436959475, 5216.60875434344, 5221.7128057956415, 5221.791128354899, 5233.4243233244315, 4676.859694209179, 4743.549362810528, 4810.759462026815, 4812.639052071108, 4841.806327746921, 5053.924191137063, 5089.541941225308, 5096.23556466533, 5125.795438071976, 5149.639525233348, 4947.48051454592, 4998.1253280676465, 5003.424606170337, 5005.774740136775, 5012.924806127984, 4672.995306009224, 4723.126221649006, 4836.081144582518, 4841.346418233494, 4846.224604063333, 3518.7712798668003, 3531.9293614128087, 3535.0, 3542.220711443478, 3551.9467207992416, 4854.95145048545, 5055.5702765263895, 5099.413567439792, 5109.565686916654, 5126.641440018473, 4842.58837998774, 4918.729469879191, 4919.532644398776, 4938.209886418156, 4938.358013458227, 4889.657723959289, 4896.7758060484875, 4899.3385892904, 4929.112759703288, 4946.752662366939, 4607.285870690049, 4809.254565542346, 4834.6374021947795, 4864.659473836798, 4879.829205977774, 4989.501049895127, 4989.72556509381, 4993.226049962262, 4998.800047998039, 5010.749462526932, 4902.828401005948, 4920.8769780755765, 4920.975395123145, 4927.260910863256, 4930.408350997904], "value": 3659.4137950600702, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.6405594894833, 748.5134662469391, 764.1899586438376, 767.4167632599226, 772.9072511298644, 12174.878251217486, 12679.429425675844, 12880.67798305043, 12888.548900788473, 12888.999999999989, 13008.0, 13554.932225338884, 13563.389647465863, 13580.253086080287, 13602.659933501667, 640.1262276991896, 783.4437549339975, 799.2327365728893, 801.2988634944423, 816.0982114763191, 797.4457751862458, 811.8457493076326, 812.8861959325699, 813.2152472863685, 813.3168138763438, 855.2943821347383, 860.2300940658107, 861.1775754154767, 861.4314552395421, 861.6553378648559, 497.1573183454047, 826.4132465949123, 843.4475418600765, 856.4304737349655, 857.652650676477, 625.9029850373154, 626.264139635926, 627.2191122053073, 627.5481653209682, 627.7112528237017, 13016.0, 13036.283004434752, 13037.54368597104, 13039.739205215938, 13094.86905130946, 11602.187846850724, 12179.939100304531, 12260.81608775869, 12334.53309338127, 12484.250944943242, 9860.0, 10229.539670714836, 10292.794144117075, 10506.212034097396, 11278.887211127947, 3257.5765150530515, 3291.078498020558, 3325.567676202078, 3330.633630300665, 3405.506201600754, 46596.534034659555, 47097.76451117757, 47274.29088563674, 47624.0, 48095.0, 9865.408075515492, 9941.919204487109, 10040.096391324816, 10264.538095785707, 10306.227032972407, 18526.444206673823, 18531.35140270111, 18592.0, 18604.34884779026, 18624.16191271396, 6684.0, 6822.181338239443, 6828.897566536506, 6924.58452492852, 6967.965160174268, 3774.6602805747616, 3810.6951443884977, 3828.2534905693124, 3876.8836934891997, 3890.4164375343357, 2787.8466684332557, 2874.8275103493856, 2875.56866470027, 2876.453473839964, 2883.226815508489, 495.62332627203585, 524.4702850121329, 529.2722506553489, 534.5536477041713, 540.6296686769575, 414.49638688992417, 469.3452633576142, 519.732337846002, 567.8154599755013, 574.5920396518519, 7055.3650171484815, 7273.27267273279, 7364.77905662831, 7409.110906691231, 7493.625318734042, 544.6024402186426, 553.914143307788, 558.2352177516827, 562.0220815780513, 566.3091028944681, 3331.06730115568, 3366.259422926952, 3370.6292307846115, 3438.9312213755584, 3446.5347178131133, 51844.481555183964, 54249.72875135599, 54618.180727289124, 54836.0, 55325.446745532834, 48646.513534864906, 49232.753836231306, 49690.254646180336, 50313.0, 50385.49614503808, 45067.0, 45222.32166517505, 45952.77023614928, 46102.0, 46293.5370646296, 6644.46844252449, 6670.499712521483, 6698.765543205965, 6746.156730408699, 6788.9660551696925, 29695.0, 30381.392372152874, 31331.216719582193, 31355.372892542477, 31401.37197256088, 37475.625243748305, 39120.80439597784, 39354.409683854195, 39908.401373978835, 40475.797621011705, 9702.175315098295, 10192.0, 10234.692959211236, 10234.795304094025, 10315.48422578883, 9823.803523929624, 10058.54736536843, 10186.745331366776, 10293.330933489298, 10491.265611407129, 9168.174864262248, 9378.390404623678, 9524.666636667684, 9607.471589062668, 9749.9025009749, 9207.125323094564, 9338.439693618404, 9367.5784589695, 9554.665586704432, 9706.126448619658, 8962.283017358726, 9180.311476639145, 9418.246540276625, 9491.288153388385, 9591.808163836544, 7510.62446877643, 7761.534307941542, 7780.649870755717, 7963.243491868263, 7989.2809647132035, 7663.0, 7908.723194688158, 7931.286184243446, 8086.474379165335, 8187.5087494750505], "value": 5762.208622650346, "unit": "score"}], "name": "dromaeo_css", "value": 6236.890856077897, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 114.0, 114.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 129.0, 132.0, 168.0, 129.0, 157.0, 162.0, 130.0, 191.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 161.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 113.0, 77.0, 77.0, 75.0, 76.0, 120.0, 78.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 84.0, 119.0, 85.0, 85.0, 129.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 75.0, 65.0, 66.0, 65.0, 66.0, 82.0, 63.0, 64.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 66.0, 64.0, 65.0, 70.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 84.0, 89.0, 84.0, 86.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 134.0, 142.0, 129.0, 139.0, 129.0, 130.0, 128.0, 169.0, 141.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 173.0, 171.0, 171.0, 175.0, 177.0, 177.0, 169.0, 170.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 68.0, 66.0, 67.0, 65.0, 64.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1556.2000000000003, "alertThreshold": 2.0}]} 17:05:17 INFO - Return code: 0 17:05:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:05:17 ERROR - # TBPL SUCCESS # 17:05:17 INFO - Running post-action listener: _resource_record_post_action 17:05:17 INFO - ##### 17:05:17 INFO - ##### Finished run-tests step (success) 17:05:17 INFO - ##### 17:05:17 INFO - Running post-run listener: _resource_record_post_run 17:05:17 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 499712; Write bytes: 286228480; Read time: 68; Write time: 184044 17:05:17 INFO - TinderboxPrint: CPU usage
13.1% 17:05:17 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 68 17:05:17 INFO - TinderboxPrint: I/O write bytes / time
286,228,480 / 184,044 17:05:17 INFO - TinderboxPrint: CPU idle
8,316.4 (86.9%) 17:05:17 INFO - TinderboxPrint: CPU user
1,211.7 (12.7%) 17:05:17 INFO - TinderboxPrint: Swap in / out
0 / 0 17:05:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5300224; Read time: 0; Write time: 380 17:05:17 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 499712; Write bytes: 280928256; Read time: 68; Write time: 183664 17:05:17 INFO - Running post-run listener: _upload_blobber_files 17:05:17 INFO - Blob upload gear active. 17:05:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:17 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 17:05:17 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:05:17 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:05:18 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:18 INFO - (blobuploader) - INFO - Done attempting. 17:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:19 INFO - (blobuploader) - INFO - Done attempting. 17:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:23 INFO - (blobuploader) - INFO - Done attempting. 17:05:23 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:23 INFO - Return code: 0 17:05:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61a3179c05bc0ce20fdf709df387131dd56af9139a940d1691730a5719a965824694284d89702c223d1f5301e5c7c8c87adb146d3596a41ad8b9b67e600ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0683fda10f152b2feada4154ed4eccbfa572c7b5b86090a21b8d59e627dae8bb23f38c78e6c1a3043c12bf3a881f19e452056e9d163140290f59ff85f68a6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b117aa1b026c87d57b88b9f1075c4ed10cb81a8f542c82f2646c8e941de5127388c0b2c6ed4ed052609649319de9976cdec4249c3ecdb9d2e48c0c7b4a7397cf"} 17:05:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:23 INFO - Contents: 17:05:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61a3179c05bc0ce20fdf709df387131dd56af9139a940d1691730a5719a965824694284d89702c223d1f5301e5c7c8c87adb146d3596a41ad8b9b67e600ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0683fda10f152b2feada4154ed4eccbfa572c7b5b86090a21b8d59e627dae8bb23f38c78e6c1a3043c12bf3a881f19e452056e9d163140290f59ff85f68a6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b117aa1b026c87d57b88b9f1075c4ed10cb81a8f542c82f2646c8e941de5127388c0b2c6ed4ed052609649319de9976cdec4249c3ecdb9d2e48c0c7b4a7397cf"} 17:05:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:23 INFO - Copying logs to upload dir... 17:05:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.573853 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-25 17:05:23.981688) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 17:05:23.984982) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61a3179c05bc0ce20fdf709df387131dd56af9139a940d1691730a5719a965824694284d89702c223d1f5301e5c7c8c87adb146d3596a41ad8b9b67e600ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0683fda10f152b2feada4154ed4eccbfa572c7b5b86090a21b8d59e627dae8bb23f38c78e6c1a3043c12bf3a881f19e452056e9d163140290f59ff85f68a6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b117aa1b026c87d57b88b9f1075c4ed10cb81a8f542c82f2646c8e941de5127388c0b2c6ed4ed052609649319de9976cdec4249c3ecdb9d2e48c0c7b4a7397cf"} build_url:https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/VqfOeMUkRlGmc0RAcq3-Sg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e61a3179c05bc0ce20fdf709df387131dd56af9139a940d1691730a5719a965824694284d89702c223d1f5301e5c7c8c87adb146d3596a41ad8b9b67e600ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0683fda10f152b2feada4154ed4eccbfa572c7b5b86090a21b8d59e627dae8bb23f38c78e6c1a3043c12bf3a881f19e452056e9d163140290f59ff85f68a6a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b117aa1b026c87d57b88b9f1075c4ed10cb81a8f542c82f2646c8e941de5127388c0b2c6ed4ed052609649319de9976cdec4249c3ecdb9d2e48c0c7b4a7397cf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 17:05:24.010557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 17:05:24.010906) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464218615.472561-1891496869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 17:05:24.142803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 17:05:24.143164) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 17:05:24.143471) ========= ========= Total master_lag: 0.22 =========