builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1464792233.94 results: success (0) buildid: 20160601060845 builduid: e5f657fc98d04bb385d07f09e2a9e0fb revision: 111970c738234569c8c180319155327316335deb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:53.941275) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:53.941803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:53.942126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:53.956950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:53.957254) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:43:54-- 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% 227M=0s 2016-06-01 07:43:54 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113429 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:54.084721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:54.085079) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:54.134814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:43:54.135205) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 111970c738234569c8c180319155327316335deb --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 111970c738234569c8c180319155327316335deb --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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:43:54,308 truncating revision to first 12 chars 2016-06-01 07:43:54,308 Setting DEBUG logging. 2016-06-01 07:43:54,308 attempt 1/10 2016-06-01 07:43:54,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/111970c73823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:43:55,520 unpacking tar archive at: mozilla-central-111970c73823/testing/mozharness/ program finished with exit code 0 elapsedTime=1.530650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 07:43:55.685000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:55.685594) ========= script_repo_revision: 111970c738234569c8c180319155327316335deb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:55.686321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:55.686842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:43:55.699005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 07:43:55.699561) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:43:55 INFO - MultiFileLogger online at 20160601 07:43:55 in /builds/slave/test 07:43:55 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 07:43:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:43:55 INFO - {'append_to_log': False, 07:43:55 INFO - 'base_work_dir': '/builds/slave/test', 07:43:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:43:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:43:55 INFO - 'branch': 'Firefox-Non-PGO', 07:43:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:43:55 INFO - 'config_files': ('talos/linux_config.py',), 07:43:55 INFO - 'default_actions': ('clobber', 07:43:55 INFO - 'read-buildbot-config', 07:43:55 INFO - 'download-and-extract', 07:43:55 INFO - 'populate-webroot', 07:43:55 INFO - 'create-virtualenv', 07:43:55 INFO - 'install', 07:43:55 INFO - 'run-tests'), 07:43:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:43:55 INFO - 'download_minidump_stackwalk': True, 07:43:55 INFO - 'download_symbols': 'ondemand', 07:43:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:43:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:43:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:43:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:43:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:43:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:43:55 INFO - 'installer_path': 'installer.exe', 07:43:55 INFO - 'log_level': 'info', 07:43:55 INFO - 'log_name': 'talos', 07:43:55 INFO - 'log_to_console': True, 07:43:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:43:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:43:55 INFO - 'opt_config_files': (), 07:43:55 INFO - 'pip_index': False, 07:43:55 INFO - 'sps_profile': False, 07:43:55 INFO - 'sps_profile_interval': 0, 07:43:55 INFO - 'suite': 'dromaeojs', 07:43:55 INFO - 'system_bits': '32', 07:43:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:43:55 INFO - 'title': 'talos-linux64-ix-023', 07:43:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:43:55 INFO - 'use_talos_json': True, 07:43:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:43:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:43:55 INFO - 'work_dir': 'build'} 07:43:55 INFO - ##### 07:43:55 INFO - ##### Running clobber step. 07:43:55 INFO - ##### 07:43:55 INFO - Running pre-action listener: _resource_record_pre_action 07:43:55 INFO - Running main action method: clobber 07:43:55 INFO - rmtree: /builds/slave/test/build 07:43:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:43:56 INFO - Running post-action listener: _resource_record_post_action 07:43:56 INFO - ##### 07:43:56 INFO - ##### Finished clobber step (success) 07:43:56 INFO - ##### 07:43:56 INFO - ##### 07:43:56 INFO - ##### Running read-buildbot-config step. 07:43:56 INFO - ##### 07:43:56 INFO - Running pre-action listener: _resource_record_pre_action 07:43:56 INFO - Running main action method: read_buildbot_config 07:43:56 INFO - Using buildbot properties: 07:43:56 INFO - { 07:43:56 INFO - "project": "", 07:43:56 INFO - "product": "firefox", 07:43:56 INFO - "script_repo_revision": "production", 07:43:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:43:56 INFO - "repository": "", 07:43:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:43:56 INFO - "buildid": "20160601060845", 07:43:56 INFO - "pgo_build": "False", 07:43:56 INFO - "basedir": "/builds/slave/test", 07:43:56 INFO - "buildnumber": 602, 07:43:56 INFO - "slavename": "talos-linux64-ix-023", 07:43:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:43:56 INFO - "platform": "ubuntu64_hw", 07:43:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:43:56 INFO - "branch": "mozilla-central", 07:43:56 INFO - "repo_path": "mozilla-central", 07:43:56 INFO - "revision": "111970c738234569c8c180319155327316335deb", 07:43:56 INFO - "stage_platform": "linux64", 07:43:56 INFO - "builduid": "e5f657fc98d04bb385d07f09e2a9e0fb", 07:43:56 INFO - "slavebuilddir": "test" 07:43:56 INFO - } 07:43:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:43:56 INFO - Running post-action listener: _resource_record_post_action 07:43:56 INFO - ##### 07:43:56 INFO - ##### Finished read-buildbot-config step (success) 07:43:56 INFO - ##### 07:43:56 INFO - ##### 07:43:56 INFO - ##### Running download-and-extract step. 07:43:56 INFO - ##### 07:43:56 INFO - Running pre-action listener: _resource_record_pre_action 07:43:56 INFO - Running main action method: download_and_extract 07:43:56 INFO - mkdir: /builds/slave/test/build/tests 07:43:56 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')]} 07:43:56 INFO - https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:43:57 INFO - Downloaded 1361 bytes. 07:43:57 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:43:57 INFO - Using the following test package requirements: 07:43:57 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:57 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:43:57 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:43:57 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'jsshell-linux-x86_64.zip'], 07:43:57 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:43:57 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:43:57 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:43:57 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:43:57 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:43:57 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:43:57 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:43:57 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:43: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')]} 07:43:57 INFO - https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:43:58 INFO - Downloaded 22849819 bytes. 07:43:58 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'] 07:43:58 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 07:43:59 INFO - Return code: 0 07:43:59 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 07:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:59 INFO - https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:43:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:43:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:43:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:43:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:44:00 INFO - Downloaded 22849819 bytes. 07:44:00 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'] 07:44:00 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 07:44:02 INFO - Return code: 0 07:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:02 INFO - https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:44:02 INFO - Downloaded 10834055 bytes. 07:44:02 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'] 07:44:02 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 07:44:03 INFO - Return code: 0 07:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:03 INFO - https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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 07:44:05 INFO - Downloaded 55061592 bytes. 07:44:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:44:05 INFO - mkdir: /builds/slave/test/properties 07:44:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:05 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:05 INFO - Contents: 07:44:05 INFO - build_url:https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:44:05 INFO - Running post-action listener: _resource_record_post_action 07:44:05 INFO - Running post-action listener: set_extra_try_arguments 07:44:05 INFO - ##### 07:44:05 INFO - ##### Finished download-and-extract step (success) 07:44:05 INFO - ##### 07:44:05 INFO - ##### 07:44:05 INFO - ##### Running populate-webroot step. 07:44:05 INFO - ##### 07:44:05 INFO - Running pre-action listener: _resource_record_pre_action 07:44:05 INFO - Running main action method: populate_webroot 07:44:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:05 INFO - '--tppagecycles', 07:44:05 INFO - '7'], 07:44:05 INFO - 'tests': ['tsvgm']}}, 07:44:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['damp', 'tps']}, 07:44:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['damp', 'tps']}, 07:44:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['dromaeo_dom']}, 07:44:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['a11yr', 07:44:05 INFO - 'ts_paint', 07:44:05 INFO - 'tpaint', 07:44:05 INFO - 'sessionrestore', 07:44:05 INFO - 'sessionrestore_no_auto_restore', 07:44:05 INFO - 'tabpaint']}, 07:44:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tsvgx', 07:44:05 INFO - 'tsvgr_opacity', 07:44:05 INFO - 'tart', 07:44:05 INFO - 'tscrollx', 07:44:05 INFO - 'cart']}, 07:44:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:05 INFO - 'tsvgr_opacity', 07:44:05 INFO - 'tart', 07:44:05 INFO - 'tscrollx', 07:44:05 INFO - 'cart']}, 07:44:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s'], 07:44:05 INFO - 'tests': ['tp5o']}, 07:44:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'tests': ['tp5o']}, 07:44:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--disable-e10s', 07:44:05 INFO - '--xperf_path', 07:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:05 INFO - 'tests': ['tp5n']}, 07:44:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:05 INFO - 'talos_options': ['--xperf_path', 07:44:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:05 INFO - 'tests': ['tp5n']}}, 07:44:05 INFO - 'talos.zip': {'path': '', 07:44:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:05 INFO - Running post-action listener: _resource_record_post_action 07:44:05 INFO - ##### 07:44:05 INFO - ##### Finished populate-webroot step (success) 07:44:05 INFO - ##### 07:44:05 INFO - ##### 07:44:05 INFO - ##### Running create-virtualenv step. 07:44:05 INFO - ##### 07:44:05 INFO - Running pre-action listener: _resource_record_pre_action 07:44:05 INFO - Running main action method: create_virtualenv 07:44:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:05 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 07:44:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:05 INFO - Using real prefix '/usr' 07:44:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:08 INFO - Installing pip.................done. 07:44:08 INFO - Return code: 0 07:44:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:08 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 07:44:08 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 07:44:08 INFO - Using env: {'DISPLAY': ':0', 07:44:08 INFO - 'HOME': '/home/cltbld', 07:44:08 INFO - 'LANG': 'en_US.UTF-8', 07:44:08 INFO - 'LANGUAGE': 'en_US:en', 07:44:08 INFO - 'LOGNAME': 'cltbld', 07:44:08 INFO - 'MAIL': '/var/mail/cltbld', 07:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:08 INFO - 'MOZ_NO_REMOTE': '1', 07:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:08 INFO - 'NO_EM_RESTART': '1', 07:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:08 INFO - 'PWD': '/builds/slave/test', 07:44:08 INFO - 'SHELL': '/bin/bash', 07:44:08 INFO - 'SHLVL': '1', 07:44:08 INFO - 'TERM': 'linux', 07:44:08 INFO - 'TMOUT': '86400', 07:44:08 INFO - 'USER': 'cltbld', 07:44:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:08 INFO - '_': '/tools/buildbot/bin/python'} 07:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:08 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 07:44:08 INFO - Cleaning up... 07:44:08 INFO - Return code: 0 07:44:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:08 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:08 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 07:44:08 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 07:44:08 INFO - Using env: {'DISPLAY': ':0', 07:44:08 INFO - 'HOME': '/home/cltbld', 07:44:08 INFO - 'LANG': 'en_US.UTF-8', 07:44:08 INFO - 'LANGUAGE': 'en_US:en', 07:44:08 INFO - 'LOGNAME': 'cltbld', 07:44:08 INFO - 'MAIL': '/var/mail/cltbld', 07:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:08 INFO - 'MOZ_NO_REMOTE': '1', 07:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:08 INFO - 'NO_EM_RESTART': '1', 07:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:08 INFO - 'PWD': '/builds/slave/test', 07:44:08 INFO - 'SHELL': '/bin/bash', 07:44:08 INFO - 'SHLVL': '1', 07:44:08 INFO - 'TERM': 'linux', 07:44:08 INFO - 'TMOUT': '86400', 07:44:08 INFO - 'USER': 'cltbld', 07:44:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:08 INFO - '_': '/tools/buildbot/bin/python'} 07:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:08 INFO - Downloading/unpacking psutil>=3.1.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:10 INFO - Installing collected packages: psutil 07:44:10 INFO - Running setup.py install for psutil 07:44:10 INFO - building 'psutil._psutil_linux' extension 07:44:10 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 07:44:11 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 07:44:11 INFO - building 'psutil._psutil_posix' extension 07:44:11 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 07:44:11 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 07:44:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:11 INFO - Successfully installed psutil 07:44:11 INFO - Cleaning up... 07:44:11 INFO - Return code: 0 07:44:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:44: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 mozsystemmonitor==0.3 07:44:11 INFO - Using env: {'DISPLAY': ':0', 07:44:11 INFO - 'HOME': '/home/cltbld', 07:44:11 INFO - 'LANG': 'en_US.UTF-8', 07:44:11 INFO - 'LANGUAGE': 'en_US:en', 07:44:11 INFO - 'LOGNAME': 'cltbld', 07:44:11 INFO - 'MAIL': '/var/mail/cltbld', 07:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:11 INFO - 'MOZ_NO_REMOTE': '1', 07:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:11 INFO - 'NO_EM_RESTART': '1', 07:44:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:11 INFO - 'PWD': '/builds/slave/test', 07:44:11 INFO - 'SHELL': '/bin/bash', 07:44:11 INFO - 'SHLVL': '1', 07:44:11 INFO - 'TERM': 'linux', 07:44:11 INFO - 'TMOUT': '86400', 07:44:11 INFO - 'USER': 'cltbld', 07:44:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:11 INFO - '_': '/tools/buildbot/bin/python'} 07:44:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:13 INFO - Installing collected packages: mozsystemmonitor 07:44:13 INFO - Running setup.py install for mozsystemmonitor 07:44:13 INFO - Successfully installed mozsystemmonitor 07:44:13 INFO - Cleaning up... 07:44:13 INFO - Return code: 0 07:44:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:13 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')]} 07:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:13 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')]} 07:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:13 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:13 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 07:44:13 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 07:44:13 INFO - Using env: {'DISPLAY': ':0', 07:44:13 INFO - 'HOME': '/home/cltbld', 07:44:13 INFO - 'LANG': 'en_US.UTF-8', 07:44:13 INFO - 'LANGUAGE': 'en_US:en', 07:44:13 INFO - 'LOGNAME': 'cltbld', 07:44:13 INFO - 'MAIL': '/var/mail/cltbld', 07:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:13 INFO - 'MOZ_NO_REMOTE': '1', 07:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:13 INFO - 'NO_EM_RESTART': '1', 07:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:13 INFO - 'PWD': '/builds/slave/test', 07:44:13 INFO - 'SHELL': '/bin/bash', 07:44:13 INFO - 'SHLVL': '1', 07:44:13 INFO - 'TERM': 'linux', 07:44:13 INFO - 'TMOUT': '86400', 07:44:13 INFO - 'USER': 'cltbld', 07:44:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:13 INFO - '_': '/tools/buildbot/bin/python'} 07:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:16 INFO - Downloading docopt-0.6.1.tar.gz 07:44:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:16 INFO - Running setup.py install for blobuploader 07:44:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:16 INFO - Running setup.py install for requests 07:44:17 INFO - Running setup.py install for docopt 07:44:17 INFO - Successfully installed blobuploader requests docopt 07:44:17 INFO - Cleaning up... 07:44:17 INFO - Return code: 0 07:44:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:17 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:17 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 07:44:17 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 07:44:17 INFO - Using env: {'DISPLAY': ':0', 07:44:17 INFO - 'HOME': '/home/cltbld', 07:44:17 INFO - 'LANG': 'en_US.UTF-8', 07:44:17 INFO - 'LANGUAGE': 'en_US:en', 07:44:17 INFO - 'LOGNAME': 'cltbld', 07:44:17 INFO - 'MAIL': '/var/mail/cltbld', 07:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:17 INFO - 'MOZ_NO_REMOTE': '1', 07:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:17 INFO - 'NO_EM_RESTART': '1', 07:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:17 INFO - 'PWD': '/builds/slave/test', 07:44:17 INFO - 'SHELL': '/bin/bash', 07:44:17 INFO - 'SHLVL': '1', 07:44:17 INFO - 'TERM': 'linux', 07:44:17 INFO - 'TMOUT': '86400', 07:44:17 INFO - 'USER': 'cltbld', 07:44:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:17 INFO - '_': '/tools/buildbot/bin/python'} 07:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:17 INFO - Running setup.py (path:/tmp/pip-ESIwyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:17 INFO - Running setup.py (path:/tmp/pip-PiHz1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:17 INFO - Running setup.py (path:/tmp/pip-3t9hTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:17 INFO - Running setup.py (path:/tmp/pip-yDAwpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:17 INFO - Running setup.py (path:/tmp/pip-djaIQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:17 INFO - Running setup.py (path:/tmp/pip-fDs3pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:17 INFO - Running setup.py (path:/tmp/pip-DnqIss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:17 INFO - Running setup.py (path:/tmp/pip-d9LRFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:18 INFO - Running setup.py (path:/tmp/pip-YY_LtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:18 INFO - Running setup.py (path:/tmp/pip-1xFYji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:18 INFO - Running setup.py (path:/tmp/pip-XJYFzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:18 INFO - Running setup.py (path:/tmp/pip-rnxDcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:18 INFO - Running setup.py (path:/tmp/pip-UFsyy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:18 INFO - Running setup.py (path:/tmp/pip-t09bXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:18 INFO - Running setup.py (path:/tmp/pip-twXZcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:18 INFO - Running setup.py (path:/tmp/pip-QMYfu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:18 INFO - Running setup.py (path:/tmp/pip-HaQ3gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:18 INFO - Running setup.py install for manifestparser 07:44:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:18 INFO - Running setup.py install for mozcrash 07:44:18 INFO - Running setup.py install for mozdebug 07:44:18 INFO - Running setup.py install for mozdevice 07:44:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for mozfile 07:44:19 INFO - Running setup.py install for mozhttpd 07:44:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for mozinfo 07:44:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for mozInstall 07:44:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for mozleak 07:44:19 INFO - Running setup.py install for mozlog 07:44:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for moznetwork 07:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:19 INFO - Running setup.py install for mozprocess 07:44:19 INFO - Running setup.py install for mozprofile 07:44:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:20 INFO - Running setup.py install for mozrunner 07:44:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:20 INFO - Running setup.py install for mozscreenshot 07:44:20 INFO - Running setup.py install for moztest 07:44:20 INFO - Running setup.py install for mozversion 07:44:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:20 INFO - Cleaning up... 07:44:20 INFO - Return code: 0 07:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:20 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:20 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 07:44:20 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 07:44:20 INFO - Using env: {'DISPLAY': ':0', 07:44:20 INFO - 'HOME': '/home/cltbld', 07:44:20 INFO - 'LANG': 'en_US.UTF-8', 07:44:20 INFO - 'LANGUAGE': 'en_US:en', 07:44:20 INFO - 'LOGNAME': 'cltbld', 07:44:20 INFO - 'MAIL': '/var/mail/cltbld', 07:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:20 INFO - 'MOZ_NO_REMOTE': '1', 07:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:20 INFO - 'NO_EM_RESTART': '1', 07:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:20 INFO - 'PWD': '/builds/slave/test', 07:44:20 INFO - 'SHELL': '/bin/bash', 07:44:20 INFO - 'SHLVL': '1', 07:44:20 INFO - 'TERM': 'linux', 07:44:20 INFO - 'TMOUT': '86400', 07:44:20 INFO - 'USER': 'cltbld', 07:44:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:20 INFO - '_': '/tools/buildbot/bin/python'} 07:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:20 INFO - Running setup.py (path:/tmp/pip-Lv0CUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:20 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)) 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:20 INFO - Running setup.py (path:/tmp/pip-QI1j9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:20 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)) 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:20 INFO - Running setup.py (path:/tmp/pip-a0RqTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:20 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)) 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:20 INFO - Running setup.py (path:/tmp/pip-C8vLYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:20 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)) 07:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:20 INFO - Running setup.py (path:/tmp/pip-tFFxpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:21 INFO - Running setup.py (path:/tmp/pip-WFTfdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:21 INFO - Running setup.py (path:/tmp/pip-Db_Als-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:21 INFO - Running setup.py (path:/tmp/pip-x9vpf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:21 INFO - Running setup.py (path:/tmp/pip-hOURx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:21 INFO - Running setup.py (path:/tmp/pip-9bZPnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:21 INFO - Running setup.py (path:/tmp/pip-0OKn8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:21 INFO - Running setup.py (path:/tmp/pip-gcGNGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:21 INFO - Running setup.py (path:/tmp/pip-7LlHmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:21 INFO - Running setup.py (path:/tmp/pip-UW5vzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:21 INFO - Running setup.py (path:/tmp/pip-y6k0Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:21 INFO - Running setup.py (path:/tmp/pip-MaFjzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:21 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)) 07:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:21 INFO - Running setup.py (path:/tmp/pip-WNW5RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:21 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)) 07:44:21 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)) 07:44:21 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)) 07:44:21 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)) 07:44:21 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)) 07:44:21 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)) 07:44:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:21 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 07:44:21 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 07:44:21 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 07:44:21 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 07:44:21 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 07:44:21 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 07:44:23 INFO - Downloading blessings-1.6.tar.gz 07:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:23 INFO - Installing collected packages: blessings 07:44:23 INFO - Running setup.py install for blessings 07:44:24 INFO - Successfully installed blessings 07:44:24 INFO - Cleaning up... 07:44:24 INFO - Return code: 0 07:44:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:24 INFO - Reading from file tmpfile_stdout 07:44:24 INFO - Current package versions: 07:44:24 INFO - argparse == 1.2.1 07:44:24 INFO - blessings == 1.6 07:44:24 INFO - blobuploader == 1.2.4 07:44:24 INFO - docopt == 0.6.1 07:44:24 INFO - manifestparser == 1.1 07:44:24 INFO - mozInstall == 1.12 07:44:24 INFO - mozcrash == 0.17 07:44:24 INFO - mozdebug == 0.1 07:44:24 INFO - mozdevice == 0.48 07:44:24 INFO - mozfile == 1.2 07:44:24 INFO - mozhttpd == 0.7 07:44:24 INFO - mozinfo == 0.9 07:44:24 INFO - mozleak == 0.1 07:44:24 INFO - mozlog == 3.2 07:44:24 INFO - moznetwork == 0.27 07:44:24 INFO - mozprocess == 0.22 07:44:24 INFO - mozprofile == 0.28 07:44:24 INFO - mozrunner == 6.11 07:44:24 INFO - mozscreenshot == 0.1 07:44:24 INFO - mozsystemmonitor == 0.3 07:44:24 INFO - moztest == 0.7 07:44:24 INFO - mozversion == 1.4 07:44:24 INFO - psutil == 3.1.1 07:44:24 INFO - requests == 1.2.3 07:44:24 INFO - wsgiref == 0.1.2 07:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:24 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')]} 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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')]} 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:24 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 07:44:24 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 07:44:24 INFO - Using env: {'DISPLAY': ':0', 07:44:24 INFO - 'HOME': '/home/cltbld', 07:44:24 INFO - 'LANG': 'en_US.UTF-8', 07:44:24 INFO - 'LANGUAGE': 'en_US:en', 07:44:24 INFO - 'LOGNAME': 'cltbld', 07:44:24 INFO - 'MAIL': '/var/mail/cltbld', 07:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:24 INFO - 'MOZ_NO_REMOTE': '1', 07:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:24 INFO - 'NO_EM_RESTART': '1', 07:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:24 INFO - 'PWD': '/builds/slave/test', 07:44:24 INFO - 'SHELL': '/bin/bash', 07:44:24 INFO - 'SHLVL': '1', 07:44:24 INFO - 'TERM': 'linux', 07:44:24 INFO - 'TMOUT': '86400', 07:44:24 INFO - 'USER': 'cltbld', 07:44:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:24 INFO - '_': '/tools/buildbot/bin/python'} 07:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 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)) 07:44:24 INFO - Cleaning up... 07:44:24 INFO - Return code: 0 07:44:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:44:24 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')]} 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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')]} 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:24 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:24 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 07:44:24 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 07:44:24 INFO - Using env: {'DISPLAY': ':0', 07:44:24 INFO - 'HOME': '/home/cltbld', 07:44:24 INFO - 'LANG': 'en_US.UTF-8', 07:44:24 INFO - 'LANGUAGE': 'en_US:en', 07:44:24 INFO - 'LOGNAME': 'cltbld', 07:44:24 INFO - 'MAIL': '/var/mail/cltbld', 07:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:24 INFO - 'MOZ_NO_REMOTE': '1', 07:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:24 INFO - 'NO_EM_RESTART': '1', 07:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:24 INFO - 'PWD': '/builds/slave/test', 07:44:24 INFO - 'SHELL': '/bin/bash', 07:44:24 INFO - 'SHLVL': '1', 07:44:24 INFO - 'TERM': 'linux', 07:44:24 INFO - 'TMOUT': '86400', 07:44:24 INFO - 'USER': 'cltbld', 07:44:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:24 INFO - '_': '/tools/buildbot/bin/python'} 07:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:24 INFO - Downloading/unpacking jsonschema 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:26 INFO - Downloading/unpacking functools32 (from jsonschema) 07:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:26 INFO - warning: no files found matching '*.txt' 07:44:26 INFO - no previously-included directories found matching 'build' 07:44:26 INFO - no previously-included directories found matching 'dist' 07:44:26 INFO - no previously-included directories found matching '.git*' 07:44:26 INFO - Installing collected packages: jsonschema, functools32 07:44:26 INFO - Running setup.py install for functools32 07:44:27 INFO - warning: no files found matching '*.txt' 07:44:27 INFO - no previously-included directories found matching 'build' 07:44:27 INFO - no previously-included directories found matching 'dist' 07:44:27 INFO - no previously-included directories found matching '.git*' 07:44:27 INFO - Successfully installed jsonschema functools32 07:44:27 INFO - Cleaning up... 07:44:27 INFO - Return code: 0 07:44:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:44:27 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')]} 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:27 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')]} 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:27 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 0x7fc399106f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2025770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', '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 07:44:27 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 07:44:27 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 07:44:27 INFO - Using env: {'DISPLAY': ':0', 07:44:27 INFO - 'HOME': '/home/cltbld', 07:44:27 INFO - 'LANG': 'en_US.UTF-8', 07:44:27 INFO - 'LANGUAGE': 'en_US:en', 07:44:27 INFO - 'LOGNAME': 'cltbld', 07:44:27 INFO - 'MAIL': '/var/mail/cltbld', 07:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:27 INFO - 'MOZ_NO_REMOTE': '1', 07:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:27 INFO - 'NO_EM_RESTART': '1', 07:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:27 INFO - 'PWD': '/builds/slave/test', 07:44:27 INFO - 'SHELL': '/bin/bash', 07:44:27 INFO - 'SHLVL': '1', 07:44:27 INFO - 'TERM': 'linux', 07:44:27 INFO - 'TMOUT': '86400', 07:44:27 INFO - 'USER': 'cltbld', 07:44:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:27 INFO - '_': '/tools/buildbot/bin/python'} 07:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:27 INFO - Downloading/unpacking flake8 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:44:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:44:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 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 07:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:29 INFO - no previously-included directories found matching 'docs/_build' 07:44:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:44:29 INFO - Running setup.py install for pep8 07:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:44:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:44:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:44:30 INFO - no previously-included directories found matching 'docs/_build' 07:44:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:44:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:44:30 INFO - Cleaning up... 07:44:30 INFO - Return code: 0 07:44:30 INFO - Running post-action listener: _resource_record_post_action 07:44:30 INFO - Running post-action listener: _start_resource_monitoring 07:44:30 INFO - Starting resource monitoring. 07:44:30 INFO - ##### 07:44:30 INFO - ##### Finished create-virtualenv step (success) 07:44:30 INFO - ##### 07:44:30 INFO - ##### 07:44:30 INFO - ##### Running install step. 07:44:30 INFO - ##### 07:44:30 INFO - Running pre-action listener: _resource_record_pre_action 07:44:30 INFO - Running main action method: install 07:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:30 INFO - Reading from file tmpfile_stdout 07:44:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:44:30 INFO - Reading from file tmpfile_stdout 07:44:30 INFO - Output received: 07:44:30 INFO - Usage: mozinstall [options] installer 07:44:30 INFO - Options: 07:44:30 INFO - -h, --help show this help message and exit 07:44:30 INFO - -d DEST, --destination=DEST 07:44:30 INFO - Directory to install application into. [default: 07:44:30 INFO - "/builds/slave/test"] 07:44:30 INFO - --app=APP Application being installed. [default: firefox] 07:44:30 INFO - mkdir: /builds/slave/test/build/application 07:44:30 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'] 07:44:30 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 07:44:46 INFO - Reading from file tmpfile_stdout 07:44:46 INFO - Output received: 07:44:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:44:46 INFO - Running post-action listener: _resource_record_post_action 07:44:46 INFO - ##### 07:44:46 INFO - ##### Finished install step (success) 07:44:46 INFO - ##### 07:44:46 INFO - ##### 07:44:46 INFO - ##### Running run-tests step. 07:44:46 INFO - ##### 07:44:46 INFO - Running pre-action listener: _resource_record_pre_action 07:44:46 INFO - Running main action method: run_tests 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:46 INFO - Python 2.7.3 07:44:46 INFO - Return code: 0 07:44:46 INFO - grabbing minidump binary from tooltool 07:44:46 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')]} 07:44:46 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 0x20b49c0>, '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 0x20b58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:46 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 07:44:46 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 07:44:46 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 07:44:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:46 INFO - Return code: 0 07:44:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:44:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:44:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:44:47 INFO - Return code: 0 07:44:47 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/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:44:47 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/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 07:44:47 INFO - Using env: {'DISPLAY': ':0', 07:44:47 INFO - 'HOME': '/home/cltbld', 07:44:47 INFO - 'LANG': 'en_US.UTF-8', 07:44:47 INFO - 'LANGUAGE': 'en_US:en', 07:44:47 INFO - 'LOGNAME': 'cltbld', 07:44:47 INFO - 'MAIL': '/var/mail/cltbld', 07:44:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:47 INFO - 'MOZ_NO_REMOTE': '1', 07:44:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:47 INFO - 'NO_EM_RESTART': '1', 07:44:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:47 INFO - 'PWD': '/builds/slave/test', 07:44:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:47 INFO - 'SHELL': '/bin/bash', 07:44:47 INFO - 'SHLVL': '1', 07:44:47 INFO - 'TERM': 'linux', 07:44:47 INFO - 'TMOUT': '86400', 07:44:47 INFO - 'USER': 'cltbld', 07:44:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383', 07:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:47 INFO - '_': '/tools/buildbot/bin/python'} 07:44:47 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/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 07:44:47 INFO - mozversion application_buildid: 20160601060845 07:44:47 INFO - mozversion application_changeset: 111970c738234569c8c180319155327316335deb 07:44:47 INFO - mozversion application_display_name: Nightly 07:44:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:47 INFO - mozversion application_name: Firefox 07:44:47 INFO - mozversion application_remotingname: firefox 07:44:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:44:47 INFO - mozversion application_vendor: Mozilla 07:44:47 INFO - mozversion application_version: 49.0a1 07:44:47 INFO - mozversion platform_buildid: 20160601060845 07:44:47 INFO - mozversion platform_changeset: 111970c738234569c8c180319155327316335deb 07:44:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:44:47 INFO - mozversion platform_version: 49.0a1 07:44:47 INFO - using testdate: 1464792287 07:44:47 INFO - actual date: 1464792287 07:44:47 INFO - starting webserver on 'localhost:58382' 07:44:47 INFO - SUITE-START | Running 2 tests 07:44:47 INFO - TEST-START | dromaeo_css 07:44:47 INFO - operating with platform_type : linux_ 07:44:47 INFO - Initialising browser for dromaeo_css test... 07:44:47 INFO - TEST-INFO | started process 6311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0b1LR/profile http://localhost:58382/getInfo.html) 07:44:51 INFO - PROCESS | 6311 | __metrics Screen width/height:1600/1200 07:44:51 INFO - PROCESS | 6311 | colorDepth:24 07:44:51 INFO - PROCESS | 6311 | Browser inner width/height: 1024/697 07:44:51 INFO - PROCESS | 6311 | __metrics 07:44:52 ERROR - PROCESS | 6311 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:44:53 INFO - TEST-INFO | 6311: exit 0 07:44:53 INFO - Browser initialized. 07:44:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:53 INFO - TEST-INFO | started process 6393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0b1LR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:05 INFO - PROCESS | 6393 | RSS: Main: 157216768 07:45:05 INFO - PROCESS | 6393 | 07:45:57 INFO - PROCESS | 6393 | 1464792357066 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] 07:48:08 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58382/tests/dromaeo/cssquery-ext.html) 07:48:09 INFO - PROCESS | 6393 | RSS: Main: 262840320 07:48:09 INFO - PROCESS | 6393 | 07:51:12 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-ext.html (next: http://localhost:58382/tests/dromaeo/cssquery-jquery.html) 07:51:13 INFO - PROCESS | 6393 | RSS: Main: 241311744 07:51:13 INFO - PROCESS | 6393 | 07:54:15 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58382/tests/dromaeo/cssquery-mootools.html) 07:54:15 INFO - PROCESS | 6393 | RSS: Main: 240996352 07:54:15 INFO - PROCESS | 6393 | 07:57:17 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58382/tests/dromaeo/cssquery-prototype.html) 07:57:18 INFO - PROCESS | 6393 | RSS: Main: 242196480 07:57:18 INFO - PROCESS | 6393 | 08:00:21 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58382/tests/dromaeo/cssquery-yui.html) 08:00:21 INFO - PROCESS | 6393 | RSS: Main: 211243008 08:00:21 INFO - PROCESS | 6393 | 08:03:24 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:58382/tests/dromaeo/cssquery-yui.html (next: http://localhost:58382/tests/dromaeo/cssquery-dojo.html) 08:03:25 INFO - PROCESS | 6393 | RSS: Main: 273543168 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | __start_tp_report 08:03:25 INFO - PROCESS | 6393 | _x_x_mozilla_page_load 08:03:25 INFO - PROCESS | 6393 | _x_x_mozilla_page_load_details 08:03:25 INFO - PROCESS | 6393 | |i|pagename|runs| 08:03:25 INFO - PROCESS | 6393 | |0;dojo.html;2633.8419694818313;2633.9990803494675;2634.3019099938506;2654.2302732207672;2673.879675414606;4441.978344980656;4529.501754806968;4534.365188873556;4587.472440669324;4647;4574.359589657451;4611.400517932672;4670.159371313162;4702.482726900038;4735.195016847136;4231.957680423203;4243.151369726052;4375.256206444912;4375.4093197418415;4384.8026838792175;4246.596573325544;4283.571642835723;4353.281708518107;4373.322135069069;4387.210302145629;4318.805653745589;4351.129774045188;4379.868603941887;4397.988462653591;4408.97795511022;4147.3778933159965;4169.478815148106;4264.189803937242;4276.50820155683;4306.095719898825;4226.936595951063;4228.598283163125;4235.830566777326;4253.1706317268145;4281.186574550826;4601.700889442175;4607.516210797885;4635.976820115878;4641.559051890065;4652.209124448852;4792.041591681677;4873.683210591335;4942.802287908516;4972.90054198914;5030.8239211627415;5022.598192144656;5044.646874718771;5081;5081.339425874649;5084.694918304914;4721.008588196483;4737;4740.454847692559;4742.217534106868;4752.358431611758;4959.603231741452;5116.258142569307;5168.224766285012;5173.249878767558;5200.76596553156;4979.925301120486;5008.373953255843;5034.723090229999;5034.748262586856;5036.043151801146;4834.903301933941;5074.06129865976;5076.314697515788;5076.492350764894;5119.129747942859;4895.118878601886;4915.606751459874;4929.433115191727;4941.827036053721;4944.629152813553;4920.065187614342;4926.187179115477;4934.407871055425;4936.308916751657;4994.825181118644;4161.4382058421725;4192.266353388145;4240.151969606091;4248.978755106266;4296.505901821268;3689.6679298862696;3714.312852122312;3719.237556300952;3739.569949455793;3769.133099387156;4301.505326887448;4322.783860806947;4324.3513472978675;4349.760763157993;4355.477342718894;4757.26262429324;5008.69947803133;5009.824656137018;5011.749412529359;5052.242163675478;4273.700840941105;4316.913661726748;4350.390945267602;4359.520452750195;4365.825366985348;4491.169133710274;4494.77526123699;4500.459944806578;4518.231900576844;4544.954550454519;4581.289900065495;4664.7667616618355;4711.740854252912;4720;4720.598749106296;4968.4286307075145;4989.850304490871;5000.499950004971;5003.924941125959;5051.696898186121;4699.741514216751;4714.764261786829;4715.504871988392;4718.433787945469;4767.713937163781;4810.5670489656095;4888.242322440027;4899.534544218293;4922.040202160544;4983;4987.650864439454;4991.5008499151245;5007.198848184273;5010.549050585465;5057.115004874206;4855.174620314484;4873.780679869344;4876;4879.219324907997;4929.06347793918;4758.714477131383;4778.617710583076;4780.521947805191;4802.591779698765;4924.581410580141;4773.307870358848;4775.2359622460235;4790.329353890388;4814.325994360723;4821.421429428491;4833.73414462208;4855.053264613366;4869.196582563837;4897;4908.730019848943;4658.743769092597;4688.7890044948745;4725.432948046119;4776.904461910673;4804.42346918372 08:03:25 INFO - PROCESS | 6393 | |1;ext.html;542.9762412727587;573.8049063318472;588.8174665853583;591.0956236957451;593.5726277080503;30032.249193770138;30816.075517734447;39444.60555394445;40546.39180412296;40566.188676226455;41847.16305673885;42400;42526.574734252645;42528.57471425285;42579;7563.584002879839;7784.649690763901;7793.064832220141;7793.259640334188;7795.493292935941;7404.592747398891;9936.254780891426;10230;10244.129249013842;10585.947070264638;10150.340227885164;10262.230332725037;10266.973302669749;10277.280590358678;10280.84578731316;7423.665935032883;7651.464397492177;10084.94957525215;10149.137323327526;10153.543090560943;7456.142543607501;7525.4355923305975;9894.257930655229;10308;10319;35502.644973550196;39912;39969.80015099906;39980.40029399561;40042.599574004176;2985.462616728988;3077.522983937471;3090.5209692497697;3144.292534179814;3563.9829246500444;29343;29582.112536623936;29986.55020174699;30654.846725766452;30726.539101913488;3494.318607871466;3496.213351995806;3506.2987402519598;3522.4892390603477;3536.4341705327024;258767;259196;259943;260052;260160;57692.711536442046;58494;58563.414365855795;58615.41384586185;58620.70689646524;61131;61425.69287153536;61890.38109618936;61917.69041154855;61951.07073393903;15136.621584460476;15336.923315383576;15338.693226135638;15340.156291403857;15346.923265383602;9756.07317304855;11155.27490713101;11415.771684566262;11432.657020289405;11485.770284594428;18987.525311867037;19046.90476547636;19197.808021919882;19215.807841921403;19260.22959081621;6917.654117294115;6939.687714052779;6999.825004374931;7087.89368159478;7276.927230727731;805.8025783683036;963.629002833914;1011.7774089700254;1032.488917985602;1036.9688909332733;27843.582346264822;27916.83538545335;28127.296817579725;28255.29361765972;28356.71643283541;965.8647789309503;977.2816979520047;981.2101258486844;999.2305924438288;1001.3291094966245;13768.141300924448;14439.711205776035;14558.4904528341;14586;14674.33965471535;367974;370973;371500;371584;372451;48106.518934810905;48709.756451217516;48731.26903096456;48750;48767;1184.3721365488461;1204.8855358740905;1217.2331431198465;1219.061322781471;1242.683115805482;23594.410139746644;24585.63121553214;28306.57540136941;29356;29972.550411744276;47797;48873.511264886896;48883.511164887896;48886.75556622194;48900;354821;360289;363918;364498;364751;32070.83964580162;32629;38752;39123.21753564856;39652.20695586014;42071.57928420677;42506.36240456334;42909.54274353877;43145;43422.78288608663;35959.46060809142;36355;36849.263014739015;36918.63081369152;37442.43836342511;35897.46153807643;35920.64079359278;35930;35930.4610430849;35987.280254394245;35087;35843.82078089593;35887;36207;36251.45622815713;31285;32846.835765821015;32886.83556582202;32947.17632059122;33102.33795324032;24889.37776555528;25005.249842504752;25283.620745689197;25515.744842552078;25590.87204563965 08:03:25 INFO - PROCESS | 6393 | |2;jquery.html;372.8434057695769;377.6487866284355;378.9071677439026;390.8534299637636;393.09195757799466;15789.36842526299;16083.437079702198;16948.322067117333;16966.830331696678;16975.91512042438;10376.325538839988;10521.053105220528;10532.315399499028;10536.104431123345;10538.209634277422;4560.270356742922;4696.835610753625;4747.382840230765;5149.716765577892;5150.793968241266;4977.8257760978195;5096.668716533432;5102.515261050213;5102.872428189288;5111.412187598418;5071;5087.364079490064;5089.847304580869;5251.973740131294;5570.136628822539;5561.555075593943;5566.916496252559;5595.160725891108;5601.551875849922;5606.747696353654;5259.500347466985;5447.073997420448;5505.972470137664;5506.146547285177;5525.834224973257;12440;12519.93740031303;12550.309732964683;13338.799918001238;19849.9007504963;1819.3177558415593;1920.9231630734753;1936.4093951344835;2332.416895776056;2393.628987506939;9075.500847453388;9583.137517623447;9781.364211326312;10252.74368140795;13610.86389136106;1754.3070487157502;1755.1224387806096;1769.2392271323326;1770.0618672103806;1848.1036697201846;67840.32159678389;68304;68584.6570767143;69180.6540967292;69429.30570694279;10170.949145254226;10174.796504070026;10186.286959912883;10240.948795255976;10413.843792343121;13859.722805543832;13887.888968882466;13913;13913.58259252224;13922.37349319283;7139.92860071403;7162.534435261691;7223.89164162538;7307.707691692272;7338.853222935618;6623.701933413008;6672.5996440212775;6744.6627668616375;6815.931840681629;6834.829129271808;4345.261305578059;4399.6920215584605;4415.66882483815;4424.0709451015;4447.066116115588;1704.8977061376356;1805.2778888444464;1839.5860931290354;1897.468708761549;1898.6582415165126;768.7847402727245;829.788403956987;860.350435421253;909.4316052467208;913.7304495173939;15619.219039048003;16324.34702611906;16559.91720041392;16728;17000.82999170017;821.5399376349263;838.3502785341409;841.9115992820788;852.5694524265331;869.2871845086968;9077.909220907839;9273.211776998896;9297.628094876129;9360.391574547768;9702.175315098155;399272;399758;401923;402820;406892;43934.34098488525;53578.660533486975;59793;72535;74835.25164748392;917.6008436330218;921.1571412157934;929.4098247612815;950.4582388038751;951.7240000399806;14808.59402337447;14906.25468726581;14934.286155055586;15100.471483498024;15105.39578416851;32637.836810816745;33739.325213496086;34209.31581368409;34319.31361372808;35598.64401355953;42108.789456052524;46380.7680961593;46702.29946550736;47268.29097563608;47271;6795.830104247433;6836.487263455161;6845.5550389224545;6887.311268873273;7073.257307982588;6665.766698165541;6879.759208427681;9431.858522122036;10396.272260941661;10513.57945682164;8960.417572857743;9206.769830754285;9449.574769135268;9461.574229159567;9504.334696571173;9223.354365194373;9236.769080773034;9255.629774809202;9321.114494123047;9501.667441639509;9084.454932704059;9165.679201227926;9246.445213287225;9265.027172146827;9395.154436100784;6394.200724909387;6787.185537735503;6792.592444453348;6877.793666190022;6938.5836849789175;7174.964125179341;8570.957145214234;9174.08259174104;9265.86101208469;9297.6280948764 08:03:25 INFO - PROCESS | 6393 | |3;mootools.html;1219.3293688471338;1354.3499120422198;1422.1680317014545;1477.8817694584434;1709.3846215362476;6417.839554011146;7280.635968201588;7424.294692004251;7491.8876216856725;7697.2687594678555;7538.81152971176;7643.46495745298;7652.770416887488;7673.424493163007;7700.383969282458;2199.472126689595;2220.7002054722566;2220.85564438311;2225.276785044859;2226.065052677871;2153.881536515491;2163.7728038555883;2204.0853045985896;2204.9228277010307;2209.635410157322;2138.123369418539;2142.657174852024;2144.517483566193;2146.9355919322365;2193.7367515898036;2101.2750601042617;2108.2410332280365;2112.86266392684;2115.7038014677955;2116.3016204652504;2089.3523007867457;2136.327056977063;2138.262299506683;2139.358192542231;2144.0351841671154;7446.218147094532;7497.887531687029;7502.324790768803;7503.549787012742;7683.884741728879;4464.1071785643;4567.794449249758;4568.817247310104;4569.04050149469;4598.563136502027;2882.351470919047;3003.309238875071;3026.969730302691;3033.347830216492;3037.088873338012;947.6967370441462;950.7005293332578;956.1633570625703;956.3401253135314;970.0832713086137;10311.690649280534;10334.276600637959;10342.84485732707;10343.534540945675;10396.688099357032;4162.4796900387455;4180.665546756252;4215.367694845798;4333.71830830995;4340.47914250292;8149.633266503021;8166.510009399455;8169.42814003026;8174.877376839352;8188.795280117925;4488.169688607618;4488.708233964782;4488.798004089824;4491.05687805558;4530.048689775184;3619.7285203609836;3712.5730540987593;4193.853215137456;4212.789360531961;4214.726042807269;3625.6041424051405;3746.438034294823;3750.6999440044733;3798.1264309209037;3799.3161230978135;1187.352892673495;1205.5539450403407;1210.667066556704;1218.2994778002683;1223.5472875036294;725.8729722298576;855.5209082913589;860.714055520026;868.6308318964541;879.2394578689515;5053.898922021613;5117.744112794346;5174.239148263538;5275.419703832576;5321.600879934021;428.55644408037534;433.68124428544996;438.8815019944597;439.92081425343747;443.3748414735208;3519.1729943463265;3559.323728491578;3563.893083207508;3587.7488575799443;3620.2035552178477;9279;9409.435433873989;9538.856917146248;9558.28312876537;9598.088181622734;9287.164155225926;9333.673321433716;9333.719988400358;9360.719178424659;9364.20404265645;7119.110111236096;7230.457715671346;7306.780796576111;7316.487845850846;7321.121465424077;5258.106121959199;5274.077036518517;5285.920711189258;5333.493318134771;5377.569794416359;8553.144685531397;8789.077146899483;8798.252148567444;8809.07504711996;8878.778030549289;8520.957395212985;8909.198172164537;9032.86450703227;9042.638294468148;9051.14014168653;5907.113932910098;5960.403959604005;6024.487918526975;6516.57642253252;6700.93299067003;7322.524035937647;7325.413966882743;7403.888941665771;7405.259474052552;7408.851822963618;6576.901346479903;6676.232233293039;6699.631520266432;6797.796066118024;6799.490038247052;6613.636250006296;6647.401733843977;6680.899786503109;6769.526133170631;6778;6135.9079613806725;6175.413335733098;6195.783147589813;6200.038993955944;6218.782342617987;4443.533428989909;4451.977740111279;4470.8435204767675;4584.908301834012;4588.839390621312;4479.977600111979;4510.075434535978;4549.818007279804;4551.65862560316;4695.272232803921 08:03:25 INFO - PROCESS | 6393 | |4;prototype.html;297.5937844841791;301.08019998903353;305.3816022554327;311.32442599558954;314.05156427588685;4752.762361881905;4776.880577985552;4799.68802027868;4800.687955282904;4828.903421931559;4705.564802735164;4727.929081063787;4730.408698912636;4750.7862146203415;4757.238841785315;3763.7177211709095;3783.375743002415;3790.1472168761948;3796.6013568575318;3823.483829682985;3517.9120521986897;3732.4961130247475;3821.407681809324;3825.1775868188333;3830.5020347354803;3663.5970043295215;3696.7781933083966;3702.500162478071;3705.981470092646;3710.907227319325;3685.4471829225563;3693.741438099334;3702.574203966538;3703.944375852869;3724.3296206682785;3089.2431354318337;3166.857491412892;3172.587563616715;3240.0603824890754;3292.1440425489304;4524;4531.614812740921;4556.382484218088;4567.314902764579;4574.61115805157;4232.9153416931795;4236.195122926634;4236.682248831319;4248.808803603845;4254.489461264637;4726.787294571753;4791;4975.487378873682;4999.875003124915;5001.574866136347;3525.11872031992;3531.9823400882833;3540.716742660581;3540.8760693375866;3550.254446566224;5193.169092945111;5217.069684216826;5236.7119808410525;5243.112479507375;5251.369835619712;3392.5928888533535;3565.4668492547935;3587.4260118380935;3622.710183185339;3660.304542137039;3587.712982961357;3592.892213233607;3594.694450971697;3607.549056367954;3629.3467175908063;4137.97931010343;4163.687723420756;4168.458100446983;4175.6868234881895;4179.874603761892;4878.0001296544315;4958.6776859504735;4973.47778483254;4980.402351717817;4992.425871024806;1252.405107573895;1271.319843883518;1275.1329096214479;1275.993620031894;1277.757226127033;797.5135167547792;806.4435539477741;824.9670013199525;827.1025936858456;827.4042689263721;3984.900377490586;4006.49756341372;4016.5339651027166;4042.3330150524835;4056.9594304057173;4529.977350113229;4661.813527458864;4665.393498845128;4667.159911216014;4680.391549098664;3944.2703099926607;3963.365861462152;3974.463447434617;3996.3805610130476;4021;2309.168699268262;2434.6469761884427;2468.0991438124956;2621.279148234251;2692.7845772338164;4836.250381190921;4843.370361852936;4863.9513604864205;4870.512948705101;4873.31773551703;5253.921191182136;5267.894642107136;5281.39263984639;5281.419043905167;5286.20706893969;4635.443746750411;4834.226523756252;4861.343718597944;4881.8771682513225;4914.262860570943;5116.360454943132;5120.641555091257;5145.87135321605;5153;5175.249588809676;5068.797248110034;5075.28945947575;5084.440711521655;5105.642605017613;5124.872528043825;4773.546513081252;4833.845804563368;4898.853034408973;4913.950860491349;4931.876703082452;3593.173570078844;3610.963890361168;3620.6741393274733;3624.4019736743144;3688.262347530451;5120.590352771844;5136.589072874236;5177.171652535576;5187.662801917863;5245.0558899398475;4743.715377077387;4964.957358954515;5027.924581131213;5038.823641172541;5041.924371134362;4981.178105612678;4989.426215985208;5014.222795466709;5045.722485263345;5054.140796064605;4899.387576552931;4909.9018019640125;4919.385076865392;4939.16034274167;4992.15133427311;4787.880302992453;5023.216758050839;5026.949730502648;5046.520580544842;5062.493750624908;4929.802807887644;4938.08645400602;4940.419065898878;4946.826861059845;4977.352944117241 08:03:25 INFO - PROCESS | 6393 | |5;yui.html;659.3143131143611;670.8557660103077;695.2144077192771;731.8755811512043;765.2232983521725;11318.660440186797;11390.715232119192;11412.31526108434;12259.387030648455;12277.631671049861;11724;11823.408829558532;11951.342676152808;11953.880461195386;12000.579979700691;628.597697473615;761.0866959648416;783.6786917363868;797.4736673795296;798.2137594469443;792.065362871811;798.1778767869104;798.6006996501749;799.3764863406552;800.5476905548376;823.9011318641772;825.4015838517087;826.2563692676579;829.0424559633602;829.2619568583965;653.7711800869705;781.4022272961189;806.8265322955534;822.2394285286116;823.2549542663899;592.2330581896455;592.3543337761861;592.9288485381738;593.3087952535291;593.8426317025992;11479.311241325464;11550.191486595942;11559.364234967074;11562.826557601642;11645.243059201124;11509.884901151048;11530.135239857043;11766.294022358601;12155.939220303842;12247.081468889868;11019.559217631286;11059.834102488468;11229.887701122965;11293.774124517464;11327;4037.9798101009305;4055.3105971984537;4169.97915010423;4217.177650358181;4292.1415716856445;46199.30701039487;46525;46664.76667616674;46679.53320466786;47179.76410117927;9377.812443751223;9688.951555242178;9961.950190249147;10246.692599222035;10264;16717.749233761504;16844.157792110345;16846.157692115346;16849.831501685072;16869.24088416024;6247.0629405589525;6349.142865713162;6426.550141490145;6499.707513161919;6528.249251336062;3466.774659647165;3533.717302615836;3579.319929213441;3597.748157628941;3651.123730304708;2757.7518023377593;2857.4285142971075;2860.17055054032;2860.442213768295;2863.8138520996067;520.9218617207449;527.6754795800632;528.6405244433745;530.8487081181922;552.4972275229521;494.3968358602499;603.770567184467;625.7121724007008;636.5544119116637;642.6690254518926;7744.690212391554;7847.372210223282;7851.136374998746;7888.842223155505;8122.634481448349;467.81988934259874;485.907677541266;621.0994058615026;629.3580547841176;632.9746810127543;3873.86441474547;3914.451976723261;3931.0761970936805;3982.203559288154;4071.9389209161886;54971.72514137404;56807.43192568104;56830.147547786815;57070.143947840814;57074.42925570691;48280.517194827604;49151.50848491541;49531.75234123806;51366.22950655743;51621.22568161481;41339.58660413417;42023.369649455286;46589;47231.5276847234;47258.52741472541;8491.575421229038;8500.957495212484;8575.228229459379;8659.13408659129;8749.606267717842;30241.243968900955;30539.694603053686;30577.54133687952;31168.688313116578;31690.683093168773;37623.43564846475;40669.38995915123;40926;41168;41576.466000390305;10437.225671635688;10763.46182690878;10836.738142813194;10888.836667449836;10900.836487452536;11752.294862308288;11971.521139154685;12119.091068170099;12189.268643881396;12493.812592811297;11361.772764544829;11670.88329116698;11867.287962722265;12001.219920705125;12283.38583070825;11443;11806.409679515818;11908.40457977115;11938.22401543897;12313.56902508408;11217.60738374153;11517.25137866036;11646.359450230319;11905.583304584645;11912.583059592873;9590.904090959;9780.657676981271;9848.409095454295;9887.505624718879;10236.283460158016;9433.7830609808;9644.95177524108;10222.233332500242;10228.53971571296;10268.127209187303 08:03:25 INFO - PROCESS | 6393 | __end_tp_report 08:03:25 INFO - PROCESS | 6393 | __start_cc_report 08:03:25 INFO - PROCESS | 6393 | _x_x_mozilla_cycle_collect,984 08:03:25 INFO - PROCESS | 6393 | __end_cc_report 08:03:25 INFO - PROCESS | 6393 | __startTimestamp1464793405070__endTimestamp 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | ------- Summary: start ------- 08:03:25 INFO - PROCESS | 6393 | Number of tests: 6 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#0] dojo.html Cycles:165 Average:4613.77 Median:4735.20 stddev:476.54 (10.1%) stddev-sans-first:451.99 08:03:25 INFO - PROCESS | 6393 | Values: 2633.8 2634.0 2634.3 2654.2 2673.9 4442.0 4529.5 4534.4 4587.5 4647.0 4574.4 4611.4 4670.2 4702.5 4735.2 4232.0 4243.2 4375.3 4375.4 4384.8 4246.6 4283.6 4353.3 4373.3 4387.2 4318.8 4351.1 4379.9 4398.0 4409.0 4147.4 4169.5 4264.2 4276.5 4306.1 4226.9 4228.6 4235.8 4253.2 4281.2 4601.7 4607.5 4636.0 4641.6 4652.2 4792.0 4873.7 4942.8 4972.9 5030.8 5022.6 5044.6 5081.0 5081.3 5084.7 4721.0 4737.0 4740.5 4742.2 4752.4 4959.6 5116.3 5168.2 5173.2 5200.8 4979.9 5008.4 5034.7 5034.7 5036.0 4834.9 5074.1 5076.3 5076.5 5119.1 4895.1 4915.6 4929.4 4941.8 4944.6 4920.1 4926.2 4934.4 4936.3 4994.8 4161.4 4192.3 4240.2 4249.0 4296.5 3689.7 3714.3 3719.2 3739.6 3769.1 4301.5 4322.8 4324.4 4349.8 4355.5 4757.3 5008.7 5009.8 5011.7 5052.2 4273.7 4316.9 4350.4 4359.5 4365.8 4491.2 4494.8 4500.5 4518.2 4545.0 4581.3 4664.8 4711.7 4720.0 4720.6 4968.4 4989.9 5000.5 5003.9 5051.7 4699.7 4714.8 4715.5 4718.4 4767.7 4810.6 4888.2 4899.5 4922.0 4983.0 4987.7 4991.5 5007.2 5010.5 5057.1 4855.2 4873.8 4876.0 4879.2 4929.1 4758.7 4778.6 4780.5 4802.6 4924.6 4773.3 4775.2 4790.3 4814.3 4821.4 4833.7 4855.1 4869.2 4897.0 4908.7 4658.7 4688.8 4725.4 4776.9 4804.4 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#1] ext.html Cycles:180 Average:49484.32 Median:35909.05 stddev:87948.40 (244.9%) stddev-sans-first:88118.35 08:03:25 INFO - PROCESS | 6393 | Values: 543.0 573.8 588.8 591.1 593.6 30032.2 30816.1 39444.6 40546.4 40566.2 41847.2 42400.0 42526.6 42528.6 42579.0 7563.6 7784.6 7793.1 7793.3 7795.5 7404.6 9936.3 10230.0 10244.1 10585.9 10150.3 10262.2 10267.0 10277.3 10280.8 7423.7 7651.5 10084.9 10149.1 10153.5 7456.1 7525.4 9894.3 10308.0 10319.0 35502.6 39912.0 39969.8 39980.4 40042.6 2985.5 3077.5 3090.5 3144.3 3564.0 29343.0 29582.1 29986.6 30654.8 30726.5 3494.3 3496.2 3506.3 3522.5 3536.4 258767.0 259196.0 259943.0 260052.0 260160.0 57692.7 58494.0 58563.4 58615.4 58620.7 61131.0 61425.7 61890.4 61917.7 61951.1 15136.6 15336.9 15338.7 15340.2 15346.9 9756.1 11155.3 11415.8 11432.7 11485.8 18987.5 19046.9 19197.8 19215.8 19260.2 6917.7 6939.7 6999.8 7087.9 7276.9 805.8 963.6 1011.8 1032.5 1037.0 27843.6 27916.8 28127.3 28255.3 28356.7 965.9 977.3 981.2 999.2 1001.3 13768.1 14439.7 14558.5 14586.0 14674.3 367974.0 370973.0 371500.0 371584.0 372451.0 48106.5 48709.8 48731.3 48750.0 48767.0 1184.4 1204.9 1217.2 1219.1 1242.7 23594.4 24585.6 28306.6 29356.0 29972.6 47797.0 48873.5 48883.5 48886.8 48900.0 354821.0 360289.0 363918.0 364498.0 364751.0 32070.8 32629.0 38752.0 39123.2 39652.2 42071.6 42506.4 42909.5 43145.0 43422.8 35959.5 36355.0 36849.3 36918.6 37442.4 35897.5 35920.6 35930.0 35930.5 35987.3 35087.0 35843.8 35887.0 36207.0 36251.5 31285.0 32846.8 32886.8 32947.2 33102.3 24889.4 25005.2 25283.6 25515.7 25590.9 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#2] jquery.html Cycles:180 Average:23349.56 Median:5130.56 stddev:66073.85 (1287.8%) stddev-sans-first:66236.68 08:03:25 INFO - PROCESS | 6393 | Values: 372.8 377.6 378.9 390.9 393.1 15789.4 16083.4 16948.3 16966.8 16975.9 10376.3 10521.1 10532.3 10536.1 10538.2 4560.3 4696.8 4747.4 5149.7 5150.8 4977.8 5096.7 5102.5 5102.9 5111.4 5071.0 5087.4 5089.8 5252.0 5570.1 5561.6 5566.9 5595.2 5601.6 5606.7 5259.5 5447.1 5506.0 5506.1 5525.8 12440.0 12519.9 12550.3 13338.8 19849.9 1819.3 1920.9 1936.4 2332.4 2393.6 9075.5 9583.1 9781.4 10252.7 13610.9 1754.3 1755.1 1769.2 1770.1 1848.1 67840.3 68304.0 68584.7 69180.7 69429.3 10170.9 10174.8 10186.3 10240.9 10413.8 13859.7 13887.9 13913.0 13913.6 13922.4 7139.9 7162.5 7223.9 7307.7 7338.9 6623.7 6672.6 6744.7 6815.9 6834.8 4345.3 4399.7 4415.7 4424.1 4447.1 1704.9 1805.3 1839.6 1897.5 1898.7 768.8 829.8 860.4 909.4 913.7 15619.2 16324.3 16559.9 16728.0 17000.8 821.5 838.4 841.9 852.6 869.3 9077.9 9273.2 9297.6 9360.4 9702.2 399272.0 399758.0 401923.0 402820.0 406892.0 43934.3 53578.7 59793.0 72535.0 74835.3 917.6 921.2 929.4 950.5 951.7 14808.6 14906.3 14934.3 15100.5 15105.4 32637.8 33739.3 34209.3 34319.3 35598.6 42108.8 46380.8 46702.3 47268.3 47271.0 6795.8 6836.5 6845.6 6887.3 7073.3 6665.8 6879.8 9431.9 10396.3 10513.6 8960.4 9206.8 9449.6 9461.6 9504.3 9223.4 9236.8 9255.6 9321.1 9501.7 9084.5 9165.7 9246.4 9265.0 9395.2 6394.2 6787.2 6792.6 6877.8 6938.6 7175.0 8571.0 9174.1 9265.9 9297.6 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#3] mootools.html Cycles:180 Average:5019.95 Median:5085.82 stddev:2784.32 (54.7%) stddev-sans-first:2777.48 08:03:25 INFO - PROCESS | 6393 | Values: 1219.3 1354.3 1422.2 1477.9 1709.4 6417.8 7280.6 7424.3 7491.9 7697.3 7538.8 7643.5 7652.8 7673.4 7700.4 2199.5 2220.7 2220.9 2225.3 2226.1 2153.9 2163.8 2204.1 2204.9 2209.6 2138.1 2142.7 2144.5 2146.9 2193.7 2101.3 2108.2 2112.9 2115.7 2116.3 2089.4 2136.3 2138.3 2139.4 2144.0 7446.2 7497.9 7502.3 7503.5 7683.9 4464.1 4567.8 4568.8 4569.0 4598.6 2882.4 3003.3 3027.0 3033.3 3037.1 947.7 950.7 956.2 956.3 970.1 10311.7 10334.3 10342.8 10343.5 10396.7 4162.5 4180.7 4215.4 4333.7 4340.5 8149.6 8166.5 8169.4 8174.9 8188.8 4488.2 4488.7 4488.8 4491.1 4530.0 3619.7 3712.6 4193.9 4212.8 4214.7 3625.6 3746.4 3750.7 3798.1 3799.3 1187.4 1205.6 1210.7 1218.3 1223.5 725.9 855.5 860.7 868.6 879.2 5053.9 5117.7 5174.2 5275.4 5321.6 428.6 433.7 438.9 439.9 443.4 3519.2 3559.3 3563.9 3587.7 3620.2 9279.0 9409.4 9538.9 9558.3 9598.1 9287.2 9333.7 9333.7 9360.7 9364.2 7119.1 7230.5 7306.8 7316.5 7321.1 5258.1 5274.1 5285.9 5333.5 5377.6 8553.1 8789.1 8798.3 8809.1 8878.8 8521.0 8909.2 9032.9 9042.6 9051.1 5907.1 5960.4 6024.5 6516.6 6700.9 7322.5 7325.4 7403.9 7405.3 7408.9 6576.9 6676.2 6699.6 6797.8 6799.5 6613.6 6647.4 6680.9 6769.5 6778.0 6135.9 6175.4 6195.8 6200.0 6218.8 4443.5 4452.0 4470.8 4584.9 4588.8 4480.0 4510.1 4549.8 4551.7 4695.3 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#4] prototype.html Cycles:180 Average:4101.45 Median:4692.98 stddev:1210.10 (25.8%) stddev-sans-first:1179.33 08:03:25 INFO - PROCESS | 6393 | Values: 297.6 301.1 305.4 311.3 314.1 4752.8 4776.9 4799.7 4800.7 4828.9 4705.6 4727.9 4730.4 4750.8 4757.2 3763.7 3783.4 3790.1 3796.6 3823.5 3517.9 3732.5 3821.4 3825.2 3830.5 3663.6 3696.8 3702.5 3706.0 3710.9 3685.4 3693.7 3702.6 3703.9 3724.3 3089.2 3166.9 3172.6 3240.1 3292.1 4524.0 4531.6 4556.4 4567.3 4574.6 4232.9 4236.2 4236.7 4248.8 4254.5 4726.8 4791.0 4975.5 4999.9 5001.6 3525.1 3532.0 3540.7 3540.9 3550.3 5193.2 5217.1 5236.7 5243.1 5251.4 3392.6 3565.5 3587.4 3622.7 3660.3 3587.7 3592.9 3594.7 3607.5 3629.3 4138.0 4163.7 4168.5 4175.7 4179.9 4878.0 4958.7 4973.5 4980.4 4992.4 1252.4 1271.3 1275.1 1276.0 1277.8 797.5 806.4 825.0 827.1 827.4 3984.9 4006.5 4016.5 4042.3 4057.0 4530.0 4661.8 4665.4 4667.2 4680.4 3944.3 3963.4 3974.5 3996.4 4021.0 2309.2 2434.6 2468.1 2621.3 2692.8 4836.3 4843.4 4864.0 4870.5 4873.3 5253.9 5267.9 5281.4 5281.4 5286.2 4635.4 4834.2 4861.3 4881.9 4914.3 5116.4 5120.6 5145.9 5153.0 5175.2 5068.8 5075.3 5084.4 5105.6 5124.9 4773.5 4833.8 4898.9 4914.0 4931.9 3593.2 3611.0 3620.7 3624.4 3688.3 5120.6 5136.6 5177.2 5187.7 5245.1 4743.7 4965.0 5027.9 5038.8 5041.9 4981.2 4989.4 5014.2 5045.7 5054.1 4899.4 4909.9 4919.4 4939.2 4992.2 4787.9 5023.2 5026.9 5046.5 5062.5 4929.8 4938.1 4940.4 4946.8 4977.4 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - PROCESS | 6393 | [#5] yui.html Cycles:180 Average:13218.91 Median:23120.27 stddev:15284.43 (66.1%) stddev-sans-first:15298.21 08:03:25 INFO - PROCESS | 6393 | Values: 659.3 670.9 695.2 731.9 765.2 11318.7 11390.7 11412.3 12259.4 12277.6 11724.0 11823.4 11951.3 11953.9 12000.6 628.6 761.1 783.7 797.5 798.2 792.1 798.2 798.6 799.4 800.5 823.9 825.4 826.3 829.0 829.3 653.8 781.4 806.8 822.2 823.3 592.2 592.4 592.9 593.3 593.8 11479.3 11550.2 11559.4 11562.8 11645.2 11509.9 11530.1 11766.3 12155.9 12247.1 11019.6 11059.8 11229.9 11293.8 11327.0 4038.0 4055.3 4170.0 4217.2 4292.1 46199.3 46525.0 46664.8 46679.5 47179.8 9377.8 9689.0 9962.0 10246.7 10264.0 16717.7 16844.2 16846.2 16849.8 16869.2 6247.1 6349.1 6426.6 6499.7 6528.2 3466.8 3533.7 3579.3 3597.7 3651.1 2757.8 2857.4 2860.2 2860.4 2863.8 520.9 527.7 528.6 530.8 552.5 494.4 603.8 625.7 636.6 642.7 7744.7 7847.4 7851.1 7888.8 8122.6 467.8 485.9 621.1 629.4 633.0 3873.9 3914.5 3931.1 3982.2 4071.9 54971.7 56807.4 56830.1 57070.1 57074.4 48280.5 49151.5 49531.8 51366.2 51621.2 41339.6 42023.4 46589.0 47231.5 47258.5 8491.6 8501.0 8575.2 8659.1 8749.6 30241.2 30539.7 30577.5 31168.7 31690.7 37623.4 40669.4 40926.0 41168.0 41576.5 10437.2 10763.5 10836.7 10888.8 10900.8 11752.3 11971.5 12119.1 12189.3 12493.8 11361.8 11670.9 11867.3 12001.2 12283.4 11443.0 11806.4 11908.4 11938.2 12313.6 11217.6 11517.3 11646.4 11905.6 11912.6 9590.9 9780.7 9848.4 9887.5 10236.3 9433.8 9645.0 10222.2 10228.5 10268.1 08:03:25 INFO - PROCESS | 6393 | -------- Summary: end -------- 08:03:25 INFO - PROCESS | 6393 | 08:03:25 INFO - TEST-INFO | 6393: exit 0 08:03:25 INFO - TEST-OK | dromaeo_css | took 1118320ms 08:03:25 INFO - TEST-START | kraken 08:03:25 INFO - operating with platform_type : linux_ 08:03:25 INFO - Initialising browser for kraken test... 08:03:25 INFO - TEST-INFO | started process 6571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxtBUl/profile http://localhost:58382/getInfo.html) 08:03:29 INFO - PROCESS | 6571 | __metrics Screen width/height:1600/1200 08:03:29 INFO - PROCESS | 6571 | colorDepth:24 08:03:29 INFO - PROCESS | 6571 | Browser inner width/height: 1024/697 08:03:29 INFO - PROCESS | 6571 | __metrics 08:03:30 ERROR - PROCESS | 6571 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:03:31 INFO - TEST-INFO | 6571: exit 0 08:03:31 INFO - Browser initialized. 08:03:31 INFO - Running cycle 1/1 for kraken test... 08:03:31 INFO - TEST-INFO | started process 6652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxtBUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:43 INFO - PROCESS | 6652 | RSS: Main: 157581312 08:03:43 INFO - PROCESS | 6652 | 08:03:46 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58382/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:47 INFO - PROCESS | 6652 | RSS: Main: 213856256 08:03:47 INFO - PROCESS | 6652 | 08:03:50 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58382/tests/kraken/driver.html?testName=audio-dft) 08:03:50 INFO - PROCESS | 6652 | RSS: Main: 201547776 08:03:50 INFO - PROCESS | 6652 | 08:03:54 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58382/tests/kraken/driver.html?testName=audio-fft) 08:03:54 INFO - PROCESS | 6652 | RSS: Main: 270057472 08:03:54 INFO - PROCESS | 6652 | 08:03:56 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58382/tests/kraken/driver.html?testName=audio-oscillator) 08:03:57 INFO - PROCESS | 6652 | RSS: Main: 180326400 08:03:57 INFO - PROCESS | 6652 | 08:03:59 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58382/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:00 INFO - PROCESS | 6652 | RSS: Main: 184340480 08:04:00 INFO - PROCESS | 6652 | 08:04:03 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58382/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:04 INFO - PROCESS | 6652 | RSS: Main: 220282880 08:04:04 INFO - PROCESS | 6652 | 08:04:07 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58382/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:08 INFO - PROCESS | 6652 | RSS: Main: 216043520 08:04:08 INFO - PROCESS | 6652 | 08:04:11 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58382/tests/kraken/driver.html?testName=json-parse-financial) 08:04:11 INFO - PROCESS | 6652 | RSS: Main: 219226112 08:04:11 INFO - PROCESS | 6652 | 08:04:13 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58382/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:14 INFO - PROCESS | 6652 | RSS: Main: 209432576 08:04:14 INFO - PROCESS | 6652 | 08:04:15 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:16 INFO - PROCESS | 6652 | RSS: Main: 211623936 08:04:16 INFO - PROCESS | 6652 | 08:04:18 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:19 INFO - PROCESS | 6652 | RSS: Main: 216051712 08:04:19 INFO - PROCESS | 6652 | 08:04:22 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:22 INFO - PROCESS | 6652 | RSS: Main: 221626368 08:04:22 INFO - PROCESS | 6652 | 08:04:25 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:04:26 INFO - PROCESS | 6652 | RSS: Main: 221863936 08:04:26 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | Cycle 1(1): loaded http://localhost:58382/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58382/tests/kraken/driver.html?testName=ai-astar) 08:04:28 INFO - PROCESS | 6652 | RSS: Main: 264036352 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | __start_tp_report 08:04:28 INFO - PROCESS | 6652 | _x_x_mozilla_page_load 08:04:28 INFO - PROCESS | 6652 | _x_x_mozilla_page_load_details 08:04:28 INFO - PROCESS | 6652 | |i|pagename|runs| 08:04:28 INFO - PROCESS | 6652 | |0;ai-astar;114;111;112;112;111;112;112;113;111;113 08:04:28 INFO - PROCESS | 6652 | |1;audio-beat-detection;156;130;133;191;139;133;160;131;171;132 08:04:28 INFO - PROCESS | 6652 | |2;audio-dft;161;164;161;162;162;162;162;162;162;162 08:04:28 INFO - PROCESS | 6652 | |3;audio-fft;75;76;79;107;75;76;75;75;99;75 08:04:28 INFO - PROCESS | 6652 | |4;audio-oscillator;85;85;116;84;85;84;118;84;84;124 08:04:28 INFO - PROCESS | 6652 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;119;116;117 08:04:28 INFO - PROCESS | 6652 | |6;imaging-darkroom;147;146;147;146;146;145;147;147;146;146 08:04:28 INFO - PROCESS | 6652 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 08:04:28 INFO - PROCESS | 6652 | |8;json-parse-financial;65;64;65;64;66;65;66;64;66;65 08:04:28 INFO - PROCESS | 6652 | |9;json-stringify-tinderbox;64;66;65;65;67;64;64;64;64;66 08:04:28 INFO - PROCESS | 6652 | |10;stanford-crypto-aes;82;83;83;88;85;84;84;87;124;85 08:04:28 INFO - PROCESS | 6652 | |11;stanford-crypto-ccm;133;133;131;130;127;133;129;131;135;131 08:04:28 INFO - PROCESS | 6652 | |12;stanford-crypto-pbkdf2;169;167;167;171;166;165;166;167;170;166 08:04:28 INFO - PROCESS | 6652 | |13;stanford-crypto-sha256-iterative;66;65;66;66;66;66;67;69;65;65 08:04:28 INFO - PROCESS | 6652 | __end_tp_report 08:04:28 INFO - PROCESS | 6652 | __start_cc_report 08:04:28 INFO - PROCESS | 6652 | _x_x_mozilla_cycle_collect,1863 08:04:28 INFO - PROCESS | 6652 | __end_cc_report 08:04:28 INFO - PROCESS | 6652 | __startTimestamp1464793468260__endTimestamp 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | ------- Summary: start ------- 08:04:28 INFO - PROCESS | 6652 | Number of tests: 14 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:0.99 (0.9%) stddev-sans-first:0.78 08:04:28 INFO - PROCESS | 6652 | Values: 114.0 111.0 112.0 112.0 111.0 112.0 112.0 113.0 111.0 113.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:147.50 stddev:21.04 (14.3%) stddev-sans-first:22.10 08:04:28 INFO - PROCESS | 6652 | Values: 156.0 130.0 133.0 191.0 139.0 133.0 160.0 131.0 171.0 132.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 08:04:28 INFO - PROCESS | 6652 | Values: 161.0 164.0 161.0 162.0 162.0 162.0 162.0 162.0 162.0 162.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:11.71 (15.5%) stddev-sans-first:12.20 08:04:28 INFO - PROCESS | 6652 | Values: 75.0 76.0 79.0 107.0 75.0 76.0 75.0 75.0 99.0 75.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:16.98 (20.2%) stddev-sans-first:17.63 08:04:28 INFO - PROCESS | 6652 | Values: 85.0 85.0 116.0 84.0 85.0 84.0 118.0 84.0 84.0 124.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:04:28 INFO - PROCESS | 6652 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 117.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:04:28 INFO - PROCESS | 6652 | Values: 147.0 146.0 147.0 146.0 146.0 145.0 147.0 147.0 146.0 146.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:04:28 INFO - PROCESS | 6652 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:04:28 INFO - PROCESS | 6652 | Values: 65.0 64.0 65.0 64.0 66.0 65.0 66.0 64.0 66.0 65.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 08:04:28 INFO - PROCESS | 6652 | Values: 64.0 66.0 65.0 65.0 67.0 64.0 64.0 64.0 64.0 66.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:84.50 stddev:12.61 (14.9%) stddev-sans-first:13.15 08:04:28 INFO - PROCESS | 6652 | Values: 82.0 83.0 83.0 88.0 85.0 84.0 84.0 87.0 124.0 85.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:132.00 stddev:2.31 (1.8%) stddev-sans-first:2.37 08:04:28 INFO - PROCESS | 6652 | Values: 133.0 133.0 131.0 130.0 127.0 133.0 129.0 131.0 135.0 131.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.00 stddev:1.96 (1.2%) stddev-sans-first:1.99 08:04:28 INFO - PROCESS | 6652 | Values: 169.0 167.0 167.0 171.0 166.0 165.0 166.0 167.0 170.0 166.0 08:04:28 INFO - PROCESS | 6652 | 08:04:28 INFO - PROCESS | 6652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 08:04:28 INFO - PROCESS | 6652 | Values: 66.0 65.0 66.0 66.0 66.0 66.0 67.0 69.0 65.0 65.0 08:04:28 INFO - PROCESS | 6652 | -------- Summary: end -------- 08:04:28 INFO - PROCESS | 6652 | 08:04:29 INFO - TEST-INFO | 6652: exit 0 08:04:29 INFO - TEST-OK | kraken | took 63451ms 08:04:29 INFO - SUITE-END | took 1181s 08:04:29 INFO - Completed test suite (00:19:41) 08:04:29 INFO - javascript benchmark 08:04:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.8419694818313, 2633.9990803494675, 2634.3019099938506, 2654.2302732207672, 2673.879675414606, 4441.978344980656, 4529.501754806968, 4534.365188873556, 4587.472440669324, 4647.0, 4574.359589657451, 4611.400517932672, 4670.159371313162, 4702.482726900038, 4735.195016847136, 4231.957680423203, 4243.151369726052, 4375.256206444912, 4375.4093197418415, 4384.8026838792175, 4246.596573325544, 4283.571642835723, 4353.281708518107, 4373.322135069069, 4387.210302145629, 4318.805653745589, 4351.129774045188, 4379.868603941887, 4397.988462653591, 4408.97795511022, 4147.3778933159965, 4169.478815148106, 4264.189803937242, 4276.50820155683, 4306.095719898825, 4226.936595951063, 4228.598283163125, 4235.830566777326, 4253.1706317268145, 4281.186574550826, 4601.700889442175, 4607.516210797885, 4635.976820115878, 4641.559051890065, 4652.209124448852, 4792.041591681677, 4873.683210591335, 4942.802287908516, 4972.90054198914, 5030.8239211627415, 5022.598192144656, 5044.646874718771, 5081.0, 5081.339425874649, 5084.694918304914, 4721.008588196483, 4737.0, 4740.454847692559, 4742.217534106868, 4752.358431611758, 4959.603231741452, 5116.258142569307, 5168.224766285012, 5173.249878767558, 5200.76596553156, 4979.925301120486, 5008.373953255843, 5034.723090229999, 5034.748262586856, 5036.043151801146, 4834.903301933941, 5074.06129865976, 5076.314697515788, 5076.492350764894, 5119.129747942859, 4895.118878601886, 4915.606751459874, 4929.433115191727, 4941.827036053721, 4944.629152813553, 4920.065187614342, 4926.187179115477, 4934.407871055425, 4936.308916751657, 4994.825181118644, 4161.4382058421725, 4192.266353388145, 4240.151969606091, 4248.978755106266, 4296.505901821268, 3689.6679298862696, 3714.312852122312, 3719.237556300952, 3739.569949455793, 3769.133099387156, 4301.505326887448, 4322.783860806947, 4324.3513472978675, 4349.760763157993, 4355.477342718894, 4757.26262429324, 5008.69947803133, 5009.824656137018, 5011.749412529359, 5052.242163675478, 4273.700840941105, 4316.913661726748, 4350.390945267602, 4359.520452750195, 4365.825366985348, 4491.169133710274, 4494.77526123699, 4500.459944806578, 4518.231900576844, 4544.954550454519, 4581.289900065495, 4664.7667616618355, 4711.740854252912, 4720.0, 4720.598749106296, 4968.4286307075145, 4989.850304490871, 5000.499950004971, 5003.924941125959, 5051.696898186121, 4699.741514216751, 4714.764261786829, 4715.504871988392, 4718.433787945469, 4767.713937163781, 4810.5670489656095, 4888.242322440027, 4899.534544218293, 4922.040202160544, 4983.0, 4987.650864439454, 4991.5008499151245, 5007.198848184273, 5010.549050585465, 5057.115004874206, 4855.174620314484, 4873.780679869344, 4876.0, 4879.219324907997, 4929.06347793918, 4758.714477131383, 4778.617710583076, 4780.521947805191, 4802.591779698765, 4924.581410580141, 4773.307870358848, 4775.2359622460235, 4790.329353890388, 4814.325994360723, 4821.421429428491, 4833.73414462208, 4855.053264613366, 4869.196582563837, 4897.0, 4908.730019848943, 4658.743769092597, 4688.7890044948745, 4725.432948046119, 4776.904461910673, 4804.42346918372], "value": 4584.084567444205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9762412727587, 573.8049063318472, 588.8174665853583, 591.0956236957451, 593.5726277080503, 30032.249193770138, 30816.075517734447, 39444.60555394445, 40546.39180412296, 40566.188676226455, 41847.16305673885, 42400.0, 42526.574734252645, 42528.57471425285, 42579.0, 7563.584002879839, 7784.649690763901, 7793.064832220141, 7793.259640334188, 7795.493292935941, 7404.592747398891, 9936.254780891426, 10230.0, 10244.129249013842, 10585.947070264638, 10150.340227885164, 10262.230332725037, 10266.973302669749, 10277.280590358678, 10280.84578731316, 7423.665935032883, 7651.464397492177, 10084.94957525215, 10149.137323327526, 10153.543090560943, 7456.142543607501, 7525.4355923305975, 9894.257930655229, 10308.0, 10319.0, 35502.644973550196, 39912.0, 39969.80015099906, 39980.40029399561, 40042.599574004176, 2985.462616728988, 3077.522983937471, 3090.5209692497697, 3144.292534179814, 3563.9829246500444, 29343.0, 29582.112536623936, 29986.55020174699, 30654.846725766452, 30726.539101913488, 3494.318607871466, 3496.213351995806, 3506.2987402519598, 3522.4892390603477, 3536.4341705327024, 258767.0, 259196.0, 259943.0, 260052.0, 260160.0, 57692.711536442046, 58494.0, 58563.414365855795, 58615.41384586185, 58620.70689646524, 61131.0, 61425.69287153536, 61890.38109618936, 61917.69041154855, 61951.07073393903, 15136.621584460476, 15336.923315383576, 15338.693226135638, 15340.156291403857, 15346.923265383602, 9756.07317304855, 11155.27490713101, 11415.771684566262, 11432.657020289405, 11485.770284594428, 18987.525311867037, 19046.90476547636, 19197.808021919882, 19215.807841921403, 19260.22959081621, 6917.654117294115, 6939.687714052779, 6999.825004374931, 7087.89368159478, 7276.927230727731, 805.8025783683036, 963.629002833914, 1011.7774089700254, 1032.488917985602, 1036.9688909332733, 27843.582346264822, 27916.83538545335, 28127.296817579725, 28255.29361765972, 28356.71643283541, 965.8647789309503, 977.2816979520047, 981.2101258486844, 999.2305924438288, 1001.3291094966245, 13768.141300924448, 14439.711205776035, 14558.4904528341, 14586.0, 14674.33965471535, 367974.0, 370973.0, 371500.0, 371584.0, 372451.0, 48106.518934810905, 48709.756451217516, 48731.26903096456, 48750.0, 48767.0, 1184.3721365488461, 1204.8855358740905, 1217.2331431198465, 1219.061322781471, 1242.683115805482, 23594.410139746644, 24585.63121553214, 28306.57540136941, 29356.0, 29972.550411744276, 47797.0, 48873.511264886896, 48883.511164887896, 48886.75556622194, 48900.0, 354821.0, 360289.0, 363918.0, 364498.0, 364751.0, 32070.83964580162, 32629.0, 38752.0, 39123.21753564856, 39652.20695586014, 42071.57928420677, 42506.36240456334, 42909.54274353877, 43145.0, 43422.78288608663, 35959.46060809142, 36355.0, 36849.263014739015, 36918.63081369152, 37442.43836342511, 35897.46153807643, 35920.64079359278, 35930.0, 35930.4610430849, 35987.280254394245, 35087.0, 35843.82078089593, 35887.0, 36207.0, 36251.45622815713, 31285.0, 32846.835765821015, 32886.83556582202, 32947.17632059122, 33102.33795324032, 24889.37776555528, 25005.249842504752, 25283.620745689197, 25515.744842552078, 25590.87204563965], "value": 18467.120740343165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8434057695769, 377.6487866284355, 378.9071677439026, 390.8534299637636, 393.09195757799466, 15789.36842526299, 16083.437079702198, 16948.322067117333, 16966.830331696678, 16975.91512042438, 10376.325538839988, 10521.053105220528, 10532.315399499028, 10536.104431123345, 10538.209634277422, 4560.270356742922, 4696.835610753625, 4747.382840230765, 5149.716765577892, 5150.793968241266, 4977.8257760978195, 5096.668716533432, 5102.515261050213, 5102.872428189288, 5111.412187598418, 5071.0, 5087.364079490064, 5089.847304580869, 5251.973740131294, 5570.136628822539, 5561.555075593943, 5566.916496252559, 5595.160725891108, 5601.551875849922, 5606.747696353654, 5259.500347466985, 5447.073997420448, 5505.972470137664, 5506.146547285177, 5525.834224973257, 12440.0, 12519.93740031303, 12550.309732964683, 13338.799918001238, 19849.9007504963, 1819.3177558415593, 1920.9231630734753, 1936.4093951344835, 2332.416895776056, 2393.628987506939, 9075.500847453388, 9583.137517623447, 9781.364211326312, 10252.74368140795, 13610.86389136106, 1754.3070487157502, 1755.1224387806096, 1769.2392271323326, 1770.0618672103806, 1848.1036697201846, 67840.32159678389, 68304.0, 68584.6570767143, 69180.6540967292, 69429.30570694279, 10170.949145254226, 10174.796504070026, 10186.286959912883, 10240.948795255976, 10413.843792343121, 13859.722805543832, 13887.888968882466, 13913.0, 13913.58259252224, 13922.37349319283, 7139.92860071403, 7162.534435261691, 7223.89164162538, 7307.707691692272, 7338.853222935618, 6623.701933413008, 6672.5996440212775, 6744.6627668616375, 6815.931840681629, 6834.829129271808, 4345.261305578059, 4399.6920215584605, 4415.66882483815, 4424.0709451015, 4447.066116115588, 1704.8977061376356, 1805.2778888444464, 1839.5860931290354, 1897.468708761549, 1898.6582415165126, 768.7847402727245, 829.788403956987, 860.350435421253, 909.4316052467208, 913.7304495173939, 15619.219039048003, 16324.34702611906, 16559.91720041392, 16728.0, 17000.82999170017, 821.5399376349263, 838.3502785341409, 841.9115992820788, 852.5694524265331, 869.2871845086968, 9077.909220907839, 9273.211776998896, 9297.628094876129, 9360.391574547768, 9702.175315098155, 399272.0, 399758.0, 401923.0, 402820.0, 406892.0, 43934.34098488525, 53578.660533486975, 59793.0, 72535.0, 74835.25164748392, 917.6008436330218, 921.1571412157934, 929.4098247612815, 950.4582388038751, 951.7240000399806, 14808.59402337447, 14906.25468726581, 14934.286155055586, 15100.471483498024, 15105.39578416851, 32637.836810816745, 33739.325213496086, 34209.31581368409, 34319.31361372808, 35598.64401355953, 42108.789456052524, 46380.7680961593, 46702.29946550736, 47268.29097563608, 47271.0, 6795.830104247433, 6836.487263455161, 6845.5550389224545, 6887.311268873273, 7073.257307982588, 6665.766698165541, 6879.759208427681, 9431.858522122036, 10396.272260941661, 10513.57945682164, 8960.417572857743, 9206.769830754285, 9449.574769135268, 9461.574229159567, 9504.334696571173, 9223.354365194373, 9236.769080773034, 9255.629774809202, 9321.114494123047, 9501.667441639509, 9084.454932704059, 9165.679201227926, 9246.445213287225, 9265.027172146827, 9395.154436100784, 6394.200724909387, 6787.185537735503, 6792.592444453348, 6877.793666190022, 6938.5836849789175, 7174.964125179341, 8570.957145214234, 9174.08259174104, 9265.86101208469, 9297.6280948764], "value": 7728.33499409559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.3293688471338, 1354.3499120422198, 1422.1680317014545, 1477.8817694584434, 1709.3846215362476, 6417.839554011146, 7280.635968201588, 7424.294692004251, 7491.8876216856725, 7697.2687594678555, 7538.81152971176, 7643.46495745298, 7652.770416887488, 7673.424493163007, 7700.383969282458, 2199.472126689595, 2220.7002054722566, 2220.85564438311, 2225.276785044859, 2226.065052677871, 2153.881536515491, 2163.7728038555883, 2204.0853045985896, 2204.9228277010307, 2209.635410157322, 2138.123369418539, 2142.657174852024, 2144.517483566193, 2146.9355919322365, 2193.7367515898036, 2101.2750601042617, 2108.2410332280365, 2112.86266392684, 2115.7038014677955, 2116.3016204652504, 2089.3523007867457, 2136.327056977063, 2138.262299506683, 2139.358192542231, 2144.0351841671154, 7446.218147094532, 7497.887531687029, 7502.324790768803, 7503.549787012742, 7683.884741728879, 4464.1071785643, 4567.794449249758, 4568.817247310104, 4569.04050149469, 4598.563136502027, 2882.351470919047, 3003.309238875071, 3026.969730302691, 3033.347830216492, 3037.088873338012, 947.6967370441462, 950.7005293332578, 956.1633570625703, 956.3401253135314, 970.0832713086137, 10311.690649280534, 10334.276600637959, 10342.84485732707, 10343.534540945675, 10396.688099357032, 4162.4796900387455, 4180.665546756252, 4215.367694845798, 4333.71830830995, 4340.47914250292, 8149.633266503021, 8166.510009399455, 8169.42814003026, 8174.877376839352, 8188.795280117925, 4488.169688607618, 4488.708233964782, 4488.798004089824, 4491.05687805558, 4530.048689775184, 3619.7285203609836, 3712.5730540987593, 4193.853215137456, 4212.789360531961, 4214.726042807269, 3625.6041424051405, 3746.438034294823, 3750.6999440044733, 3798.1264309209037, 3799.3161230978135, 1187.352892673495, 1205.5539450403407, 1210.667066556704, 1218.2994778002683, 1223.5472875036294, 725.8729722298576, 855.5209082913589, 860.714055520026, 868.6308318964541, 879.2394578689515, 5053.898922021613, 5117.744112794346, 5174.239148263538, 5275.419703832576, 5321.600879934021, 428.55644408037534, 433.68124428544996, 438.8815019944597, 439.92081425343747, 443.3748414735208, 3519.1729943463265, 3559.323728491578, 3563.893083207508, 3587.7488575799443, 3620.2035552178477, 9279.0, 9409.435433873989, 9538.856917146248, 9558.28312876537, 9598.088181622734, 9287.164155225926, 9333.673321433716, 9333.719988400358, 9360.719178424659, 9364.20404265645, 7119.110111236096, 7230.457715671346, 7306.780796576111, 7316.487845850846, 7321.121465424077, 5258.106121959199, 5274.077036518517, 5285.920711189258, 5333.493318134771, 5377.569794416359, 8553.144685531397, 8789.077146899483, 8798.252148567444, 8809.07504711996, 8878.778030549289, 8520.957395212985, 8909.198172164537, 9032.86450703227, 9042.638294468148, 9051.14014168653, 5907.113932910098, 5960.403959604005, 6024.487918526975, 6516.57642253252, 6700.93299067003, 7322.524035937647, 7325.413966882743, 7403.888941665771, 7405.259474052552, 7408.851822963618, 6576.901346479903, 6676.232233293039, 6699.631520266432, 6797.796066118024, 6799.490038247052, 6613.636250006296, 6647.401733843977, 6680.899786503109, 6769.526133170631, 6778.0, 6135.9079613806725, 6175.413335733098, 6195.783147589813, 6200.038993955944, 6218.782342617987, 4443.533428989909, 4451.977740111279, 4470.8435204767675, 4584.908301834012, 4588.839390621312, 4479.977600111979, 4510.075434535978, 4549.818007279804, 4551.65862560316, 4695.272232803921], "value": 4008.3759054575853, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5937844841791, 301.08019998903353, 305.3816022554327, 311.32442599558954, 314.05156427588685, 4752.762361881905, 4776.880577985552, 4799.68802027868, 4800.687955282904, 4828.903421931559, 4705.564802735164, 4727.929081063787, 4730.408698912636, 4750.7862146203415, 4757.238841785315, 3763.7177211709095, 3783.375743002415, 3790.1472168761948, 3796.6013568575318, 3823.483829682985, 3517.9120521986897, 3732.4961130247475, 3821.407681809324, 3825.1775868188333, 3830.5020347354803, 3663.5970043295215, 3696.7781933083966, 3702.500162478071, 3705.981470092646, 3710.907227319325, 3685.4471829225563, 3693.741438099334, 3702.574203966538, 3703.944375852869, 3724.3296206682785, 3089.2431354318337, 3166.857491412892, 3172.587563616715, 3240.0603824890754, 3292.1440425489304, 4524.0, 4531.614812740921, 4556.382484218088, 4567.314902764579, 4574.61115805157, 4232.9153416931795, 4236.195122926634, 4236.682248831319, 4248.808803603845, 4254.489461264637, 4726.787294571753, 4791.0, 4975.487378873682, 4999.875003124915, 5001.574866136347, 3525.11872031992, 3531.9823400882833, 3540.716742660581, 3540.8760693375866, 3550.254446566224, 5193.169092945111, 5217.069684216826, 5236.7119808410525, 5243.112479507375, 5251.369835619712, 3392.5928888533535, 3565.4668492547935, 3587.4260118380935, 3622.710183185339, 3660.304542137039, 3587.712982961357, 3592.892213233607, 3594.694450971697, 3607.549056367954, 3629.3467175908063, 4137.97931010343, 4163.687723420756, 4168.458100446983, 4175.6868234881895, 4179.874603761892, 4878.0001296544315, 4958.6776859504735, 4973.47778483254, 4980.402351717817, 4992.425871024806, 1252.405107573895, 1271.319843883518, 1275.1329096214479, 1275.993620031894, 1277.757226127033, 797.5135167547792, 806.4435539477741, 824.9670013199525, 827.1025936858456, 827.4042689263721, 3984.900377490586, 4006.49756341372, 4016.5339651027166, 4042.3330150524835, 4056.9594304057173, 4529.977350113229, 4661.813527458864, 4665.393498845128, 4667.159911216014, 4680.391549098664, 3944.2703099926607, 3963.365861462152, 3974.463447434617, 3996.3805610130476, 4021.0, 2309.168699268262, 2434.6469761884427, 2468.0991438124956, 2621.279148234251, 2692.7845772338164, 4836.250381190921, 4843.370361852936, 4863.9513604864205, 4870.512948705101, 4873.31773551703, 5253.921191182136, 5267.894642107136, 5281.39263984639, 5281.419043905167, 5286.20706893969, 4635.443746750411, 4834.226523756252, 4861.343718597944, 4881.8771682513225, 4914.262860570943, 5116.360454943132, 5120.641555091257, 5145.87135321605, 5153.0, 5175.249588809676, 5068.797248110034, 5075.28945947575, 5084.440711521655, 5105.642605017613, 5124.872528043825, 4773.546513081252, 4833.845804563368, 4898.853034408973, 4913.950860491349, 4931.876703082452, 3593.173570078844, 3610.963890361168, 3620.6741393274733, 3624.4019736743144, 3688.262347530451, 5120.590352771844, 5136.589072874236, 5177.171652535576, 5187.662801917863, 5245.0558899398475, 4743.715377077387, 4964.957358954515, 5027.924581131213, 5038.823641172541, 5041.924371134362, 4981.178105612678, 4989.426215985208, 5014.222795466709, 5045.722485263345, 5054.140796064605, 4899.387576552931, 4909.9018019640125, 4919.385076865392, 4939.16034274167, 4992.15133427311, 4787.880302992453, 5023.216758050839, 5026.949730502648, 5046.520580544842, 5062.493750624908, 4929.802807887644, 4938.08645400602, 4940.419065898878, 4946.826861059845, 4977.352944117241], "value": 3720.1381857987653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.3143131143611, 670.8557660103077, 695.2144077192771, 731.8755811512043, 765.2232983521725, 11318.660440186797, 11390.715232119192, 11412.31526108434, 12259.387030648455, 12277.631671049861, 11724.0, 11823.408829558532, 11951.342676152808, 11953.880461195386, 12000.579979700691, 628.597697473615, 761.0866959648416, 783.6786917363868, 797.4736673795296, 798.2137594469443, 792.065362871811, 798.1778767869104, 798.6006996501749, 799.3764863406552, 800.5476905548376, 823.9011318641772, 825.4015838517087, 826.2563692676579, 829.0424559633602, 829.2619568583965, 653.7711800869705, 781.4022272961189, 806.8265322955534, 822.2394285286116, 823.2549542663899, 592.2330581896455, 592.3543337761861, 592.9288485381738, 593.3087952535291, 593.8426317025992, 11479.311241325464, 11550.191486595942, 11559.364234967074, 11562.826557601642, 11645.243059201124, 11509.884901151048, 11530.135239857043, 11766.294022358601, 12155.939220303842, 12247.081468889868, 11019.559217631286, 11059.834102488468, 11229.887701122965, 11293.774124517464, 11327.0, 4037.9798101009305, 4055.3105971984537, 4169.97915010423, 4217.177650358181, 4292.1415716856445, 46199.30701039487, 46525.0, 46664.76667616674, 46679.53320466786, 47179.76410117927, 9377.812443751223, 9688.951555242178, 9961.950190249147, 10246.692599222035, 10264.0, 16717.749233761504, 16844.157792110345, 16846.157692115346, 16849.831501685072, 16869.24088416024, 6247.0629405589525, 6349.142865713162, 6426.550141490145, 6499.707513161919, 6528.249251336062, 3466.774659647165, 3533.717302615836, 3579.319929213441, 3597.748157628941, 3651.123730304708, 2757.7518023377593, 2857.4285142971075, 2860.17055054032, 2860.442213768295, 2863.8138520996067, 520.9218617207449, 527.6754795800632, 528.6405244433745, 530.8487081181922, 552.4972275229521, 494.3968358602499, 603.770567184467, 625.7121724007008, 636.5544119116637, 642.6690254518926, 7744.690212391554, 7847.372210223282, 7851.136374998746, 7888.842223155505, 8122.634481448349, 467.81988934259874, 485.907677541266, 621.0994058615026, 629.3580547841176, 632.9746810127543, 3873.86441474547, 3914.451976723261, 3931.0761970936805, 3982.203559288154, 4071.9389209161886, 54971.72514137404, 56807.43192568104, 56830.147547786815, 57070.143947840814, 57074.42925570691, 48280.517194827604, 49151.50848491541, 49531.75234123806, 51366.22950655743, 51621.22568161481, 41339.58660413417, 42023.369649455286, 46589.0, 47231.5276847234, 47258.52741472541, 8491.575421229038, 8500.957495212484, 8575.228229459379, 8659.13408659129, 8749.606267717842, 30241.243968900955, 30539.694603053686, 30577.54133687952, 31168.688313116578, 31690.683093168773, 37623.43564846475, 40669.38995915123, 40926.0, 41168.0, 41576.466000390305, 10437.225671635688, 10763.46182690878, 10836.738142813194, 10888.836667449836, 10900.836487452536, 11752.294862308288, 11971.521139154685, 12119.091068170099, 12189.268643881396, 12493.812592811297, 11361.772764544829, 11670.88329116698, 11867.287962722265, 12001.219920705125, 12283.38583070825, 11443.0, 11806.409679515818, 11908.40457977115, 11938.22401543897, 12313.56902508408, 11217.60738374153, 11517.25137866036, 11646.359450230319, 11905.583304584645, 11912.583059592873, 9590.904090959, 9780.657676981271, 9848.409095454295, 9887.505624718879, 10236.283460158016, 9433.7830609808, 9644.95177524108, 10222.233332500242, 10228.53971571296, 10268.127209187303], "value": 6022.273364836401, "unit": "score"}], "name": "dromaeo_css", "value": 6235.145253484661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 111.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 133.0, 191.0, 139.0, 133.0, 160.0, 131.0, 171.0, 132.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 107.0, 75.0, 76.0, 75.0, 75.0, 99.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 84.0, 85.0, 84.0, 118.0, 84.0, 84.0, 124.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 66.0, 64.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 67.0, 64.0, 64.0, 64.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 88.0, 85.0, 84.0, 84.0, 87.0, 124.0, 85.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 131.0, 130.0, 127.0, 133.0, 129.0, 131.0, 135.0, 131.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 167.0, 171.0, 166.0, 165.0, 166.0, 167.0, 170.0, 166.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 69.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1539.1999999999998, "alertThreshold": 2.0}]} 08:04:29 INFO - Return code: 0 08:04:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:04:29 ERROR - # TBPL SUCCESS # 08:04:29 INFO - Running post-action listener: _resource_record_post_action 08:04:29 INFO - ##### 08:04:29 INFO - ##### Finished run-tests step (success) 08:04:29 INFO - ##### 08:04:29 INFO - Running post-run listener: _resource_record_post_run 08:04:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 530313216; Read time: 0; Write time: 483708 08:04:29 INFO - TinderboxPrint: CPU usage
13.1% 08:04:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:04:29 INFO - TinderboxPrint: I/O write bytes / time
530,313,216 / 483,708 08:04:29 INFO - TinderboxPrint: CPU idle
8,313.1 (86.9%) 08:04:29 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 08:04:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:04:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244822016; Read time: 0; Write time: 276044 08:04:29 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 285491200; Read time: 0; Write time: 207664 08:04:30 INFO - Running post-run listener: _upload_blobber_files 08:04:30 INFO - Blob upload gear active. 08:04:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:04:30 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 08:04:30 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'] 08:04:30 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 08:04:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:31 INFO - (blobuploader) - INFO - Done attempting. 08:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:04:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:32 INFO - (blobuploader) - INFO - Done attempting. 08:04:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:04:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:04:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:04:36 INFO - (blobuploader) - INFO - Done attempting. 08:04:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:04:36 INFO - Return code: 0 08:04:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:04:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:04:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b12c3a99d1cc7cfe7be6eae3fc78940e04eefdeb86486d8673f45989c2856d80a87ede3bfc07bf4348f860b8c8a3ca767b116511471a0189ad68f9016f463e3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8888552f56f1dfa695d4eb371d8e5a681f5557ea8dbaca77037bdb8cf1a7515c4b6030640f1455610d67b2c9175d0a5c30bf7e1d3025bda6acfb4197f84aa21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48623d333f2222e3d282ce9b52a27ffe8069a0bcc5b0756bb44b79161a306cca23df936d24dbf4dc8a542a10cc8025660b8ab5f9ede10c4a816c2bfe71aad500"} 08:04:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:04:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:04:36 INFO - Contents: 08:04:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b12c3a99d1cc7cfe7be6eae3fc78940e04eefdeb86486d8673f45989c2856d80a87ede3bfc07bf4348f860b8c8a3ca767b116511471a0189ad68f9016f463e3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8888552f56f1dfa695d4eb371d8e5a681f5557ea8dbaca77037bdb8cf1a7515c4b6030640f1455610d67b2c9175d0a5c30bf7e1d3025bda6acfb4197f84aa21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48623d333f2222e3d282ce9b52a27ffe8069a0bcc5b0756bb44b79161a306cca23df936d24dbf4dc8a542a10cc8025660b8ab5f9ede10c4a816c2bfe71aad500"} 08:04:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:04:36 INFO - Copying logs to upload dir... 08:04:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:04:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.486392 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-01 08:04:36.193251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:04:36.197084) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 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/b12c3a99d1cc7cfe7be6eae3fc78940e04eefdeb86486d8673f45989c2856d80a87ede3bfc07bf4348f860b8c8a3ca767b116511471a0189ad68f9016f463e3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8888552f56f1dfa695d4eb371d8e5a681f5557ea8dbaca77037bdb8cf1a7515c4b6030640f1455610d67b2c9175d0a5c30bf7e1d3025bda6acfb4197f84aa21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48623d333f2222e3d282ce9b52a27ffe8069a0bcc5b0756bb44b79161a306cca23df936d24dbf4dc8a542a10cc8025660b8ab5f9ede10c4a816c2bfe71aad500"} build_url:https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/LsKxW3EiQ5SsozpwHy3IFA/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/b12c3a99d1cc7cfe7be6eae3fc78940e04eefdeb86486d8673f45989c2856d80a87ede3bfc07bf4348f860b8c8a3ca767b116511471a0189ad68f9016f463e3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8888552f56f1dfa695d4eb371d8e5a681f5557ea8dbaca77037bdb8cf1a7515c4b6030640f1455610d67b2c9175d0a5c30bf7e1d3025bda6acfb4197f84aa21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48623d333f2222e3d282ce9b52a27ffe8069a0bcc5b0756bb44b79161a306cca23df936d24dbf4dc8a542a10cc8025660b8ab5f9ede10c4a816c2bfe71aad500"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 08:04:36.221972) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:04:36.222285) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464792233.332455-799232383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 08:04:36.310212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:04:36.310935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 08:04:36.311513) ========= ========= Total master_lag: 0.17 =========