builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1463677712.84 results: success (0) buildid: 20160519073110 builduid: 2da991ffcb3741159aebddd95851704c revision: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:32.838786) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:32.839744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:32.840344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:32.880907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:32.881315) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 10:08:33-- 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% 87.1K=0.1s 2016-05-19 10:08:33 (87.1 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.274975 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:33.211337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:33.211862) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084605 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:33.315432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:33.315989) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 --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 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 --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=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 10:08:33,439 truncating revision to first 12 chars 2016-05-19 10:08:33,439 Setting DEBUG logging. 2016-05-19 10:08:33,439 attempt 1/10 2016-05-19 10:08:33,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a4cdb6dfb19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 10:08:33,844 unpacking tar archive at: mozilla-central-5a4cdb6dfb19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:34.004151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:34.004506) ========= script_repo_revision: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:34.004990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:34.005268) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:08:34.019332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-19 10:08:34.019771) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:34 INFO - MultiFileLogger online at 20160519 10:08:34 in /builds/slave/test 10:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:34 INFO - {'append_to_log': False, 10:08:34 INFO - 'base_work_dir': '/builds/slave/test', 10:08:34 INFO - 'blob_upload_branch': 'Firefox', 10:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:34 INFO - 'branch': 'Firefox', 10:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:34 INFO - 'config_files': ('talos/linux_config.py',), 10:08:34 INFO - 'default_actions': ('clobber', 10:08:34 INFO - 'read-buildbot-config', 10:08:34 INFO - 'download-and-extract', 10:08:34 INFO - 'populate-webroot', 10:08:34 INFO - 'create-virtualenv', 10:08:34 INFO - 'install', 10:08:34 INFO - 'run-tests'), 10:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:34 INFO - 'download_minidump_stackwalk': True, 10:08:34 INFO - 'download_symbols': 'ondemand', 10:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:34 INFO - 'installer_path': 'installer.exe', 10:08:34 INFO - 'log_level': 'info', 10:08:34 INFO - 'log_name': 'talos', 10:08:34 INFO - 'log_to_console': True, 10:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:34 INFO - 'opt_config_files': (), 10:08:34 INFO - 'pip_index': False, 10:08:34 INFO - 'sps_profile': False, 10:08:34 INFO - 'sps_profile_interval': 0, 10:08:34 INFO - 'suite': 'dromaeojs-e10s', 10:08:34 INFO - 'system_bits': '32', 10:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:34 INFO - 'title': 'talos-linux64-ix-030', 10:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:34 INFO - 'use_talos_json': True, 10:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:34 INFO - 'work_dir': 'build'} 10:08:34 INFO - ##### 10:08:34 INFO - ##### Running clobber step. 10:08:34 INFO - ##### 10:08:34 INFO - Running pre-action listener: _resource_record_pre_action 10:08:34 INFO - Running main action method: clobber 10:08:34 INFO - rmtree: /builds/slave/test/build 10:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:35 INFO - Running post-action listener: _resource_record_post_action 10:08:35 INFO - ##### 10:08:35 INFO - ##### Finished clobber step (success) 10:08:35 INFO - ##### 10:08:35 INFO - ##### 10:08:35 INFO - ##### Running read-buildbot-config step. 10:08:35 INFO - ##### 10:08:35 INFO - Running pre-action listener: _resource_record_pre_action 10:08:35 INFO - Running main action method: read_buildbot_config 10:08:35 INFO - Using buildbot properties: 10:08:35 INFO - { 10:08:35 INFO - "project": "", 10:08:35 INFO - "product": "firefox", 10:08:35 INFO - "script_repo_revision": "production", 10:08:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:08:35 INFO - "repository": "", 10:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:08:35 INFO - "buildid": "20160519073110", 10:08:35 INFO - "pgo_build": "True", 10:08:35 INFO - "basedir": "/builds/slave/test", 10:08:35 INFO - "buildnumber": 37, 10:08:35 INFO - "slavename": "talos-linux64-ix-030", 10:08:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:08:35 INFO - "platform": "ubuntu64_hw", 10:08:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:08:35 INFO - "branch": "mozilla-central", 10:08:35 INFO - "repo_path": "mozilla-central", 10:08:35 INFO - "revision": "5a4cdb6dfb19b458229c60e0e19f083ba83d0f58", 10:08:35 INFO - "stage_platform": "linux64-pgo", 10:08:35 INFO - "builduid": "2da991ffcb3741159aebddd95851704c", 10:08:35 INFO - "slavebuilddir": "test" 10:08:35 INFO - } 10:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:08:35 INFO - Running post-action listener: _resource_record_post_action 10:08:35 INFO - ##### 10:08:35 INFO - ##### Finished read-buildbot-config step (success) 10:08:35 INFO - ##### 10:08:35 INFO - ##### 10:08:35 INFO - ##### Running download-and-extract step. 10:08:35 INFO - ##### 10:08:35 INFO - Running pre-action listener: _resource_record_pre_action 10:08:35 INFO - Running main action method: download_and_extract 10:08:35 INFO - mkdir: /builds/slave/test/build/tests 10:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:35 INFO - https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:36 INFO - Downloaded 1361 bytes. 10:08:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:08:36 INFO - Using the following test package requirements: 10:08:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:08:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'jsshell-linux-x86_64.zip'], 10:08:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:08:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:08:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:36 INFO - https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:37 INFO - Downloaded 24386692 bytes. 10:08:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:08:38 INFO - Return code: 0 10:08:38 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 10:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:38 INFO - https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:42 INFO - Downloaded 24386692 bytes. 10:08:42 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'] 10:08:42 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 10:08:44 INFO - Return code: 0 10:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:44 INFO - https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:45 INFO - Downloaded 10840194 bytes. 10:08:45 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'] 10:08:45 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 10:08:45 INFO - Return code: 0 10:08:45 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')]} 10:08:45 INFO - https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:08:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dSaXlhBUShSBevz3dtgmVA/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 10:08:47 INFO - Downloaded 58425050 bytes. 10:08:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:47 INFO - mkdir: /builds/slave/test/properties 10:08:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:47 INFO - Contents: 10:08:47 INFO - build_url:https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:08:47 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 10:08:47 WARNING - Traceback (most recent call last): 10:08:47 WARNING - 10:08:47 WARNING - File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 200, in query_symbols_url 10:08:47 WARNING - self._urlopen(symbols_url, timeout=120) 10:08:47 WARNING - 10:08:47 WARNING - File "/builds/slave/test/scripts/mozharness/mozilla/testing/testbase.py", line 292, in _urlopen 10:08:47 WARNING - return urllib2.urlopen(url, **kwargs) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 126, in urlopen 10:08:47 WARNING - return _opener.open(url, data, timeout) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 406, in open 10:08:47 WARNING - response = meth(req, response) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 519, in http_response 10:08:47 WARNING - 'http', request, response, code, msg, hdrs) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 438, in error 10:08:47 WARNING - result = self._call_chain(*args) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain 10:08:47 WARNING - result = func(*args) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 625, in http_error_302 10:08:47 WARNING - return self.parent.open(new, timeout=req.timeout) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 406, in open 10:08:47 WARNING - response = meth(req, response) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 519, in http_response 10:08:47 WARNING - 'http', request, response, code, msg, hdrs) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 444, in error 10:08:47 WARNING - return self._call_chain(*args) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain 10:08:47 WARNING - result = func(*args) 10:08:47 WARNING - 10:08:47 WARNING - File "/usr/lib/python2.7/urllib2.py", line 527, in http_error_default 10:08:47 WARNING - raise HTTPError(req.get_full_url(), code, msg, hdrs, fp) 10:08:47 WARNING - 10:08:47 WARNING - HTTPError: HTTP Error 503: Service Unavailable 10:08:47 WARNING - 10:08:47 WARNING - No symbols_url found. Let minidump_stackwalk query for symbols. 10:08:47 INFO - Running post-action listener: _resource_record_post_action 10:08:47 INFO - Running post-action listener: set_extra_try_arguments 10:08:47 INFO - ##### 10:08:47 INFO - ##### Finished download-and-extract step (success) 10:08:47 INFO - ##### 10:08:47 INFO - ##### 10:08:47 INFO - ##### Running populate-webroot step. 10:08:47 INFO - ##### 10:08:47 INFO - Running pre-action listener: _resource_record_pre_action 10:08:47 INFO - Running main action method: populate_webroot 10:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:48 INFO - '--tppagecycles', 10:08:48 INFO - '7'], 10:08:48 INFO - 'tests': ['tsvgm']}}, 10:08:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['damp', 'tps']}, 10:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'tests': ['damp', 'tps']}, 10:08:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['dromaeo_dom']}, 10:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['a11yr', 10:08:48 INFO - 'ts_paint', 10:08:48 INFO - 'tpaint', 10:08:48 INFO - 'sessionrestore', 10:08:48 INFO - 'sessionrestore_no_auto_restore', 10:08:48 INFO - 'tabpaint']}, 10:08:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['tsvgx', 10:08:48 INFO - 'tsvgr_opacity', 10:08:48 INFO - 'tart', 10:08:48 INFO - 'tscrollx', 10:08:48 INFO - 'cart']}, 10:08:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:48 INFO - 'tsvgr_opacity', 10:08:48 INFO - 'tart', 10:08:48 INFO - 'tscrollx', 10:08:48 INFO - 'cart']}, 10:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'talos_options': ['--disable-e10s'], 10:08:48 INFO - 'tests': ['tp5o']}, 10:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'tests': ['tp5o']}, 10:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'talos_options': ['--disable-e10s', 10:08:48 INFO - '--xperf_path', 10:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:48 INFO - 'tests': ['tp5n']}, 10:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:48 INFO - 'talos_options': ['--xperf_path', 10:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:48 INFO - 'tests': ['tp5n']}}, 10:08:48 INFO - 'talos.zip': {'path': '', 10:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:48 INFO - Running post-action listener: _resource_record_post_action 10:08:48 INFO - ##### 10:08:48 INFO - ##### Finished populate-webroot step (success) 10:08:48 INFO - ##### 10:08:48 INFO - ##### 10:08:48 INFO - ##### Running create-virtualenv step. 10:08:48 INFO - ##### 10:08:48 INFO - Running pre-action listener: _resource_record_pre_action 10:08:48 INFO - Running main action method: create_virtualenv 10:08:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:48 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 10:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:48 INFO - Using real prefix '/usr' 10:08:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:50 INFO - Installing pip.................done. 10:08:50 INFO - Return code: 0 10:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:50 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')]} 10:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:50 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')]} 10:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:50 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:08:50 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 10:08:50 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 10:08:50 INFO - Using env: {'DISPLAY': ':0', 10:08:50 INFO - 'HOME': '/home/cltbld', 10:08:50 INFO - 'LANG': 'en_US.UTF-8', 10:08:50 INFO - 'LANGUAGE': 'en_US:en', 10:08:50 INFO - 'LOGNAME': 'cltbld', 10:08:50 INFO - 'MAIL': '/var/mail/cltbld', 10:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:50 INFO - 'MOZ_NO_REMOTE': '1', 10:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:50 INFO - 'NO_EM_RESTART': '1', 10:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:50 INFO - 'PWD': '/builds/slave/test', 10:08:50 INFO - 'SHELL': '/bin/bash', 10:08:50 INFO - 'SHLVL': '1', 10:08:50 INFO - 'TERM': 'linux', 10:08:50 INFO - 'TMOUT': '86400', 10:08:50 INFO - 'USER': 'cltbld', 10:08:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:50 INFO - '_': '/tools/buildbot/bin/python'} 10:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:51 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 10:08:51 INFO - Cleaning up... 10:08:51 INFO - Return code: 0 10:08:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:51 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')]} 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 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')]} 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:08:51 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 10:08:51 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 10:08:51 INFO - Using env: {'DISPLAY': ':0', 10:08:51 INFO - 'HOME': '/home/cltbld', 10:08:51 INFO - 'LANG': 'en_US.UTF-8', 10:08:51 INFO - 'LANGUAGE': 'en_US:en', 10:08:51 INFO - 'LOGNAME': 'cltbld', 10:08:51 INFO - 'MAIL': '/var/mail/cltbld', 10:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:51 INFO - 'MOZ_NO_REMOTE': '1', 10:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:51 INFO - 'NO_EM_RESTART': '1', 10:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:51 INFO - 'PWD': '/builds/slave/test', 10:08:51 INFO - 'SHELL': '/bin/bash', 10:08:51 INFO - 'SHLVL': '1', 10:08:51 INFO - 'TERM': 'linux', 10:08:51 INFO - 'TMOUT': '86400', 10:08:51 INFO - 'USER': 'cltbld', 10:08:51 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:51 INFO - '_': '/tools/buildbot/bin/python'} 10:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:51 INFO - Downloading/unpacking psutil>=3.1.1 10:08:51 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 10:08:51 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 10:08:51 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 10:08:51 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 10:08:51 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 10:08:51 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 10:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:53 INFO - Installing collected packages: psutil 10:08:53 INFO - Running setup.py install for psutil 10:08:53 INFO - building 'psutil._psutil_linux' extension 10:08:53 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 10:08:54 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 10:08:54 INFO - building 'psutil._psutil_posix' extension 10:08:54 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 10:08:54 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 10:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:55 INFO - Successfully installed psutil 10:08:55 INFO - Cleaning up... 10:08:55 INFO - Return code: 0 10:08:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08:55 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')]} 10:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:55 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')]} 10:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:55 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:08:55 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 10:08:55 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 10:08:55 INFO - Using env: {'DISPLAY': ':0', 10:08:55 INFO - 'HOME': '/home/cltbld', 10:08:55 INFO - 'LANG': 'en_US.UTF-8', 10:08:55 INFO - 'LANGUAGE': 'en_US:en', 10:08:55 INFO - 'LOGNAME': 'cltbld', 10:08:55 INFO - 'MAIL': '/var/mail/cltbld', 10:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:55 INFO - 'MOZ_NO_REMOTE': '1', 10:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:55 INFO - 'NO_EM_RESTART': '1', 10:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:55 INFO - 'PWD': '/builds/slave/test', 10:08:55 INFO - 'SHELL': '/bin/bash', 10:08:55 INFO - 'SHLVL': '1', 10:08:55 INFO - 'TERM': 'linux', 10:08:55 INFO - 'TMOUT': '86400', 10:08:55 INFO - 'USER': 'cltbld', 10:08:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:55 INFO - '_': '/tools/buildbot/bin/python'} 10:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:55 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 10:08:55 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 10:08:55 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 10:08:55 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 10:08:55 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 10:08:55 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 10:08:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:57 INFO - Installing collected packages: mozsystemmonitor 10:08:57 INFO - Running setup.py install for mozsystemmonitor 10:08:57 INFO - Successfully installed mozsystemmonitor 10:08:57 INFO - Cleaning up... 10:08:57 INFO - Return code: 0 10:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:08:57 INFO - Using env: {'DISPLAY': ':0', 10:08:57 INFO - 'HOME': '/home/cltbld', 10:08:57 INFO - 'LANG': 'en_US.UTF-8', 10:08:57 INFO - 'LANGUAGE': 'en_US:en', 10:08:57 INFO - 'LOGNAME': 'cltbld', 10:08:57 INFO - 'MAIL': '/var/mail/cltbld', 10:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:57 INFO - 'MOZ_NO_REMOTE': '1', 10:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:57 INFO - 'NO_EM_RESTART': '1', 10:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:57 INFO - 'PWD': '/builds/slave/test', 10:08:57 INFO - 'SHELL': '/bin/bash', 10:08:57 INFO - 'SHLVL': '1', 10:08:57 INFO - 'TERM': 'linux', 10:08:57 INFO - 'TMOUT': '86400', 10:08:57 INFO - 'USER': 'cltbld', 10:08:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:57 INFO - '_': '/tools/buildbot/bin/python'} 10:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 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 10:08:58 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 10:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - Downloading docopt-0.6.1.tar.gz 10:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:09:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:09:00 INFO - Running setup.py install for blobuploader 10:09:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:09:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:09:00 INFO - Running setup.py install for requests 10:09:01 INFO - Running setup.py install for docopt 10:09:01 INFO - Successfully installed blobuploader requests docopt 10:09:01 INFO - Cleaning up... 10:09:01 INFO - Return code: 0 10:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:01 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:09:01 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 10:09:01 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 10:09:01 INFO - Using env: {'DISPLAY': ':0', 10:09:01 INFO - 'HOME': '/home/cltbld', 10:09:01 INFO - 'LANG': 'en_US.UTF-8', 10:09:01 INFO - 'LANGUAGE': 'en_US:en', 10:09:01 INFO - 'LOGNAME': 'cltbld', 10:09:01 INFO - 'MAIL': '/var/mail/cltbld', 10:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:01 INFO - 'MOZ_NO_REMOTE': '1', 10:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:01 INFO - 'NO_EM_RESTART': '1', 10:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:01 INFO - 'PWD': '/builds/slave/test', 10:09:01 INFO - 'SHELL': '/bin/bash', 10:09:01 INFO - 'SHLVL': '1', 10:09:01 INFO - 'TERM': 'linux', 10:09:01 INFO - 'TMOUT': '86400', 10:09:01 INFO - 'USER': 'cltbld', 10:09:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:01 INFO - '_': '/tools/buildbot/bin/python'} 10:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:01 INFO - Running setup.py (path:/tmp/pip-qDi40P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:01 INFO - Running setup.py (path:/tmp/pip-SokaU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:01 INFO - Running setup.py (path:/tmp/pip-5v3lLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:01 INFO - Running setup.py (path:/tmp/pip-rzj5VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:01 INFO - Running setup.py (path:/tmp/pip-DvEGJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:01 INFO - Running setup.py (path:/tmp/pip-UU4VAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:01 INFO - Running setup.py (path:/tmp/pip-E_0U_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:01 INFO - Running setup.py (path:/tmp/pip-BRixDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:02 INFO - Running setup.py (path:/tmp/pip-R5JmrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:02 INFO - Running setup.py (path:/tmp/pip-ESGBWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:02 INFO - Running setup.py (path:/tmp/pip-QenFcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:02 INFO - Running setup.py (path:/tmp/pip-I7CJ7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:02 INFO - Running setup.py (path:/tmp/pip-2yc7nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:02 INFO - Running setup.py (path:/tmp/pip-nXzXuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:02 INFO - Running setup.py (path:/tmp/pip-V7P5A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:02 INFO - Running setup.py (path:/tmp/pip-YBbk_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:02 INFO - Running setup.py (path:/tmp/pip-Ka25KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:09:02 INFO - Running setup.py install for manifestparser 10:09:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:09:02 INFO - Running setup.py install for mozcrash 10:09:02 INFO - Running setup.py install for mozdebug 10:09:02 INFO - Running setup.py install for mozdevice 10:09:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozfile 10:09:03 INFO - Running setup.py install for mozhttpd 10:09:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozinfo 10:09:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozInstall 10:09:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozleak 10:09:03 INFO - Running setup.py install for mozlog 10:09:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for moznetwork 10:09:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:09:03 INFO - Running setup.py install for mozprocess 10:09:03 INFO - Running setup.py install for mozprofile 10:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Running setup.py install for mozrunner 10:09:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Running setup.py install for mozscreenshot 10:09:04 INFO - Running setup.py install for moztest 10:09:04 INFO - Running setup.py install for mozversion 10:09:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:09:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:04 INFO - Cleaning up... 10:09:04 INFO - Return code: 0 10:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:09:04 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 10:09:04 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 10:09:04 INFO - Using env: {'DISPLAY': ':0', 10:09:04 INFO - 'HOME': '/home/cltbld', 10:09:04 INFO - 'LANG': 'en_US.UTF-8', 10:09:04 INFO - 'LANGUAGE': 'en_US:en', 10:09:04 INFO - 'LOGNAME': 'cltbld', 10:09:04 INFO - 'MAIL': '/var/mail/cltbld', 10:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:04 INFO - 'MOZ_NO_REMOTE': '1', 10:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:04 INFO - 'NO_EM_RESTART': '1', 10:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:04 INFO - 'PWD': '/builds/slave/test', 10:09:04 INFO - 'SHELL': '/bin/bash', 10:09:04 INFO - 'SHLVL': '1', 10:09:04 INFO - 'TERM': 'linux', 10:09:04 INFO - 'TMOUT': '86400', 10:09:04 INFO - 'USER': 'cltbld', 10:09:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:04 INFO - '_': '/tools/buildbot/bin/python'} 10:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:09:04 INFO - Running setup.py (path:/tmp/pip-9yFIb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 INFO - Running setup.py (path:/tmp/pip-b1hBK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 INFO - Running setup.py (path:/tmp/pip-7ZCVIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 INFO - Running setup.py (path:/tmp/pip-CqXjs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:09:04 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)) 10:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:09:04 INFO - Running setup.py (path:/tmp/pip-6jf_t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:09:05 INFO - Running setup.py (path:/tmp/pip-UNo6mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:09:05 INFO - Running setup.py (path:/tmp/pip-8HxbW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:09:05 INFO - Running setup.py (path:/tmp/pip-xiqRUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:09:05 INFO - Running setup.py (path:/tmp/pip-EDMz7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:05 INFO - Running setup.py (path:/tmp/pip-lkdOo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:05 INFO - Running setup.py (path:/tmp/pip-yt6z7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:05 INFO - Running setup.py (path:/tmp/pip-_5hRK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:05 INFO - Running setup.py (path:/tmp/pip-5kLdo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:05 INFO - Running setup.py (path:/tmp/pip-gLPZz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:05 INFO - Running setup.py (path:/tmp/pip-DOpqu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:05 INFO - Running setup.py (path:/tmp/pip-oHV4ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:05 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)) 10:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:05 INFO - Running setup.py (path:/tmp/pip-5j2VCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:05 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)) 10:09:05 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)) 10:09:05 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)) 10:09:05 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)) 10:09:05 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)) 10:09:05 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)) 10:09:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:05 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 10:09:07 INFO - Downloading blessings-1.6.tar.gz 10:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:07 INFO - Installing collected packages: blessings 10:09:07 INFO - Running setup.py install for blessings 10:09:08 INFO - Successfully installed blessings 10:09:08 INFO - Cleaning up... 10:09:08 INFO - Return code: 0 10:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:08 INFO - Reading from file tmpfile_stdout 10:09:08 INFO - Current package versions: 10:09:08 INFO - argparse == 1.2.1 10:09:08 INFO - blessings == 1.6 10:09:08 INFO - blobuploader == 1.2.4 10:09:08 INFO - docopt == 0.6.1 10:09:08 INFO - manifestparser == 1.1 10:09:08 INFO - mozInstall == 1.12 10:09:08 INFO - mozcrash == 0.17 10:09:08 INFO - mozdebug == 0.1 10:09:08 INFO - mozdevice == 0.48 10:09:08 INFO - mozfile == 1.2 10:09:08 INFO - mozhttpd == 0.7 10:09:08 INFO - mozinfo == 0.9 10:09:08 INFO - mozleak == 0.1 10:09:08 INFO - mozlog == 3.2 10:09:08 INFO - moznetwork == 0.27 10:09:08 INFO - mozprocess == 0.22 10:09:08 INFO - mozprofile == 0.28 10:09:08 INFO - mozrunner == 6.11 10:09:08 INFO - mozscreenshot == 0.1 10:09:08 INFO - mozsystemmonitor == 0.3 10:09:08 INFO - moztest == 0.7 10:09:08 INFO - mozversion == 1.4 10:09:08 INFO - psutil == 3.1.1 10:09:08 INFO - requests == 1.2.3 10:09:08 INFO - wsgiref == 0.1.2 10:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:08 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 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:09:08 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 10:09:08 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 10:09:08 INFO - Using env: {'DISPLAY': ':0', 10:09:08 INFO - 'HOME': '/home/cltbld', 10:09:08 INFO - 'LANG': 'en_US.UTF-8', 10:09:08 INFO - 'LANGUAGE': 'en_US:en', 10:09:08 INFO - 'LOGNAME': 'cltbld', 10:09:08 INFO - 'MAIL': '/var/mail/cltbld', 10:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:08 INFO - 'MOZ_NO_REMOTE': '1', 10:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:08 INFO - 'NO_EM_RESTART': '1', 10:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:08 INFO - 'PWD': '/builds/slave/test', 10:09:08 INFO - 'SHELL': '/bin/bash', 10:09:08 INFO - 'SHLVL': '1', 10:09:08 INFO - 'TERM': 'linux', 10:09:08 INFO - 'TMOUT': '86400', 10:09:08 INFO - 'USER': 'cltbld', 10:09:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:08 INFO - '_': '/tools/buildbot/bin/python'} 10:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 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)) 10:09:08 INFO - Cleaning up... 10:09:08 INFO - Return code: 0 10:09:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:09: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', 'jsonschema'] in /builds/slave/test/build 10:09: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 jsonschema 10:09:08 INFO - Using env: {'DISPLAY': ':0', 10:09:08 INFO - 'HOME': '/home/cltbld', 10:09:08 INFO - 'LANG': 'en_US.UTF-8', 10:09:08 INFO - 'LANGUAGE': 'en_US:en', 10:09:08 INFO - 'LOGNAME': 'cltbld', 10:09:08 INFO - 'MAIL': '/var/mail/cltbld', 10:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:08 INFO - 'MOZ_NO_REMOTE': '1', 10:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:08 INFO - 'NO_EM_RESTART': '1', 10:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:08 INFO - 'PWD': '/builds/slave/test', 10:09:08 INFO - 'SHELL': '/bin/bash', 10:09:08 INFO - 'SHLVL': '1', 10:09:08 INFO - 'TERM': 'linux', 10:09:08 INFO - 'TMOUT': '86400', 10:09:08 INFO - 'USER': 'cltbld', 10:09:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:08 INFO - '_': '/tools/buildbot/bin/python'} 10:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:08 INFO - Downloading/unpacking jsonschema 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 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 10:09:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:10 INFO - warning: no files found matching '*.txt' 10:09:10 INFO - no previously-included directories found matching 'build' 10:09:10 INFO - no previously-included directories found matching 'dist' 10:09:10 INFO - no previously-included directories found matching '.git*' 10:09:10 INFO - Installing collected packages: jsonschema, functools32 10:09:10 INFO - Running setup.py install for functools32 10:09:11 INFO - warning: no files found matching '*.txt' 10:09:11 INFO - no previously-included directories found matching 'build' 10:09:11 INFO - no previously-included directories found matching 'dist' 10:09:11 INFO - no previously-included directories found matching '.git*' 10:09:11 INFO - Successfully installed jsonschema functools32 10:09:11 INFO - Cleaning up... 10:09:11 INFO - Return code: 0 10:09:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09: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')]} 10:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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')]} 10:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f317b361f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2232770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, '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': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', '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 10:09: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', 'flake8'] in /builds/slave/test/build 10:09: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 flake8 10:09:11 INFO - Using env: {'DISPLAY': ':0', 10:09:11 INFO - 'HOME': '/home/cltbld', 10:09:11 INFO - 'LANG': 'en_US.UTF-8', 10:09:11 INFO - 'LANGUAGE': 'en_US:en', 10:09:11 INFO - 'LOGNAME': 'cltbld', 10:09:11 INFO - 'MAIL': '/var/mail/cltbld', 10:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:11 INFO - 'MOZ_NO_REMOTE': '1', 10:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:11 INFO - 'NO_EM_RESTART': '1', 10:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:11 INFO - 'PWD': '/builds/slave/test', 10:09:11 INFO - 'SHELL': '/bin/bash', 10:09:11 INFO - 'SHLVL': '1', 10:09:11 INFO - 'TERM': 'linux', 10:09:11 INFO - 'TMOUT': '86400', 10:09:11 INFO - 'USER': 'cltbld', 10:09:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:11 INFO - '_': '/tools/buildbot/bin/python'} 10:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:11 INFO - Downloading/unpacking flake8 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09: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 10:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:13 INFO - no previously-included directories found matching 'docs/_build' 10:09:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:14 INFO - Running setup.py install for pep8 10:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:14 INFO - no previously-included directories found matching 'docs/_build' 10:09:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:09:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:14 INFO - Cleaning up... 10:09:14 INFO - Return code: 0 10:09:14 INFO - Running post-action listener: _resource_record_post_action 10:09:14 INFO - Running post-action listener: _start_resource_monitoring 10:09:14 INFO - Starting resource monitoring. 10:09:14 INFO - ##### 10:09:14 INFO - ##### Finished create-virtualenv step (success) 10:09:14 INFO - ##### 10:09:14 INFO - ##### 10:09:14 INFO - ##### Running install step. 10:09:14 INFO - ##### 10:09:14 INFO - Running pre-action listener: _resource_record_pre_action 10:09:14 INFO - Running main action method: install 10:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:14 INFO - Reading from file tmpfile_stdout 10:09:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:14 INFO - Reading from file tmpfile_stdout 10:09:14 INFO - Output received: 10:09:14 INFO - Usage: mozinstall [options] installer 10:09:14 INFO - Options: 10:09:14 INFO - -h, --help show this help message and exit 10:09:14 INFO - -d DEST, --destination=DEST 10:09:14 INFO - Directory to install application into. [default: 10:09:14 INFO - "/builds/slave/test"] 10:09:14 INFO - --app=APP Application being installed. [default: firefox] 10:09:14 INFO - mkdir: /builds/slave/test/build/application 10:09:14 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'] 10:09:14 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 10:09:31 INFO - Reading from file tmpfile_stdout 10:09:31 INFO - Output received: 10:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:09:31 INFO - Running post-action listener: _resource_record_post_action 10:09:31 INFO - ##### 10:09:31 INFO - ##### Finished install step (success) 10:09:31 INFO - ##### 10:09:31 INFO - ##### 10:09:31 INFO - ##### Running run-tests step. 10:09:31 INFO - ##### 10:09:31 INFO - Running pre-action listener: _resource_record_pre_action 10:09:31 INFO - Running main action method: run_tests 10:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:31 INFO - Python 2.7.3 10:09:31 INFO - Return code: 0 10:09:31 INFO - grabbing minidump binary from tooltool 10:09:31 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')]} 10:09:31 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 0x22c19c0>, '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 0x22c28c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22c2d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:31 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 10:09:31 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 10:09:31 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 10:09:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:31 INFO - Return code: 0 10:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:32 INFO - Return code: 0 10:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:09:32 INFO - Using env: {'DISPLAY': ':0', 10:09:32 INFO - 'HOME': '/home/cltbld', 10:09:32 INFO - 'LANG': 'en_US.UTF-8', 10:09:32 INFO - 'LANGUAGE': 'en_US:en', 10:09:32 INFO - 'LOGNAME': 'cltbld', 10:09:32 INFO - 'MAIL': '/var/mail/cltbld', 10:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:32 INFO - 'MOZ_NO_REMOTE': '1', 10:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:32 INFO - 'NO_EM_RESTART': '1', 10:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:32 INFO - 'PWD': '/builds/slave/test', 10:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:32 INFO - 'SHELL': '/bin/bash', 10:09:32 INFO - 'SHLVL': '1', 10:09:32 INFO - 'TERM': 'linux', 10:09:32 INFO - 'TMOUT': '86400', 10:09:32 INFO - 'USER': 'cltbld', 10:09:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299', 10:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:32 INFO - '_': '/tools/buildbot/bin/python'} 10:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:09:32 INFO - mozversion application_buildid: 20160519073110 10:09:32 INFO - mozversion application_changeset: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 10:09:32 INFO - mozversion application_display_name: Nightly 10:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:32 INFO - mozversion application_name: Firefox 10:09:32 INFO - mozversion application_remotingname: firefox 10:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:32 INFO - mozversion application_vendor: Mozilla 10:09:32 INFO - mozversion application_version: 49.0a1 10:09:32 INFO - mozversion platform_buildid: 20160519073110 10:09:32 INFO - mozversion platform_changeset: 5a4cdb6dfb19b458229c60e0e19f083ba83d0f58 10:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:32 INFO - mozversion platform_version: 49.0a1 10:09:32 INFO - using testdate: 1463677772 10:09:32 INFO - actual date: 1463677772 10:09:32 INFO - starting webserver on 'localhost:51810' 10:09:32 INFO - SUITE-START | Running 2 tests 10:09:32 INFO - TEST-START | dromaeo_css 10:09:32 INFO - operating with platform_type : linux_ 10:09:32 INFO - Initialising browser for dromaeo_css test... 10:09:32 INFO - TEST-INFO | started process 3277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0MPr3/profile http://localhost:51810/getInfo.html) 10:09:38 INFO - PROCESS | 3277 | 10:09:38 INFO - PROCESS | 3277 | (process:3345): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:39 INFO - PROCESS | 3277 | __metrics Screen width/height:1600/1200 10:09:39 INFO - PROCESS | 3277 | colorDepth:24 10:09:39 INFO - PROCESS | 3277 | Browser inner width/height: 1024/697 10:09:39 INFO - PROCESS | 3277 | __metrics 10:09:40 ERROR - PROCESS | 3277 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:09:40 INFO - TEST-INFO | 3277: exit 0 10:09:40 INFO - Browser initialized. 10:09:40 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:40 INFO - TEST-INFO | started process 3396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT0MPr3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:42 INFO - PROCESS | 3396 | 10:09:42 INFO - PROCESS | 3396 | (process:3457): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:52 INFO - PROCESS | 3396 | RSS: Main: 163844096 10:09:52 INFO - PROCESS | 3396 | 10:10:42 INFO - PROCESS | 3396 | 1463677842373 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] 10:12:49 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51810/tests/dromaeo/cssquery-ext.html) 10:12:50 INFO - PROCESS | 3396 | RSS: Main: 165171200 10:12:50 INFO - PROCESS | 3396 | 10:15:52 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-ext.html (next: http://localhost:51810/tests/dromaeo/cssquery-jquery.html) 10:15:53 INFO - PROCESS | 3396 | RSS: Main: 166780928 10:15:53 INFO - PROCESS | 3396 | 10:18:55 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51810/tests/dromaeo/cssquery-mootools.html) 10:18:56 INFO - PROCESS | 3396 | RSS: Main: 168271872 10:18:56 INFO - PROCESS | 3396 | 10:21:57 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51810/tests/dromaeo/cssquery-prototype.html) 10:21:58 INFO - PROCESS | 3396 | RSS: Main: 165638144 10:21:58 INFO - PROCESS | 3396 | 10:25:00 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51810/tests/dromaeo/cssquery-yui.html) 10:25:01 INFO - PROCESS | 3396 | RSS: Main: 167149568 10:25:01 INFO - PROCESS | 3396 | 10:28:03 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:51810/tests/dromaeo/cssquery-yui.html (next: http://localhost:51810/tests/dromaeo/cssquery-dojo.html) 10:28:04 INFO - PROCESS | 3396 | RSS: Main: 168968192 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | __start_tp_report 10:28:04 INFO - PROCESS | 3396 | _x_x_mozilla_page_load 10:28:04 INFO - PROCESS | 3396 | _x_x_mozilla_page_load_details 10:28:04 INFO - PROCESS | 3396 | |i|pagename|runs| 10:28:04 INFO - PROCESS | 3396 | |0;dojo.html;3094.767892408069;3130.2800355918125;3169;3173.841307934603;3183.665715099916;5408.2698835657175;5445.809396671118;5454.209139674745;5457.672539647624;5484.506394424501;5355.839324820252;5421.810236641718;5429.4570542945685;5471.151971444432;5501.559875209983;4905.730184839841;4937.629677774164;5048.1165795985735;5081.314022606956;5112.233165025239;786.4899346047306;4925.38432695913;5042.773075211624;5060.06388818068;5089.669171503859;4942.802287908479;5010.7995680172935;5016.122178618727;5021.874453138665;5048.9242661360295;4866.805327786884;4977.950220497821;4984.127777638899;5031.622628302892;5067.062593420229;4857.198562237227;4859.73271470069;4962.05720913029;4974.527419895104;4984.102861484931;5311.362636483646;5419.295491586108;5430.809921652763;5440.075187218183;5443.401225865152;5758.280214973129;5788.971055144697;5906.734196961104;5911.142884281798;5935.139404786281;5783.2192653992015;5824.388439213906;5840.153177789197;5856.531477481792;5876.882462350772;5476.698781567012;5476.726163691839;5478.233047373371;5487.2317875497465;5497.230387745679;5780.6820624865195;5853.473187413153;5879.676617786063;5905.527557795452;5945.494632956161;5668.574856885668;5683.232763576947;5708.600397972185;5723.942760572424;5730.627509211888;5803.506701930299;5815.447532484407;5816.243888294494;5822.155787410802;5829.358770535237;5546.334439867242;5768.480836724715;5779.306483221956;5790.10253410722;5803.912941305884;5631.549476041907;5708.80019199326;5709.65742055478;5740.684262365527;5845.883082338414;4360.589932798781;4375.321825117112;4383.561643835591;4391.890202744957;4428.977855110704;3826.6556009959236;3909.4135879618284;3924.901027712245;3968.1270120573427;3970.741901776433;5582.63712858671;5639.605227634026;5646.040173170571;5672.659640421588;5717.656940583578;5666.943330566642;5877.089051197071;5913.172155898092;5939.970300148558;5954.583179177416;5504.53211477029;5511.53151982086;5519.668819870821;5545.528630066409;5569.136783798518;4970.353853998957;4983.352164218629;5005.199168133081;5012.398512178562;5046.646734728533;5915.08316210988;5936.1095835625;5988.311344195473;6004.54965877561;6027.276726792813;5742.196092547047;5818.592698511064;5824.708764561839;5835.153902684002;5847.649141051551;5986.102084687158;5998.700064996646;6010;6013.488853447506;6021.7591296347655;5424.484673955968;5697;5703;5709.286339207599;5743.540516758733;5847.473727364558;5852.970735146468;5858.882822343444;5872.412758724094;5913.142594323713;5728.1694154348215;5745.166950792028;5748.482636562562;5752.798652047159;5763.596548241583;5541.362743284574;5617.915731263953;5653.152027195953;5676.2337084493065;5676.262085928803;5444.564434845123;5461.126219804971;5503.834884953458;5588.776448941997;5608.887822243614;5636.971815140898;5672.290963629546;5677.914831277451;5701.572382071278;5719.084946408721;5513.283273174462;5553.139263414178;5557.277553917965;5567.415421380859;5570.526505246938 10:28:04 INFO - PROCESS | 3396 | |1;ext.html;576.8615532272254;629.3832044596295;634.3688030409743;643.2313385504323;675.2639622811134;38937.80531097344;43953.78023109884;43998.12003759927;44175.33736993948;44211.33682994758;44263;45044.324335134996;45058.54941450585;45191.0961780765;45192;8854.380193386465;9039.593218305192;9054.139856713602;9058.048904864992;9061.139191776803;8922.776930576723;9011.324150688724;9015.323850711224;9019.323550733689;9021.233195178418;8988.280937525014;8989.820203595924;9003.459792412443;9048.41185322952;9077.591508382138;8961.193492585666;8962.462252264884;8998.86501702475;9005.189532942;9021.819563608724;8874.156955089256;8945.06076861933;8956.552172391419;8972.192502674725;8974.86537701935;33517.16207094818;41595.58404415947;41753.373699394535;42052.36921446181;42228.78885605552;3348.3554515350047;3470.4794280858073;3566.554180727409;3668.596454390042;3679.319325924686;30981.380372392425;31605.367892642247;32179.51730724041;32366.190845228823;32774.50838237428;4258.105797782469;4281.764502952336;4303.591158839905;4304.612584867377;4309.913801723979;315364;315581;316549;319411;320008;35668.28663426717;36327;37072.25855482875;37118.8144059278;37258.254834903695;35954.64045359513;38086.80956595255;38100;38101.61898381036;38170;13919.582412527641;13948.511802086878;13966.86033139676;13969.860301397059;14030.508932187324;12164.695882603006;12179.695507612203;12180.390980451119;12220.572279970158;12250.693732656755;8690.000649925212;8693.434926729742;8697;8729.869051964226;8740.78148046304;3338.9833050835077;3398.9490157647656;3401.5577974863604;3413.5903691557173;3433.9313213736086;1083.6748975307376;1118.4184224203368;1195.8146487294484;1196.4077781498213;1292.4636275945566;33333.3333333332;33359;33446.331073378395;33889.32221355559;34027.14932126716;1138.347649975555;1194.5401020607128;1199.8980086692554;1309;1372.6568357910523;16906.32374704998;17090.743638845426;17168.484945451655;17373.218205180798;17534;513197;513329;515578;517997;519418;59051.409485904594;60283.69858150681;60626;60763.39236607577;60843;1433.6559225785736;1444.0685757686445;1454.3382760844001;1456.8907331949933;1458.2635768936618;30590.84704576463;31777.523337150422;31953.680463196;32287.35425291528;32359.838200809787;51868.481315186364;52167.47832521778;52247.21629175489;52261.47738522566;52407.47592524026;338539;339342;339580;340485;341903;28948.27629309284;29323.560146598244;46992;48634.513654864415;48774.268385973526;47593.76203119101;52101.47898521118;52765.472345277594;53261.7336913313;53514;42514.5748542523;44098.77950610226;44181.77909110434;44220.778896105316;44830.55169448264;43607.690086717426;44150.779246103564;44954.3256851154;45042.549574505145;45249.32126018178;44308.33537496876;45537.31694024526;45542.77228613836;45631.54368456273;45732.77133614311;35317.82341088278;36636.45045324376;36648.26703465969;37132.44301335536;37738.245235095696;28997.56503652489;29033.419331613673;29455.26361840971;29471.55792663069;29650 10:28:04 INFO - PROCESS | 3396 | |2;jquery.html;404.3893720482071;405.624797062717;408.428200519273;408.55467540380977;426.3881330291031;15865.286062127203;18125.184366703495;19233;19940.10269537869;19967.700484492725;15969.84030159698;16213.594660133473;17876.55308617282;19023.52441188971;19202.327918522853;5565.972170139144;5577.247071645337;5698.6865722385255;5935.228420305354;5956.940430595682;5866.9706651466895;5894.675792831393;5910.1134829775665;5913.674747888865;5925.5555833312455;5899.439553242435;6476.093346931433;6490.902636460457;6505.6421896795655;6506;6257.7184026718905;6358.745650173987;6419.358064193543;6487.610743355413;6500.349965003509;5645.181448689958;5648.181013753024;5702.45826646468;5717.685527295997;5737.7131143443075;13340.599782006459;16958.321667133423;20147.79852201474;22901.77098229013;23023.76976230233;2266.8073213776847;2366.3847399676038;2445.9510809783706;2530.8101892358145;2863.498887694645;9969.750756231153;10054.592357070016;10115.595376184943;10376.481175941248;10618.150547956146;1947.5617985953188;1976.9209231630718;1989.5424052468013;2006.317851930336;2052.1791283486577;83259.16740832575;83721;83801;83844.16155838425;83913.58043209744;10952.616658416917;10960.397178155277;11157.107431405468;11176.720581985515;11339.773204535863;13316.334183290797;14166.929165354108;15714.371425142866;15841.366345346287;15855.127967961642;8186.345092392594;8192.877106843402;8206;8313.83372332562;8367.330613550901;7652.1582625911105;7733.110692270461;7830.804229894185;7830.8433831323055;7843.254890785366;4733.171694953369;4765.0946320199055;4844.128056949783;4916.434610019822;4917.213245880642;1995.670714332119;2019.9192032318836;2076.5743022680313;2111.9894400528206;2132.2323963373174;1000.2248257600272;1029.055085887673;1040.3081950502983;1068.9951445641072;1087.3095584304024;18094.63810723778;18647.067646617616;18744.53138671544;19349.51626209356;19518.5120371989;1070.9625163119254;1088.9128869690405;1091.0126335666075;1124.235519846496;1135.5741596901162;8256.504609723435;10631.734206644896;10744.516496757664;10796.352218866894;10909.618163364245;450854;453544;454023;459203;489258;88128;88890.55554722185;89017;89228;89952;1056.3767377247461;1077.5689724110418;1078.2398409121552;1082.5020490574425;1084.7667751433637;16767.413140540022;17084.316627334767;17129.14354282256;17147.228374723418;17502.91248543749;38680.80659596684;40137.39793903035;40746.38880416737;41063.589364105974;42120.78939605282;56440;57285.71357143188;59625;59908.400915990285;60137;8777.956110219407;8784.472931624123;8897.065808090058;9026.368154229142;9049.321300902327;12979.870201297867;13552.322383880964;13573;13625.727485450434;13697.726045479234;12006.519739210335;12028.338441385808;12033.338166400932;12039.939800300943;12175.817362739388;11570.026230029289;11815.113866460222;11845.5854045108;11892.821607675718;11944.581939632071;12065.276083435023;12272.325022123512;12290.508379664714;12324.260544367367;12482.875171248172;8580.957095214484;8707.564621768759;8789.34079943994;8844.425112367675;8865.379423440298;8698.304135669257;8811.955940220258;8822.294216462797;8955.328350373618;9144.177024067865 10:28:04 INFO - PROCESS | 3396 | |3;mootools.html;1536.469917878332;1580.7470804671252;1719.5872990482287;1875.3061367294104;1882.1624377152164;8186.631601577928;8586;8903.777405564864;9125.224355929753;9192.080791920804;9121.680741174061;9202.723918282445;9207.861882071775;9299.256059515239;9303.162715355616;2222.2444368914526;2249.572581209573;2250.819934405252;2252.0653928619604;2259.8644081355087;2317;2338.6375111857687;2358.6344116661858;2369.5497855407416;2370.502194539149;2308.0652335804025;2310.87290199039;2320.4198950262435;2335.0543030072763;2360.327306717586;2271.0802125139344;2271.943201419961;2280.7605201453857;2285.5885940530698;2285.5885940530698;2263.603869322862;2266.8866556672265;2270.375646697155;2270.943226419336;2272.4318920269934;9172.174504294579;9176.724698258997;9222.21611163052;9255.398399104104;9264.675736349196;5217.765200565984;5358.651687640291;5362.302900622933;5373.194020896858;5373.194020896896;3346.3474622448634;3413.5903691556923;3540.3627347077518;3543.1496440854266;3553.07620018797;1151.8732939376662;1156.8553930758655;1162.1167912386563;1202.4829323390938;1226.6013545597716;12773.936130319382;12784.744305113938;12869.67825804353;12901.483940642269;12904.612861614167;4641.350210970467;4801.29554008329;4811.08589368019;4814.15752243356;4815.7351345676325;10147.746306342253;10188.490575471196;10191.847122293171;10201.948990255001;10233.1301839343;5203.375594928557;5385.838424847261;5409.972950135303;5418.864528386822;5429.049916264638;4404.4494438195225;4832.130216560982;4987.775550100254;4991;5027.095122877844;3855.0747820522874;3905.72659913809;3956.8812935611977;3996.300647386696;4161.167766446722;1158.5887010111458;1159.9420028998516;1169.9415029248503;1171.3264872698232;1175.124532223499;1045.9320144190604;1050.0444595418132;1065.3661071662348;1068.5939343049747;1077.6228320087907;6193.84515387119;6350.396712312323;6413.486921046305;6453.548251622341;6518.706658200393;458.5712358944398;464.0857510703908;466.6150425898579;468.0685435982439;469.38276166840495;4262.190183865056;4436.245838207448;4456.62118719906;4513.11994161142;4590.540945905383;10872.402017888933;11180.664580062612;11202.159838012181;11249.887501125047;11288.492017859217;10818.404987725593;11054;11111.777764444827;11116.777664446667;11219.102471802236;8288.336933045342;8356.331493480508;8395.076541580422;8503.957480212559;8512.148785121562;6472.35276472349;6555.2133743951035;6612.305707900601;6619.371159739817;6694.564853284521;10143.239257055899;10628.096611787776;10722.195835312226;10872.67381978542;10887.856775038823;10616.469176540988;10736.46317684097;10809.837852432063;10915.83626245591;11094.278871873625;7946;8224.259816616533;8246.587670616325;8258.29804466603;8443.788905277172;9127.178553930178;9136.26909847224;9177.403468774508;9239.445633262027;9278.536073196177;7865.803354916173;8062.7581172564915;8131.105578386255;8216.671333146607;8219;7921.564313962787;7930.801729956797;8018.4787988780545;8080.63637136342;8222.547759873265;7400.296971787671;7417.777466676009;7453.403727701662;7471.364933980455;7476.813079673052;5309.734513274244;5341.359036915595;5437.646552974044;5466.671999680032;5480.040992826319;5284.682919024717;5392.838214853561;5430.321209848769;5461.1808228766;5577.52591029767 10:28:04 INFO - PROCESS | 3396 | |4;prototype.html;329.3643268491811;332.5377724962301;337.98648054077836;340.7512515863419;348.88835572616773;5636.2954630671165;5716.685582292972;5737.254156959594;5761.608932293093;5866.706664666771;5602.187682785993;5647;5674.574406919487;5688;5701.372848986608;4173.436586060889;4364.498082720488;4372.606465418112;4372.912541749163;4421.977890110545;4261.829526818939;4346.913061738764;4349.978250108745;4355.412019377391;4401.559844015589;4294.141171765644;4329.631981281595;4335.674824388184;4358.5423530529315;4361.302191649337;4300.182965236626;4329.913401731964;4353.564643535653;4386.385905973167;4403.581659742319;3784.1457685734067;3803.7717736935874;3807.7905715185652;3814.866479673226;3831.4252862070634;5440.102383106782;5463.48096930791;5469.835904922858;5481.12302031677;5502.312210973629;4994.700317980896;4998.475160108209;5001.799928002875;5018.247262910556;5027.673201241908;5625.131183096651;5926.733297001645;5929.140274660193;5929.436703513159;5935.584509084366;4188.937165942513;4203.7687927164;4210.221109094828;4229.281022226229;4241.512226094008;6067.211262535886;6146.539009574255;6201.937980620181;6204.81385558434;6257.405546473078;4211.768352740567;4222.387753775685;4235.8729238122905;4252.277112890816;4259.531451540328;4270.081932384553;4315.611594956469;4315.8489452869;4330.372096046056;4333.8699839004885;4782.426108866889;4895;4973.701577905337;4997.425296090923;5000.574951129122;5932.940670593325;5955.642661440241;5992.910106348409;6023.337432882379;6067.75728970845;1480.4078368652624;1482.9184394858387;1515.1363722678188;1518.7038527487255;1523.413485807972;932.9626814927327;953.3279038277998;953.4316050097551;971.9222462203007;978.8498514245733;5213.504717051874;5606.570324567209;5721.771129154788;5753.88492230153;5794.7838949383495;6118.663473508911;6150.938490615036;6176.289726681399;6188.381161883775;6198.318184999646;5520.392756796749;5758.510526605285;5784.913226301609;5792.247007888947;5800.53595712342;3228.9838550807094;3249.7725159238626;3253.837308134584;3280.3603297356785;3297.0768184908266;6307.590006649553;6308.52686048539;6354.332795056545;6430.688195579281;6446.806595802133;5883.764649413975;6199.752009919553;6210.4100110489435;6272.749090036439;6295.622262664163;6266.905996410058;6338.080978258126;6341.714622841983;6342.334054924258;6347.476605614619;5946.73239704223;6032.336442991355;6093.969530152498;6200.286966998672;6218.595791273553;6046.758129674764;6095.238095238095;6107.267127944675;6111.96944015277;6128.724207410588;6087.634741915499;6221.5333849960525;6332.398422149889;6340.9365906340345;6378.799314236581;4278.507971583308;4314.460692413449;4318.157959197926;4324.394584758199;4338.132373525371;6216.937830621817;6243.282022567463;6249.437550620466;6288;6315.336889626523;5816.47651711348;5947.364474769473;5968;5996.640201587918;6056.9697151513965;6017.676111255517;6026.517878569616;6039.305479869871;6056.788012419544;6079;5766.250387449605;5799.797007104731;5906.822795316148;5944.910826337522;5956.374580668968;5966.671833049224;5993.460588547052;6019.458248757633;6035.69821508914;6036.909446358396;5856.092305692625;5892.234009578728;5903.616264942765;5940.158550849251;5984.401559843981 10:28:04 INFO - PROCESS | 3396 | |5;yui.html;791.3827214772476;817.6565842346216;840.3403328387217;840.7397321318048;854.2183901729917;14212.21832799197;14674.486392976249;14765;14777.261136943163;14856.108633482;12214.389280535983;14548.127112373266;14596.781048284285;14598.270086495686;14614.050086744353;831.413853233472;846.5301757524571;851.4465597361702;856.8671855862351;857.7598272483715;837.2757564706516;845.9365547583925;847.5380917400032;848.6732607945924;849.8215374771305;900.7027680865332;904.0642934562729;905.2079430498314;905.483874191711;905.6694306578117;903.2548147778109;904.398574947659;904.9819003619924;905.3933864310894;906.4878343735768;653.3074940563018;654.0124412137659;654.89521676532;654.934506549346;656.5896314803248;14324.355404006845;14580.270986450741;14609.196494192814;14615.853841461556;14727;13424.32878356088;13461.326933653278;13512.189268643913;13570.93214533921;13964.092333998258;11505.252158609663;11506.884931150666;11625.360605166712;11669.124815638861;11828.172027958046;3871.845126194949;3972.5431575368625;4001.339778936472;4010.218007488541;4030.919381612351;59229.703851480466;59489;60107.69946150285;60293.39706602922;61461.69269153626;10836.620718274822;10854.67435976922;10956.178286628534;10987.505562249718;11092.722681932855;18657.720134197996;18684.53288667767;18744.188371744076;18795.90602046981;18805;7862;7979.9601001994615;8012.7980802878865;8104.797380065545;8112.878306825402;4571.634269258451;4741.715497070187;4833.782479788418;4867.902641947141;5019.774110165052;3426.640202778722;3446.2245994651503;3484.2508860595094;3501.7373696972827;3519.085037890167;703.6938931564786;703.7466512055656;710.4458522352573;715.4169351978226;716.4340171264747;650.2944305428568;703.5391818358983;723.9611157988304;769.2461387839949;774.1059076766344;9915.206783457306;9975.950120249352;9997.550110245056;10068.144207742424;10072.748181295527;751.3538357012965;755.8828381600861;758.9962050189714;762.7101701353561;779.2207792207793;4623.306504024356;4624.930626040612;4836.870854854189;4896.290037944478;4986.775595098229;72713.6364318175;74250.628746857;75102;75637.62181189058;76381.23618763853;63579;65441;65580.67209663922;67815.66092169606;68508.3149168502;52859.20711189258;55866.999999999185;61779;62100.68949655313;62695.6865215671;9966.152877005536;9993.850092248476;10267.84598231042;10400.58397664085;10482.947585262025;37115.44326835153;37303.25393492169;37630.811845940596;37689.81155094207;37971.240575188895;48950;49865.252021218985;49900.25149622831;50664.74667626638;51163.48836511736;13058;13175.934120329337;13203.405846736729;13269.867301326864;13526.797098043735;14244.857551424768;14370.281485925452;14529.128252304896;14582.781258280922;14875.776863347275;12513.687157821127;12922.741545169232;13117.08180427361;13364.398602063126;13584.592462226148;12486.625401237978;13138.80291795643;13811.79282310746;13831.930840345734;14261.857381426467;11667.241629294069;12043.518259269531;12579.433925473559;12640.55758048464;12951.481940722266;9942.254330925354;9978.800423991624;10295.639652612123;10304.690859274233;10617.362958222531;10695.465226738788;10817.837732434176;10875.782484350428;10879.51042203087;10937.781244374908 10:28:04 INFO - PROCESS | 3396 | __end_tp_report 10:28:04 INFO - PROCESS | 3396 | __start_cc_report 10:28:04 INFO - PROCESS | 3396 | _x_x_mozilla_cycle_collect,339 10:28:04 INFO - PROCESS | 3396 | __end_cc_report 10:28:04 INFO - PROCESS | 3396 | __startTimestamp1463678884165__endTimestamp 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | ------- Summary: start ------- 10:28:04 INFO - PROCESS | 3396 | Number of tests: 6 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#0] dojo.html Cycles:165 Average:5376.37 Median:5608.89 stddev:707.96 (12.6%) stddev-sans-first:687.14 10:28:04 INFO - PROCESS | 3396 | Values: 3094.8 3130.3 3169.0 3173.8 3183.7 5408.3 5445.8 5454.2 5457.7 5484.5 5355.8 5421.8 5429.5 5471.2 5501.6 4905.7 4937.6 5048.1 5081.3 5112.2 786.5 4925.4 5042.8 5060.1 5089.7 4942.8 5010.8 5016.1 5021.9 5048.9 4866.8 4978.0 4984.1 5031.6 5067.1 4857.2 4859.7 4962.1 4974.5 4984.1 5311.4 5419.3 5430.8 5440.1 5443.4 5758.3 5789.0 5906.7 5911.1 5935.1 5783.2 5824.4 5840.2 5856.5 5876.9 5476.7 5476.7 5478.2 5487.2 5497.2 5780.7 5853.5 5879.7 5905.5 5945.5 5668.6 5683.2 5708.6 5723.9 5730.6 5803.5 5815.4 5816.2 5822.2 5829.4 5546.3 5768.5 5779.3 5790.1 5803.9 5631.5 5708.8 5709.7 5740.7 5845.9 4360.6 4375.3 4383.6 4391.9 4429.0 3826.7 3909.4 3924.9 3968.1 3970.7 5582.6 5639.6 5646.0 5672.7 5717.7 5666.9 5877.1 5913.2 5940.0 5954.6 5504.5 5511.5 5519.7 5545.5 5569.1 4970.4 4983.4 5005.2 5012.4 5046.6 5915.1 5936.1 5988.3 6004.5 6027.3 5742.2 5818.6 5824.7 5835.2 5847.6 5986.1 5998.7 6010.0 6013.5 6021.8 5424.5 5697.0 5703.0 5709.3 5743.5 5847.5 5853.0 5858.9 5872.4 5913.1 5728.2 5745.2 5748.5 5752.8 5763.6 5541.4 5617.9 5653.2 5676.2 5676.3 5444.6 5461.1 5503.8 5588.8 5608.9 5637.0 5672.3 5677.9 5701.6 5719.1 5513.3 5553.1 5557.3 5567.4 5570.5 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#1] ext.html Cycles:180 Average:55301.86 Median:41902.87 stddev:106225.40 (253.5%) stddev-sans-first:106443.92 10:28:04 INFO - PROCESS | 3396 | Values: 576.9 629.4 634.4 643.2 675.3 38937.8 43953.8 43998.1 44175.3 44211.3 44263.0 45044.3 45058.5 45191.1 45192.0 8854.4 9039.6 9054.1 9058.0 9061.1 8922.8 9011.3 9015.3 9019.3 9021.2 8988.3 8989.8 9003.5 9048.4 9077.6 8961.2 8962.5 8998.9 9005.2 9021.8 8874.2 8945.1 8956.6 8972.2 8974.9 33517.2 41595.6 41753.4 42052.4 42228.8 3348.4 3470.5 3566.6 3668.6 3679.3 30981.4 31605.4 32179.5 32366.2 32774.5 4258.1 4281.8 4303.6 4304.6 4309.9 315364.0 315581.0 316549.0 319411.0 320008.0 35668.3 36327.0 37072.3 37118.8 37258.3 35954.6 38086.8 38100.0 38101.6 38170.0 13919.6 13948.5 13966.9 13969.9 14030.5 12164.7 12179.7 12180.4 12220.6 12250.7 8690.0 8693.4 8697.0 8729.9 8740.8 3339.0 3398.9 3401.6 3413.6 3433.9 1083.7 1118.4 1195.8 1196.4 1292.5 33333.3 33359.0 33446.3 33889.3 34027.1 1138.3 1194.5 1199.9 1309.0 1372.7 16906.3 17090.7 17168.5 17373.2 17534.0 513197.0 513329.0 515578.0 517997.0 519418.0 59051.4 60283.7 60626.0 60763.4 60843.0 1433.7 1444.1 1454.3 1456.9 1458.3 30590.8 31777.5 31953.7 32287.4 32359.8 51868.5 52167.5 52247.2 52261.5 52407.5 338539.0 339342.0 339580.0 340485.0 341903.0 28948.3 29323.6 46992.0 48634.5 48774.3 47593.8 52101.5 52765.5 53261.7 53514.0 42514.6 44098.8 44181.8 44220.8 44830.6 43607.7 44150.8 44954.3 45042.5 45249.3 44308.3 45537.3 45542.8 45631.5 45732.8 35317.8 36636.5 36648.3 37132.4 37738.2 28997.6 29033.4 29455.3 29471.6 29650.0 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#2] jquery.html Cycles:180 Average:28024.24 Median:2488.38 stddev:76276.34 (3065.3%) stddev-sans-first:76462.12 10:28:04 INFO - PROCESS | 3396 | Values: 404.4 405.6 408.4 408.6 426.4 15865.3 18125.2 19233.0 19940.1 19967.7 15969.8 16213.6 17876.6 19023.5 19202.3 5566.0 5577.2 5698.7 5935.2 5956.9 5867.0 5894.7 5910.1 5913.7 5925.6 5899.4 6476.1 6490.9 6505.6 6506.0 6257.7 6358.7 6419.4 6487.6 6500.3 5645.2 5648.2 5702.5 5717.7 5737.7 13340.6 16958.3 20147.8 22901.8 23023.8 2266.8 2366.4 2446.0 2530.8 2863.5 9969.8 10054.6 10115.6 10376.5 10618.2 1947.6 1976.9 1989.5 2006.3 2052.2 83259.2 83721.0 83801.0 83844.2 83913.6 10952.6 10960.4 11157.1 11176.7 11339.8 13316.3 14166.9 15714.4 15841.4 15855.1 8186.3 8192.9 8206.0 8313.8 8367.3 7652.2 7733.1 7830.8 7830.8 7843.3 4733.2 4765.1 4844.1 4916.4 4917.2 1995.7 2019.9 2076.6 2112.0 2132.2 1000.2 1029.1 1040.3 1069.0 1087.3 18094.6 18647.1 18744.5 19349.5 19518.5 1071.0 1088.9 1091.0 1124.2 1135.6 8256.5 10631.7 10744.5 10796.4 10909.6 450854.0 453544.0 454023.0 459203.0 489258.0 88128.0 88890.6 89017.0 89228.0 89952.0 1056.4 1077.6 1078.2 1082.5 1084.8 16767.4 17084.3 17129.1 17147.2 17502.9 38680.8 40137.4 40746.4 41063.6 42120.8 56440.0 57285.7 59625.0 59908.4 60137.0 8778.0 8784.5 8897.1 9026.4 9049.3 12979.9 13552.3 13573.0 13625.7 13697.7 12006.5 12028.3 12033.3 12039.9 12175.8 11570.0 11815.1 11845.6 11892.8 11944.6 12065.3 12272.3 12290.5 12324.3 12482.9 8581.0 8707.6 8789.3 8844.4 8865.4 8698.3 8812.0 8822.3 8955.3 9144.2 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#3] mootools.html Cycles:180 Average:6014.23 Median:2524.56 stddev:3460.42 (137.1%) stddev-sans-first:3453.76 10:28:04 INFO - PROCESS | 3396 | Values: 1536.5 1580.7 1719.6 1875.3 1882.2 8186.6 8586.0 8903.8 9125.2 9192.1 9121.7 9202.7 9207.9 9299.3 9303.2 2222.2 2249.6 2250.8 2252.1 2259.9 2317.0 2338.6 2358.6 2369.5 2370.5 2308.1 2310.9 2320.4 2335.1 2360.3 2271.1 2271.9 2280.8 2285.6 2285.6 2263.6 2266.9 2270.4 2270.9 2272.4 9172.2 9176.7 9222.2 9255.4 9264.7 5217.8 5358.7 5362.3 5373.2 5373.2 3346.3 3413.6 3540.4 3543.1 3553.1 1151.9 1156.9 1162.1 1202.5 1226.6 12773.9 12784.7 12869.7 12901.5 12904.6 4641.4 4801.3 4811.1 4814.2 4815.7 10147.7 10188.5 10191.8 10201.9 10233.1 5203.4 5385.8 5410.0 5418.9 5429.0 4404.4 4832.1 4987.8 4991.0 5027.1 3855.1 3905.7 3956.9 3996.3 4161.2 1158.6 1159.9 1169.9 1171.3 1175.1 1045.9 1050.0 1065.4 1068.6 1077.6 6193.8 6350.4 6413.5 6453.5 6518.7 458.6 464.1 466.6 468.1 469.4 4262.2 4436.2 4456.6 4513.1 4590.5 10872.4 11180.7 11202.2 11249.9 11288.5 10818.4 11054.0 11111.8 11116.8 11219.1 8288.3 8356.3 8395.1 8504.0 8512.1 6472.4 6555.2 6612.3 6619.4 6694.6 10143.2 10628.1 10722.2 10872.7 10887.9 10616.5 10736.5 10809.8 10915.8 11094.3 7946.0 8224.3 8246.6 8258.3 8443.8 9127.2 9136.3 9177.4 9239.4 9278.5 7865.8 8062.8 8131.1 8216.7 8219.0 7921.6 7930.8 8018.5 8080.6 8222.5 7400.3 7417.8 7453.4 7471.4 7476.8 5309.7 5341.4 5437.6 5466.7 5480.0 5284.7 5392.8 5430.3 5461.2 5577.5 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#4] prototype.html Cycles:180 Average:5002.71 Median:5763.93 stddev:1501.03 (26.0%) stddev-sans-first:1463.68 10:28:04 INFO - PROCESS | 3396 | Values: 329.4 332.5 338.0 340.8 348.9 5636.3 5716.7 5737.3 5761.6 5866.7 5602.2 5647.0 5674.6 5688.0 5701.4 4173.4 4364.5 4372.6 4372.9 4422.0 4261.8 4346.9 4350.0 4355.4 4401.6 4294.1 4329.6 4335.7 4358.5 4361.3 4300.2 4329.9 4353.6 4386.4 4403.6 3784.1 3803.8 3807.8 3814.9 3831.4 5440.1 5463.5 5469.8 5481.1 5502.3 4994.7 4998.5 5001.8 5018.2 5027.7 5625.1 5926.7 5929.1 5929.4 5935.6 4188.9 4203.8 4210.2 4229.3 4241.5 6067.2 6146.5 6201.9 6204.8 6257.4 4211.8 4222.4 4235.9 4252.3 4259.5 4270.1 4315.6 4315.8 4330.4 4333.9 4782.4 4895.0 4973.7 4997.4 5000.6 5932.9 5955.6 5992.9 6023.3 6067.8 1480.4 1482.9 1515.1 1518.7 1523.4 933.0 953.3 953.4 971.9 978.8 5213.5 5606.6 5721.8 5753.9 5794.8 6118.7 6150.9 6176.3 6188.4 6198.3 5520.4 5758.5 5784.9 5792.2 5800.5 3229.0 3249.8 3253.8 3280.4 3297.1 6307.6 6308.5 6354.3 6430.7 6446.8 5883.8 6199.8 6210.4 6272.7 6295.6 6266.9 6338.1 6341.7 6342.3 6347.5 5946.7 6032.3 6094.0 6200.3 6218.6 6046.8 6095.2 6107.3 6112.0 6128.7 6087.6 6221.5 6332.4 6340.9 6378.8 4278.5 4314.5 4318.2 4324.4 4338.1 6216.9 6243.3 6249.4 6288.0 6315.3 5816.5 5947.4 5968.0 5996.6 6057.0 6017.7 6026.5 6039.3 6056.8 6079.0 5766.3 5799.8 5906.8 5944.9 5956.4 5966.7 5993.5 6019.5 6035.7 6036.9 5856.1 5892.2 5903.6 5940.2 5984.4 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - PROCESS | 3396 | [#5] yui.html Cycles:180 Average:16287.99 Median:4683.32 stddev:20024.25 (427.6%) stddev-sans-first:20046.61 10:28:04 INFO - PROCESS | 3396 | Values: 791.4 817.7 840.3 840.7 854.2 14212.2 14674.5 14765.0 14777.3 14856.1 12214.4 14548.1 14596.8 14598.3 14614.1 831.4 846.5 851.4 856.9 857.8 837.3 845.9 847.5 848.7 849.8 900.7 904.1 905.2 905.5 905.7 903.3 904.4 905.0 905.4 906.5 653.3 654.0 654.9 654.9 656.6 14324.4 14580.3 14609.2 14615.9 14727.0 13424.3 13461.3 13512.2 13570.9 13964.1 11505.3 11506.9 11625.4 11669.1 11828.2 3871.8 3972.5 4001.3 4010.2 4030.9 59229.7 59489.0 60107.7 60293.4 61461.7 10836.6 10854.7 10956.2 10987.5 11092.7 18657.7 18684.5 18744.2 18795.9 18805.0 7862.0 7980.0 8012.8 8104.8 8112.9 4571.6 4741.7 4833.8 4867.9 5019.8 3426.6 3446.2 3484.3 3501.7 3519.1 703.7 703.7 710.4 715.4 716.4 650.3 703.5 724.0 769.2 774.1 9915.2 9976.0 9997.6 10068.1 10072.7 751.4 755.9 759.0 762.7 779.2 4623.3 4624.9 4836.9 4896.3 4986.8 72713.6 74250.6 75102.0 75637.6 76381.2 63579.0 65441.0 65580.7 67815.7 68508.3 52859.2 55867.0 61779.0 62100.7 62695.7 9966.2 9993.9 10267.8 10400.6 10482.9 37115.4 37303.3 37630.8 37689.8 37971.2 48950.0 49865.3 49900.3 50664.7 51163.5 13058.0 13175.9 13203.4 13269.9 13526.8 14244.9 14370.3 14529.1 14582.8 14875.8 12513.7 12922.7 13117.1 13364.4 13584.6 12486.6 13138.8 13811.8 13831.9 14261.9 11667.2 12043.5 12579.4 12640.6 12951.5 9942.3 9978.8 10295.6 10304.7 10617.4 10695.5 10817.8 10875.8 10879.5 10937.8 10:28:04 INFO - PROCESS | 3396 | -------- Summary: end -------- 10:28:04 INFO - PROCESS | 3396 | 10:28:04 INFO - TEST-INFO | 3396: exit 0 10:28:04 INFO - TEST-OK | dromaeo_css | took 1112419ms 10:28:04 INFO - TEST-START | kraken 10:28:04 INFO - operating with platform_type : linux_ 10:28:04 INFO - Initialising browser for kraken test... 10:28:04 INFO - TEST-INFO | started process 3632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVONVQ5/profile http://localhost:51810/getInfo.html) 10:28:08 INFO - PROCESS | 3632 | 10:28:08 INFO - PROCESS | 3632 | (process:3700): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:09 INFO - PROCESS | 3632 | __metrics Screen width/height:1600/1200 10:28:09 INFO - PROCESS | 3632 | colorDepth:24 10:28:09 INFO - PROCESS | 3632 | Browser inner width/height: 1024/697 10:28:09 INFO - PROCESS | 3632 | __metrics 10:28:10 ERROR - PROCESS | 3632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:28:11 INFO - TEST-INFO | 3632: exit 0 10:28:11 INFO - Browser initialized. 10:28:11 INFO - Running cycle 1/1 for kraken test... 10:28:11 INFO - TEST-INFO | started process 3751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVONVQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:13 INFO - PROCESS | 3751 | 10:28:13 INFO - PROCESS | 3751 | (process:3812): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:23 INFO - PROCESS | 3751 | RSS: Main: 163385344 10:28:23 INFO - PROCESS | 3751 | 10:28:25 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51810/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:26 INFO - PROCESS | 3751 | RSS: Main: 168103936 10:28:26 INFO - PROCESS | 3751 | 10:28:29 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51810/tests/kraken/driver.html?testName=audio-dft) 10:28:30 INFO - PROCESS | 3751 | RSS: Main: 168513536 10:28:30 INFO - PROCESS | 3751 | 10:28:32 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51810/tests/kraken/driver.html?testName=audio-fft) 10:28:33 INFO - PROCESS | 3751 | RSS: Main: 163303424 10:28:33 INFO - PROCESS | 3751 | 10:28:35 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51810/tests/kraken/driver.html?testName=audio-oscillator) 10:28:36 INFO - PROCESS | 3751 | RSS: Main: 163762176 10:28:36 INFO - PROCESS | 3751 | 10:28:38 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51810/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:39 INFO - PROCESS | 3751 | RSS: Main: 163897344 10:28:39 INFO - PROCESS | 3751 | 10:28:42 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51810/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:43 INFO - PROCESS | 3751 | RSS: Main: 164261888 10:28:43 INFO - PROCESS | 3751 | 10:28:46 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51810/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:47 INFO - PROCESS | 3751 | RSS: Main: 163160064 10:28:47 INFO - PROCESS | 3751 | 10:28:50 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51810/tests/kraken/driver.html?testName=json-parse-financial) 10:28:50 INFO - PROCESS | 3751 | RSS: Main: 163549184 10:28:50 INFO - PROCESS | 3751 | 10:28:52 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51810/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:52 INFO - PROCESS | 3751 | RSS: Main: 164048896 10:28:52 INFO - PROCESS | 3751 | 10:28:54 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:55 INFO - PROCESS | 3751 | RSS: Main: 164163584 10:28:55 INFO - PROCESS | 3751 | 10:28:57 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:58 INFO - PROCESS | 3751 | RSS: Main: 164175872 10:28:58 INFO - PROCESS | 3751 | 10:29:00 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:01 INFO - PROCESS | 3751 | RSS: Main: 164003840 10:29:01 INFO - PROCESS | 3751 | 10:29:04 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:04 INFO - PROCESS | 3751 | RSS: Main: 164196352 10:29:04 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | Cycle 1(1): loaded http://localhost:51810/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51810/tests/kraken/driver.html?testName=ai-astar) 10:29:06 INFO - PROCESS | 3751 | RSS: Main: 165793792 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | __start_tp_report 10:29:06 INFO - PROCESS | 3751 | _x_x_mozilla_page_load 10:29:06 INFO - PROCESS | 3751 | _x_x_mozilla_page_load_details 10:29:06 INFO - PROCESS | 3751 | |i|pagename|runs| 10:29:06 INFO - PROCESS | 3751 | |0;ai-astar;109;114;103;109;115;110;105;110;110;109 10:29:06 INFO - PROCESS | 3751 | |1;audio-beat-detection;154;130;150;204;129;161;155;127;188;126 10:29:06 INFO - PROCESS | 3751 | |2;audio-dft;163;162;162;160;165;173;162;161;160;164 10:29:06 INFO - PROCESS | 3751 | |3;audio-fft;74;75;75;171;76;74;74;75;158;75 10:29:06 INFO - PROCESS | 3751 | |4;audio-oscillator;92;92;181;92;92;93;144;93;93;145 10:29:06 INFO - PROCESS | 3751 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;117;117;118 10:29:06 INFO - PROCESS | 3751 | |6;imaging-darkroom;147;146;146;147;147;146;146;146;146;146 10:29:06 INFO - PROCESS | 3751 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;96 10:29:06 INFO - PROCESS | 3751 | |8;json-parse-financial;55;55;55;54;57;56;60;107;54;53 10:29:06 INFO - PROCESS | 3751 | |9;json-stringify-tinderbox;59;61;59;60;59;59;59;60;61;59 10:29:06 INFO - PROCESS | 3751 | |10;stanford-crypto-aes;83;79;79;78;79;80;79;79;81;85 10:29:06 INFO - PROCESS | 3751 | |11;stanford-crypto-ccm;124;120;123;135;129;117;123;126;188;135 10:29:06 INFO - PROCESS | 3751 | |12;stanford-crypto-pbkdf2;159;167;159;165;161;157;159;157;160;160 10:29:06 INFO - PROCESS | 3751 | |13;stanford-crypto-sha256-iterative;64;65;64;62;63;65;63;63;64;62 10:29:06 INFO - PROCESS | 3751 | __end_tp_report 10:29:06 INFO - PROCESS | 3751 | __start_cc_report 10:29:06 INFO - PROCESS | 3751 | _x_x_mozilla_cycle_collect,870 10:29:06 INFO - PROCESS | 3751 | __end_cc_report 10:29:06 INFO - PROCESS | 3751 | __startTimestamp1463678946787__endTimestamp 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | ------- Summary: start ------- 10:29:06 INFO - PROCESS | 3751 | Number of tests: 14 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:3.78 10:29:06 INFO - PROCESS | 3751 | Values: 109.0 114.0 103.0 109.0 115.0 110.0 105.0 110.0 110.0 109.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:154.50 stddev:26.69 (17.3%) stddev-sans-first:28.30 10:29:06 INFO - PROCESS | 3751 | Values: 154.0 130.0 150.0 204.0 129.0 161.0 155.0 127.0 188.0 126.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.79 (2.3%) stddev-sans-first:4.02 10:29:06 INFO - PROCESS | 3751 | Values: 163.0 162.0 162.0 160.0 165.0 173.0 162.0 161.0 160.0 164.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.00 stddev:37.97 (50.6%) stddev-sans-first:39.67 10:29:06 INFO - PROCESS | 3751 | Values: 74.0 75.0 75.0 171.0 76.0 74.0 74.0 75.0 158.0 75.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:32.59 (35.4%) stddev-sans-first:33.77 10:29:06 INFO - PROCESS | 3751 | Values: 92.0 92.0 181.0 92.0 92.0 93.0 144.0 93.0 93.0 145.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:29:06 INFO - PROCESS | 3751 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 118.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 10:29:06 INFO - PROCESS | 3751 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:29:06 INFO - PROCESS | 3751 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:55.00 stddev:16.42 (29.9%) stddev-sans-first:17.29 10:29:06 INFO - PROCESS | 3751 | Values: 55.0 55.0 55.0 54.0 57.0 56.0 60.0 107.0 54.0 53.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 10:29:06 INFO - PROCESS | 3751 | Values: 59.0 61.0 59.0 60.0 59.0 59.0 59.0 60.0 61.0 59.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:2.20 (2.8%) stddev-sans-first:2.09 10:29:06 INFO - PROCESS | 3751 | Values: 83.0 79.0 79.0 78.0 79.0 80.0 79.0 79.0 81.0 85.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:127.50 stddev:20.53 (16.1%) stddev-sans-first:21.57 10:29:06 INFO - PROCESS | 3751 | Values: 124.0 120.0 123.0 135.0 129.0 117.0 123.0 126.0 188.0 135.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:3.24 (2.0%) stddev-sans-first:3.40 10:29:06 INFO - PROCESS | 3751 | Values: 159.0 167.0 159.0 165.0 161.0 157.0 159.0 157.0 160.0 160.0 10:29:06 INFO - PROCESS | 3751 | 10:29:06 INFO - PROCESS | 3751 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 10:29:06 INFO - PROCESS | 3751 | Values: 64.0 65.0 64.0 62.0 63.0 65.0 63.0 63.0 64.0 62.0 10:29:06 INFO - PROCESS | 3751 | -------- Summary: end -------- 10:29:06 INFO - PROCESS | 3751 | 10:29:07 INFO - TEST-INFO | 3751: exit 0 10:29:07 INFO - TEST-OK | kraken | took 62838ms 10:29:07 INFO - SUITE-END | took 1175s 10:29:07 INFO - Completed test suite (00:19:35) 10:29:07 INFO - javascript benchmark 10:29:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7229.261194574974, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.767892408069, 3130.2800355918125, 3169.0, 3173.841307934603, 3183.665715099916, 5408.2698835657175, 5445.809396671118, 5454.209139674745, 5457.672539647624, 5484.506394424501, 5355.839324820252, 5421.810236641718, 5429.4570542945685, 5471.151971444432, 5501.559875209983, 4905.730184839841, 4937.629677774164, 5048.1165795985735, 5081.314022606956, 5112.233165025239, 786.4899346047306, 4925.38432695913, 5042.773075211624, 5060.06388818068, 5089.669171503859, 4942.802287908479, 5010.7995680172935, 5016.122178618727, 5021.874453138665, 5048.9242661360295, 4866.805327786884, 4977.950220497821, 4984.127777638899, 5031.622628302892, 5067.062593420229, 4857.198562237227, 4859.73271470069, 4962.05720913029, 4974.527419895104, 4984.102861484931, 5311.362636483646, 5419.295491586108, 5430.809921652763, 5440.075187218183, 5443.401225865152, 5758.280214973129, 5788.971055144697, 5906.734196961104, 5911.142884281798, 5935.139404786281, 5783.2192653992015, 5824.388439213906, 5840.153177789197, 5856.531477481792, 5876.882462350772, 5476.698781567012, 5476.726163691839, 5478.233047373371, 5487.2317875497465, 5497.230387745679, 5780.6820624865195, 5853.473187413153, 5879.676617786063, 5905.527557795452, 5945.494632956161, 5668.574856885668, 5683.232763576947, 5708.600397972185, 5723.942760572424, 5730.627509211888, 5803.506701930299, 5815.447532484407, 5816.243888294494, 5822.155787410802, 5829.358770535237, 5546.334439867242, 5768.480836724715, 5779.306483221956, 5790.10253410722, 5803.912941305884, 5631.549476041907, 5708.80019199326, 5709.65742055478, 5740.684262365527, 5845.883082338414, 4360.589932798781, 4375.321825117112, 4383.561643835591, 4391.890202744957, 4428.977855110704, 3826.6556009959236, 3909.4135879618284, 3924.901027712245, 3968.1270120573427, 3970.741901776433, 5582.63712858671, 5639.605227634026, 5646.040173170571, 5672.659640421588, 5717.656940583578, 5666.943330566642, 5877.089051197071, 5913.172155898092, 5939.970300148558, 5954.583179177416, 5504.53211477029, 5511.53151982086, 5519.668819870821, 5545.528630066409, 5569.136783798518, 4970.353853998957, 4983.352164218629, 5005.199168133081, 5012.398512178562, 5046.646734728533, 5915.08316210988, 5936.1095835625, 5988.311344195473, 6004.54965877561, 6027.276726792813, 5742.196092547047, 5818.592698511064, 5824.708764561839, 5835.153902684002, 5847.649141051551, 5986.102084687158, 5998.700064996646, 6010.0, 6013.488853447506, 6021.7591296347655, 5424.484673955968, 5697.0, 5703.0, 5709.286339207599, 5743.540516758733, 5847.473727364558, 5852.970735146468, 5858.882822343444, 5872.412758724094, 5913.142594323713, 5728.1694154348215, 5745.166950792028, 5748.482636562562, 5752.798652047159, 5763.596548241583, 5541.362743284574, 5617.915731263953, 5653.152027195953, 5676.2337084493065, 5676.262085928803, 5444.564434845123, 5461.126219804971, 5503.834884953458, 5588.776448941997, 5608.887822243614, 5636.971815140898, 5672.290963629546, 5677.914831277451, 5701.572382071278, 5719.084946408721, 5513.283273174462, 5553.139263414178, 5557.277553917965, 5567.415421380859, 5570.526505246938], "value": 5330.8672041447335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8615532272254, 629.3832044596295, 634.3688030409743, 643.2313385504323, 675.2639622811134, 38937.80531097344, 43953.78023109884, 43998.12003759927, 44175.33736993948, 44211.33682994758, 44263.0, 45044.324335134996, 45058.54941450585, 45191.0961780765, 45192.0, 8854.380193386465, 9039.593218305192, 9054.139856713602, 9058.048904864992, 9061.139191776803, 8922.776930576723, 9011.324150688724, 9015.323850711224, 9019.323550733689, 9021.233195178418, 8988.280937525014, 8989.820203595924, 9003.459792412443, 9048.41185322952, 9077.591508382138, 8961.193492585666, 8962.462252264884, 8998.86501702475, 9005.189532942, 9021.819563608724, 8874.156955089256, 8945.06076861933, 8956.552172391419, 8972.192502674725, 8974.86537701935, 33517.16207094818, 41595.58404415947, 41753.373699394535, 42052.36921446181, 42228.78885605552, 3348.3554515350047, 3470.4794280858073, 3566.554180727409, 3668.596454390042, 3679.319325924686, 30981.380372392425, 31605.367892642247, 32179.51730724041, 32366.190845228823, 32774.50838237428, 4258.105797782469, 4281.764502952336, 4303.591158839905, 4304.612584867377, 4309.913801723979, 315364.0, 315581.0, 316549.0, 319411.0, 320008.0, 35668.28663426717, 36327.0, 37072.25855482875, 37118.8144059278, 37258.254834903695, 35954.64045359513, 38086.80956595255, 38100.0, 38101.61898381036, 38170.0, 13919.582412527641, 13948.511802086878, 13966.86033139676, 13969.860301397059, 14030.508932187324, 12164.695882603006, 12179.695507612203, 12180.390980451119, 12220.572279970158, 12250.693732656755, 8690.000649925212, 8693.434926729742, 8697.0, 8729.869051964226, 8740.78148046304, 3338.9833050835077, 3398.9490157647656, 3401.5577974863604, 3413.5903691557173, 3433.9313213736086, 1083.6748975307376, 1118.4184224203368, 1195.8146487294484, 1196.4077781498213, 1292.4636275945566, 33333.3333333332, 33359.0, 33446.331073378395, 33889.32221355559, 34027.14932126716, 1138.347649975555, 1194.5401020607128, 1199.8980086692554, 1309.0, 1372.6568357910523, 16906.32374704998, 17090.743638845426, 17168.484945451655, 17373.218205180798, 17534.0, 513197.0, 513329.0, 515578.0, 517997.0, 519418.0, 59051.409485904594, 60283.69858150681, 60626.0, 60763.39236607577, 60843.0, 1433.6559225785736, 1444.0685757686445, 1454.3382760844001, 1456.8907331949933, 1458.2635768936618, 30590.84704576463, 31777.523337150422, 31953.680463196, 32287.35425291528, 32359.838200809787, 51868.481315186364, 52167.47832521778, 52247.21629175489, 52261.47738522566, 52407.47592524026, 338539.0, 339342.0, 339580.0, 340485.0, 341903.0, 28948.27629309284, 29323.560146598244, 46992.0, 48634.513654864415, 48774.268385973526, 47593.76203119101, 52101.47898521118, 52765.472345277594, 53261.7336913313, 53514.0, 42514.5748542523, 44098.77950610226, 44181.77909110434, 44220.778896105316, 44830.55169448264, 43607.690086717426, 44150.779246103564, 44954.3256851154, 45042.549574505145, 45249.32126018178, 44308.33537496876, 45537.31694024526, 45542.77228613836, 45631.54368456273, 45732.77133614311, 35317.82341088278, 36636.45045324376, 36648.26703465969, 37132.44301335536, 37738.245235095696, 28997.56503652489, 29033.419331613673, 29455.26361840971, 29471.55792663069, 29650.0], "value": 19118.37402956033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.3893720482071, 405.624797062717, 408.428200519273, 408.55467540380977, 426.3881330291031, 15865.286062127203, 18125.184366703495, 19233.0, 19940.10269537869, 19967.700484492725, 15969.84030159698, 16213.594660133473, 17876.55308617282, 19023.52441188971, 19202.327918522853, 5565.972170139144, 5577.247071645337, 5698.6865722385255, 5935.228420305354, 5956.940430595682, 5866.9706651466895, 5894.675792831393, 5910.1134829775665, 5913.674747888865, 5925.5555833312455, 5899.439553242435, 6476.093346931433, 6490.902636460457, 6505.6421896795655, 6506.0, 6257.7184026718905, 6358.745650173987, 6419.358064193543, 6487.610743355413, 6500.349965003509, 5645.181448689958, 5648.181013753024, 5702.45826646468, 5717.685527295997, 5737.7131143443075, 13340.599782006459, 16958.321667133423, 20147.79852201474, 22901.77098229013, 23023.76976230233, 2266.8073213776847, 2366.3847399676038, 2445.9510809783706, 2530.8101892358145, 2863.498887694645, 9969.750756231153, 10054.592357070016, 10115.595376184943, 10376.481175941248, 10618.150547956146, 1947.5617985953188, 1976.9209231630718, 1989.5424052468013, 2006.317851930336, 2052.1791283486577, 83259.16740832575, 83721.0, 83801.0, 83844.16155838425, 83913.58043209744, 10952.616658416917, 10960.397178155277, 11157.107431405468, 11176.720581985515, 11339.773204535863, 13316.334183290797, 14166.929165354108, 15714.371425142866, 15841.366345346287, 15855.127967961642, 8186.345092392594, 8192.877106843402, 8206.0, 8313.83372332562, 8367.330613550901, 7652.1582625911105, 7733.110692270461, 7830.804229894185, 7830.8433831323055, 7843.254890785366, 4733.171694953369, 4765.0946320199055, 4844.128056949783, 4916.434610019822, 4917.213245880642, 1995.670714332119, 2019.9192032318836, 2076.5743022680313, 2111.9894400528206, 2132.2323963373174, 1000.2248257600272, 1029.055085887673, 1040.3081950502983, 1068.9951445641072, 1087.3095584304024, 18094.63810723778, 18647.067646617616, 18744.53138671544, 19349.51626209356, 19518.5120371989, 1070.9625163119254, 1088.9128869690405, 1091.0126335666075, 1124.235519846496, 1135.5741596901162, 8256.504609723435, 10631.734206644896, 10744.516496757664, 10796.352218866894, 10909.618163364245, 450854.0, 453544.0, 454023.0, 459203.0, 489258.0, 88128.0, 88890.55554722185, 89017.0, 89228.0, 89952.0, 1056.3767377247461, 1077.5689724110418, 1078.2398409121552, 1082.5020490574425, 1084.7667751433637, 16767.413140540022, 17084.316627334767, 17129.14354282256, 17147.228374723418, 17502.91248543749, 38680.80659596684, 40137.39793903035, 40746.38880416737, 41063.589364105974, 42120.78939605282, 56440.0, 57285.71357143188, 59625.0, 59908.400915990285, 60137.0, 8777.956110219407, 8784.472931624123, 8897.065808090058, 9026.368154229142, 9049.321300902327, 12979.870201297867, 13552.322383880964, 13573.0, 13625.727485450434, 13697.726045479234, 12006.519739210335, 12028.338441385808, 12033.338166400932, 12039.939800300943, 12175.817362739388, 11570.026230029289, 11815.113866460222, 11845.5854045108, 11892.821607675718, 11944.581939632071, 12065.276083435023, 12272.325022123512, 12290.508379664714, 12324.260544367367, 12482.875171248172, 8580.957095214484, 8707.564621768759, 8789.34079943994, 8844.425112367675, 8865.379423440298, 8698.304135669257, 8811.955940220258, 8822.294216462797, 8955.328350373618, 9144.177024067865], "value": 9255.641930834698, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.469917878332, 1580.7470804671252, 1719.5872990482287, 1875.3061367294104, 1882.1624377152164, 8186.631601577928, 8586.0, 8903.777405564864, 9125.224355929753, 9192.080791920804, 9121.680741174061, 9202.723918282445, 9207.861882071775, 9299.256059515239, 9303.162715355616, 2222.2444368914526, 2249.572581209573, 2250.819934405252, 2252.0653928619604, 2259.8644081355087, 2317.0, 2338.6375111857687, 2358.6344116661858, 2369.5497855407416, 2370.502194539149, 2308.0652335804025, 2310.87290199039, 2320.4198950262435, 2335.0543030072763, 2360.327306717586, 2271.0802125139344, 2271.943201419961, 2280.7605201453857, 2285.5885940530698, 2285.5885940530698, 2263.603869322862, 2266.8866556672265, 2270.375646697155, 2270.943226419336, 2272.4318920269934, 9172.174504294579, 9176.724698258997, 9222.21611163052, 9255.398399104104, 9264.675736349196, 5217.765200565984, 5358.651687640291, 5362.302900622933, 5373.194020896858, 5373.194020896896, 3346.3474622448634, 3413.5903691556923, 3540.3627347077518, 3543.1496440854266, 3553.07620018797, 1151.8732939376662, 1156.8553930758655, 1162.1167912386563, 1202.4829323390938, 1226.6013545597716, 12773.936130319382, 12784.744305113938, 12869.67825804353, 12901.483940642269, 12904.612861614167, 4641.350210970467, 4801.29554008329, 4811.08589368019, 4814.15752243356, 4815.7351345676325, 10147.746306342253, 10188.490575471196, 10191.847122293171, 10201.948990255001, 10233.1301839343, 5203.375594928557, 5385.838424847261, 5409.972950135303, 5418.864528386822, 5429.049916264638, 4404.4494438195225, 4832.130216560982, 4987.775550100254, 4991.0, 5027.095122877844, 3855.0747820522874, 3905.72659913809, 3956.8812935611977, 3996.300647386696, 4161.167766446722, 1158.5887010111458, 1159.9420028998516, 1169.9415029248503, 1171.3264872698232, 1175.124532223499, 1045.9320144190604, 1050.0444595418132, 1065.3661071662348, 1068.5939343049747, 1077.6228320087907, 6193.84515387119, 6350.396712312323, 6413.486921046305, 6453.548251622341, 6518.706658200393, 458.5712358944398, 464.0857510703908, 466.6150425898579, 468.0685435982439, 469.38276166840495, 4262.190183865056, 4436.245838207448, 4456.62118719906, 4513.11994161142, 4590.540945905383, 10872.402017888933, 11180.664580062612, 11202.159838012181, 11249.887501125047, 11288.492017859217, 10818.404987725593, 11054.0, 11111.777764444827, 11116.777664446667, 11219.102471802236, 8288.336933045342, 8356.331493480508, 8395.076541580422, 8503.957480212559, 8512.148785121562, 6472.35276472349, 6555.2133743951035, 6612.305707900601, 6619.371159739817, 6694.564853284521, 10143.239257055899, 10628.096611787776, 10722.195835312226, 10872.67381978542, 10887.856775038823, 10616.469176540988, 10736.46317684097, 10809.837852432063, 10915.83626245591, 11094.278871873625, 7946.0, 8224.259816616533, 8246.587670616325, 8258.29804466603, 8443.788905277172, 9127.178553930178, 9136.26909847224, 9177.403468774508, 9239.445633262027, 9278.536073196177, 7865.803354916173, 8062.7581172564915, 8131.105578386255, 8216.671333146607, 8219.0, 7921.564313962787, 7930.801729956797, 8018.4787988780545, 8080.63637136342, 8222.547759873265, 7400.296971787671, 7417.777466676009, 7453.403727701662, 7471.364933980455, 7476.813079673052, 5309.734513274244, 5341.359036915595, 5437.646552974044, 5466.671999680032, 5480.040992826319, 5284.682919024717, 5392.838214853561, 5430.321209848769, 5461.1808228766, 5577.52591029767], "value": 4704.150291489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.3643268491811, 332.5377724962301, 337.98648054077836, 340.7512515863419, 348.88835572616773, 5636.2954630671165, 5716.685582292972, 5737.254156959594, 5761.608932293093, 5866.706664666771, 5602.187682785993, 5647.0, 5674.574406919487, 5688.0, 5701.372848986608, 4173.436586060889, 4364.498082720488, 4372.606465418112, 4372.912541749163, 4421.977890110545, 4261.829526818939, 4346.913061738764, 4349.978250108745, 4355.412019377391, 4401.559844015589, 4294.141171765644, 4329.631981281595, 4335.674824388184, 4358.5423530529315, 4361.302191649337, 4300.182965236626, 4329.913401731964, 4353.564643535653, 4386.385905973167, 4403.581659742319, 3784.1457685734067, 3803.7717736935874, 3807.7905715185652, 3814.866479673226, 3831.4252862070634, 5440.102383106782, 5463.48096930791, 5469.835904922858, 5481.12302031677, 5502.312210973629, 4994.700317980896, 4998.475160108209, 5001.799928002875, 5018.247262910556, 5027.673201241908, 5625.131183096651, 5926.733297001645, 5929.140274660193, 5929.436703513159, 5935.584509084366, 4188.937165942513, 4203.7687927164, 4210.221109094828, 4229.281022226229, 4241.512226094008, 6067.211262535886, 6146.539009574255, 6201.937980620181, 6204.81385558434, 6257.405546473078, 4211.768352740567, 4222.387753775685, 4235.8729238122905, 4252.277112890816, 4259.531451540328, 4270.081932384553, 4315.611594956469, 4315.8489452869, 4330.372096046056, 4333.8699839004885, 4782.426108866889, 4895.0, 4973.701577905337, 4997.425296090923, 5000.574951129122, 5932.940670593325, 5955.642661440241, 5992.910106348409, 6023.337432882379, 6067.75728970845, 1480.4078368652624, 1482.9184394858387, 1515.1363722678188, 1518.7038527487255, 1523.413485807972, 932.9626814927327, 953.3279038277998, 953.4316050097551, 971.9222462203007, 978.8498514245733, 5213.504717051874, 5606.570324567209, 5721.771129154788, 5753.88492230153, 5794.7838949383495, 6118.663473508911, 6150.938490615036, 6176.289726681399, 6188.381161883775, 6198.318184999646, 5520.392756796749, 5758.510526605285, 5784.913226301609, 5792.247007888947, 5800.53595712342, 3228.9838550807094, 3249.7725159238626, 3253.837308134584, 3280.3603297356785, 3297.0768184908266, 6307.590006649553, 6308.52686048539, 6354.332795056545, 6430.688195579281, 6446.806595802133, 5883.764649413975, 6199.752009919553, 6210.4100110489435, 6272.749090036439, 6295.622262664163, 6266.905996410058, 6338.080978258126, 6341.714622841983, 6342.334054924258, 6347.476605614619, 5946.73239704223, 6032.336442991355, 6093.969530152498, 6200.286966998672, 6218.595791273553, 6046.758129674764, 6095.238095238095, 6107.267127944675, 6111.96944015277, 6128.724207410588, 6087.634741915499, 6221.5333849960525, 6332.398422149889, 6340.9365906340345, 6378.799314236581, 4278.507971583308, 4314.460692413449, 4318.157959197926, 4324.394584758199, 4338.132373525371, 6216.937830621817, 6243.282022567463, 6249.437550620466, 6288.0, 6315.336889626523, 5816.47651711348, 5947.364474769473, 5968.0, 5996.640201587918, 6056.9697151513965, 6017.676111255517, 6026.517878569616, 6039.305479869871, 6056.788012419544, 6079.0, 5766.250387449605, 5799.797007104731, 5906.822795316148, 5944.910826337522, 5956.374580668968, 5966.671833049224, 5993.460588547052, 6019.458248757633, 6035.69821508914, 6036.909446358396, 5856.092305692625, 5892.234009578728, 5903.616264942765, 5940.158550849251, 5984.401559843981], "value": 4515.754501021441, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.3827214772476, 817.6565842346216, 840.3403328387217, 840.7397321318048, 854.2183901729917, 14212.21832799197, 14674.486392976249, 14765.0, 14777.261136943163, 14856.108633482, 12214.389280535983, 14548.127112373266, 14596.781048284285, 14598.270086495686, 14614.050086744353, 831.413853233472, 846.5301757524571, 851.4465597361702, 856.8671855862351, 857.7598272483715, 837.2757564706516, 845.9365547583925, 847.5380917400032, 848.6732607945924, 849.8215374771305, 900.7027680865332, 904.0642934562729, 905.2079430498314, 905.483874191711, 905.6694306578117, 903.2548147778109, 904.398574947659, 904.9819003619924, 905.3933864310894, 906.4878343735768, 653.3074940563018, 654.0124412137659, 654.89521676532, 654.934506549346, 656.5896314803248, 14324.355404006845, 14580.270986450741, 14609.196494192814, 14615.853841461556, 14727.0, 13424.32878356088, 13461.326933653278, 13512.189268643913, 13570.93214533921, 13964.092333998258, 11505.252158609663, 11506.884931150666, 11625.360605166712, 11669.124815638861, 11828.172027958046, 3871.845126194949, 3972.5431575368625, 4001.339778936472, 4010.218007488541, 4030.919381612351, 59229.703851480466, 59489.0, 60107.69946150285, 60293.39706602922, 61461.69269153626, 10836.620718274822, 10854.67435976922, 10956.178286628534, 10987.505562249718, 11092.722681932855, 18657.720134197996, 18684.53288667767, 18744.188371744076, 18795.90602046981, 18805.0, 7862.0, 7979.9601001994615, 8012.7980802878865, 8104.797380065545, 8112.878306825402, 4571.634269258451, 4741.715497070187, 4833.782479788418, 4867.902641947141, 5019.774110165052, 3426.640202778722, 3446.2245994651503, 3484.2508860595094, 3501.7373696972827, 3519.085037890167, 703.6938931564786, 703.7466512055656, 710.4458522352573, 715.4169351978226, 716.4340171264747, 650.2944305428568, 703.5391818358983, 723.9611157988304, 769.2461387839949, 774.1059076766344, 9915.206783457306, 9975.950120249352, 9997.550110245056, 10068.144207742424, 10072.748181295527, 751.3538357012965, 755.8828381600861, 758.9962050189714, 762.7101701353561, 779.2207792207793, 4623.306504024356, 4624.930626040612, 4836.870854854189, 4896.290037944478, 4986.775595098229, 72713.6364318175, 74250.628746857, 75102.0, 75637.62181189058, 76381.23618763853, 63579.0, 65441.0, 65580.67209663922, 67815.66092169606, 68508.3149168502, 52859.20711189258, 55866.999999999185, 61779.0, 62100.68949655313, 62695.6865215671, 9966.152877005536, 9993.850092248476, 10267.84598231042, 10400.58397664085, 10482.947585262025, 37115.44326835153, 37303.25393492169, 37630.811845940596, 37689.81155094207, 37971.240575188895, 48950.0, 49865.252021218985, 49900.25149622831, 50664.74667626638, 51163.48836511736, 13058.0, 13175.934120329337, 13203.405846736729, 13269.867301326864, 13526.797098043735, 14244.857551424768, 14370.281485925452, 14529.128252304896, 14582.781258280922, 14875.776863347275, 12513.687157821127, 12922.741545169232, 13117.08180427361, 13364.398602063126, 13584.592462226148, 12486.625401237978, 13138.80291795643, 13811.79282310746, 13831.930840345734, 14261.857381426467, 11667.241629294069, 12043.518259269531, 12579.433925473559, 12640.55758048464, 12951.481940722266, 9942.254330925354, 9978.800423991624, 10295.639652612123, 10304.690859274233, 10617.362958222531, 10695.465226738788, 10817.837732434176, 10875.782484350428, 10879.51042203087, 10937.781244374908], "value": 7122.89443011275, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 103.0, 109.0, 115.0, 110.0, 105.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 150.0, 204.0, 129.0, 161.0, 155.0, 127.0, 188.0, 126.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 160.0, 165.0, 173.0, 162.0, 161.0, 160.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 171.0, 76.0, 74.0, 74.0, 75.0, 158.0, 75.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 181.0, 92.0, 92.0, 93.0, 144.0, 93.0, 93.0, 145.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 57.0, 56.0, 60.0, 107.0, 54.0, 53.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 61.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 79.0, 78.0, 79.0, 80.0, 79.0, 79.0, 81.0, 85.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 120.0, 123.0, 135.0, 129.0, 117.0, 123.0, 126.0, 188.0, 135.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 167.0, 159.0, 165.0, 161.0, 157.0, 159.0, 157.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 62.0, 63.0, 65.0, 63.0, 63.0, 64.0, 62.0], "value": 63.5, "unit": "score"}]}]} 10:29:08 INFO - Return code: 0 10:29:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:08 ERROR - # TBPL SUCCESS # 10:29:08 INFO - Running post-action listener: _resource_record_post_action 10:29:08 INFO - ##### 10:29:08 INFO - ##### Finished run-tests step (success) 10:29:08 INFO - ##### 10:29:08 INFO - Running post-run listener: _resource_record_post_run 10:29:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7979008; Write bytes: 428249088; Read time: 1800; Write time: 447772 10:29:08 INFO - TinderboxPrint: CPU usage
13.4% 10:29:08 INFO - TinderboxPrint: I/O read bytes / time
7,979,008 / 1,800 10:29:08 INFO - TinderboxPrint: I/O write bytes / time
428,249,088 / 447,772 10:29:08 INFO - TinderboxPrint: CPU idle
8,245.9 (86.6%) 10:29:08 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%) 10:29:08 INFO - TinderboxPrint: Swap in / out
0 / 0 10:29:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 72249344; Read time: 0; Write time: 45156 10:29:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6242304; Write bytes: 326541312; Read time: 1776; Write time: 354588 10:29:08 INFO - Running post-run listener: _upload_blobber_files 10:29:08 INFO - Blob upload gear active. 10:29:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:08 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 10:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:29:09 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:10 INFO - (blobuploader) - INFO - Done attempting. 10:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:10 INFO - (blobuploader) - INFO - Done attempting. 10:29:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:14 INFO - (blobuploader) - INFO - Done attempting. 10:29:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:14 INFO - Return code: 0 10:29:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9a4577da45cdf379588efb0ab5787b36ae45118080a3aec7ebdb3a0b16c1c03207c3851da9fa79307874bc41c8e6d342f366793713b1980dc6db8a6494fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5735d847f7a584ce7ac0f99abeaa929ac37addd87e19e80ae79c8061cd5685e20930ef1446a3ab7a24bc1b0249d57a5fabbcc62b84d147fbf4881f5eb319a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ae6437b313d59927f0ddb5d9a13f47a0909c4620396e1019eb9bbf562e468b1631c4769009255f1fee7fb1d29d9a0a1e153ab4c9d32c97f115e7d659166e072"} 10:29:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:14 INFO - Contents: 10:29:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9a4577da45cdf379588efb0ab5787b36ae45118080a3aec7ebdb3a0b16c1c03207c3851da9fa79307874bc41c8e6d342f366793713b1980dc6db8a6494fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5735d847f7a584ce7ac0f99abeaa929ac37addd87e19e80ae79c8061cd5685e20930ef1446a3ab7a24bc1b0249d57a5fabbcc62b84d147fbf4881f5eb319a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ae6437b313d59927f0ddb5d9a13f47a0909c4620396e1019eb9bbf562e468b1631c4769009255f1fee7fb1d29d9a0a1e153ab4c9d32c97f115e7d659166e072"} 10:29:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:14 INFO - Copying logs to upload dir... 10:29:14 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.646853 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-19 10:29:14.691154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:29:14.694939) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9a4577da45cdf379588efb0ab5787b36ae45118080a3aec7ebdb3a0b16c1c03207c3851da9fa79307874bc41c8e6d342f366793713b1980dc6db8a6494fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5735d847f7a584ce7ac0f99abeaa929ac37addd87e19e80ae79c8061cd5685e20930ef1446a3ab7a24bc1b0249d57a5fabbcc62b84d147fbf4881f5eb319a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ae6437b313d59927f0ddb5d9a13f47a0909c4620396e1019eb9bbf562e468b1631c4769009255f1fee7fb1d29d9a0a1e153ab4c9d32c97f115e7d659166e072"} build_url:https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/dSaXlhBUShSBevz3dtgmVA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9a4577da45cdf379588efb0ab5787b36ae45118080a3aec7ebdb3a0b16c1c03207c3851da9fa79307874bc41c8e6d342f366793713b1980dc6db8a6494fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5735d847f7a584ce7ac0f99abeaa929ac37addd87e19e80ae79c8061cd5685e20930ef1446a3ab7a24bc1b0249d57a5fabbcc62b84d147fbf4881f5eb319a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ae6437b313d59927f0ddb5d9a13f47a0909c4620396e1019eb9bbf562e468b1631c4769009255f1fee7fb1d29d9a0a1e153ab4c9d32c97f115e7d659166e072"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:29:14.722336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:29:14.722907) ========= 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=4ac8d263c7293b36a1be1aed000001be-1463675795.409217-179352299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:29:14.806593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:29:14.807041) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:29:14.807489) ========= ========= Total master_lag: 0.21 =========