builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1464812757.83 results: success (0) buildid: 20160601115742 builduid: 71f90a3874f84c86a34a3adaf2fccb01 revision: 248d35aedf8866d3b5bf747324a1384aa1228d8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.828749) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.829180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.829470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.843855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.844150) ========= 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=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 13:25:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.8M=0s 2016-06-01 13:25:58 (65.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116670 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.974525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:57.974834) ========= 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=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020464 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:58.024350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 13:25:58.024716) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 248d35aedf8866d3b5bf747324a1384aa1228d8e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 248d35aedf8866d3b5bf747324a1384aa1228d8e --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=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 13:25:58,139 truncating revision to first 12 chars 2016-06-01 13:25:58,139 Setting DEBUG logging. 2016-06-01 13:25:58,139 attempt 1/10 2016-06-01 13:25:58,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/248d35aedf88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 13:25:59,455 unpacking tar archive at: larch-248d35aedf88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.671216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 13:25:59.709627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:59.709951) ========= script_repo_revision: 248d35aedf8866d3b5bf747324a1384aa1228d8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:59.710384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:59.710694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 13:25:59.721615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-01 13:25:59.721957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:59 INFO - MultiFileLogger online at 20160601 13:25:59 in /builds/slave/test 13:25:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:25:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:59 INFO - {'append_to_log': False, 13:25:59 INFO - 'base_work_dir': '/builds/slave/test', 13:25:59 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:25:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:59 INFO - 'branch': 'Larch-Non-PGO', 13:25:59 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:59 INFO - 'config_files': ('talos/linux_config.py',), 13:25:59 INFO - 'default_actions': ('clobber', 13:25:59 INFO - 'read-buildbot-config', 13:25:59 INFO - 'download-and-extract', 13:25:59 INFO - 'populate-webroot', 13:25:59 INFO - 'create-virtualenv', 13:25:59 INFO - 'install', 13:25:59 INFO - 'run-tests'), 13:25:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:59 INFO - 'download_minidump_stackwalk': True, 13:25:59 INFO - 'download_symbols': 'ondemand', 13:25:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:59 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:59 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:59 INFO - 'installer_path': 'installer.exe', 13:25:59 INFO - 'log_level': 'info', 13:25:59 INFO - 'log_name': 'talos', 13:25:59 INFO - 'log_to_console': True, 13:25:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:59 INFO - 'opt_config_files': (), 13:25:59 INFO - 'pip_index': False, 13:25:59 INFO - 'sps_profile': False, 13:25:59 INFO - 'sps_profile_interval': 0, 13:25:59 INFO - 'suite': 'dromaeojs', 13:25:59 INFO - 'system_bits': '32', 13:25:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:59 INFO - 'title': 'talos-linux64-ix-016', 13:25:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:59 INFO - 'use_talos_json': True, 13:25:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:59 INFO - 'work_dir': 'build'} 13:25:59 INFO - ##### 13:25:59 INFO - ##### Running clobber step. 13:25:59 INFO - ##### 13:25:59 INFO - Running pre-action listener: _resource_record_pre_action 13:25:59 INFO - Running main action method: clobber 13:25:59 INFO - rmtree: /builds/slave/test/build 13:25:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:00 INFO - Running post-action listener: _resource_record_post_action 13:26:00 INFO - ##### 13:26:00 INFO - ##### Finished clobber step (success) 13:26:00 INFO - ##### 13:26:00 INFO - ##### 13:26:00 INFO - ##### Running read-buildbot-config step. 13:26:00 INFO - ##### 13:26:00 INFO - Running pre-action listener: _resource_record_pre_action 13:26:00 INFO - Running main action method: read_buildbot_config 13:26:00 INFO - Using buildbot properties: 13:26:00 INFO - { 13:26:00 INFO - "project": "", 13:26:00 INFO - "product": "firefox", 13:26:00 INFO - "script_repo_revision": "production", 13:26:00 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 13:26:00 INFO - "repository": "", 13:26:00 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 13:26:00 INFO - "buildid": "20160601115742", 13:26:00 INFO - "pgo_build": "False", 13:26:00 INFO - "basedir": "/builds/slave/test", 13:26:00 INFO - "buildnumber": 4, 13:26:00 INFO - "slavename": "talos-linux64-ix-016", 13:26:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:26:00 INFO - "platform": "ubuntu64_hw", 13:26:00 INFO - "scheduler": "tests-larch-linux64-talos", 13:26:00 INFO - "branch": "larch", 13:26:00 INFO - "repo_path": "projects/larch", 13:26:00 INFO - "revision": "248d35aedf8866d3b5bf747324a1384aa1228d8e", 13:26:00 INFO - "stage_platform": "linux64", 13:26:00 INFO - "builduid": "71f90a3874f84c86a34a3adaf2fccb01", 13:26:00 INFO - "slavebuilddir": "test" 13:26:00 INFO - } 13:26:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:26:00 INFO - Running post-action listener: _resource_record_post_action 13:26:00 INFO - ##### 13:26:00 INFO - ##### Finished read-buildbot-config step (success) 13:26:00 INFO - ##### 13:26:00 INFO - ##### 13:26:00 INFO - ##### Running download-and-extract step. 13:26:00 INFO - ##### 13:26:00 INFO - Running pre-action listener: _resource_record_pre_action 13:26:00 INFO - Running main action method: download_and_extract 13:26:00 INFO - mkdir: /builds/slave/test/build/tests 13:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:00 INFO - https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:01 INFO - Downloaded 1361 bytes. 13:26:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:26:01 INFO - Using the following test package requirements: 13:26:01 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:26:01 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:26:01 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:26:01 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'jsshell-linux-x86_64.zip'], 13:26:01 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:26:01 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:26:01 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:26:01 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:26:01 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:26:01 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:26:01 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:26:01 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:26: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')]} 13:26:01 INFO - https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:26:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:26:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:26:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:02 INFO - Downloaded 22849679 bytes. 13:26:02 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'] 13:26:02 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 13:26:03 INFO - Return code: 0 13:26:03 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 13:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:03 INFO - https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:26:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:26:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:26:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:04 INFO - Downloaded 22849679 bytes. 13:26:04 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'] 13:26:04 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 13:26:05 INFO - Return code: 0 13:26:05 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')]} 13:26:05 INFO - https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:26:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:26:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:26:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:07 INFO - Downloaded 10834063 bytes. 13:26:07 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'] 13:26:07 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 13:26:07 INFO - Return code: 0 13:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:07 INFO - https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:26:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:26:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:26:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a_Pw3LFgQhepDecHX_WHxQ/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 13:26:08 INFO - Downloaded 55157250 bytes. 13:26:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:26:08 INFO - mkdir: /builds/slave/test/properties 13:26:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:08 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:08 INFO - Contents: 13:26:08 INFO - build_url:https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:26:09 INFO - Running post-action listener: _resource_record_post_action 13:26:09 INFO - Running post-action listener: set_extra_try_arguments 13:26:09 INFO - ##### 13:26:09 INFO - ##### Finished download-and-extract step (success) 13:26:09 INFO - ##### 13:26:09 INFO - ##### 13:26:09 INFO - ##### Running populate-webroot step. 13:26:09 INFO - ##### 13:26:09 INFO - Running pre-action listener: _resource_record_pre_action 13:26:09 INFO - Running main action method: populate_webroot 13:26:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:09 INFO - '--tppagecycles', 13:26:09 INFO - '7'], 13:26:09 INFO - 'tests': ['tsvgm']}}, 13:26:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['damp', 'tps']}, 13:26:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'tests': ['damp', 'tps']}, 13:26:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['dromaeo_dom']}, 13:26:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['a11yr', 13:26:09 INFO - 'ts_paint', 13:26:09 INFO - 'tpaint', 13:26:09 INFO - 'sessionrestore', 13:26:09 INFO - 'sessionrestore_no_auto_restore', 13:26:09 INFO - 'tabpaint']}, 13:26:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['tsvgx', 13:26:09 INFO - 'tsvgr_opacity', 13:26:09 INFO - 'tart', 13:26:09 INFO - 'tscrollx', 13:26:09 INFO - 'cart']}, 13:26:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:09 INFO - 'tsvgr_opacity', 13:26:09 INFO - 'tart', 13:26:09 INFO - 'tscrollx', 13:26:09 INFO - 'cart']}, 13:26:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'talos_options': ['--disable-e10s'], 13:26:09 INFO - 'tests': ['tp5o']}, 13:26:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'tests': ['tp5o']}, 13:26:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'talos_options': ['--disable-e10s', 13:26:09 INFO - '--xperf_path', 13:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:09 INFO - 'tests': ['tp5n']}, 13:26:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:09 INFO - 'talos_options': ['--xperf_path', 13:26:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:09 INFO - 'tests': ['tp5n']}}, 13:26:09 INFO - 'talos.zip': {'path': '', 13:26:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:09 INFO - Running post-action listener: _resource_record_post_action 13:26:09 INFO - ##### 13:26:09 INFO - ##### Finished populate-webroot step (success) 13:26:09 INFO - ##### 13:26:09 INFO - ##### 13:26:09 INFO - ##### Running create-virtualenv step. 13:26:09 INFO - ##### 13:26:09 INFO - Running pre-action listener: _resource_record_pre_action 13:26:09 INFO - Running main action method: create_virtualenv 13:26:09 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:09 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 13:26:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:09 INFO - Using real prefix '/usr' 13:26:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:10 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:12 INFO - Installing pip.................done. 13:26:12 INFO - Return code: 0 13:26:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:12 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 13:26:12 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 13:26:12 INFO - Using env: {'DISPLAY': ':0', 13:26:12 INFO - 'HOME': '/home/cltbld', 13:26:12 INFO - 'LANG': 'en_US.UTF-8', 13:26:12 INFO - 'LANGUAGE': 'en_US:en', 13:26:12 INFO - 'LOGNAME': 'cltbld', 13:26:12 INFO - 'MAIL': '/var/mail/cltbld', 13:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:12 INFO - 'MOZ_NO_REMOTE': '1', 13:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:12 INFO - 'NO_EM_RESTART': '1', 13:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:12 INFO - 'PWD': '/builds/slave/test', 13:26:12 INFO - 'SHELL': '/bin/bash', 13:26:12 INFO - 'SHLVL': '1', 13:26:12 INFO - 'TERM': 'linux', 13:26:12 INFO - 'TMOUT': '86400', 13:26:12 INFO - 'USER': 'cltbld', 13:26:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:12 INFO - '_': '/tools/buildbot/bin/python'} 13:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:12 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 13:26:12 INFO - Cleaning up... 13:26:12 INFO - Return code: 0 13:26:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:12 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:12 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 13:26:12 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 13:26:12 INFO - Using env: {'DISPLAY': ':0', 13:26:12 INFO - 'HOME': '/home/cltbld', 13:26:12 INFO - 'LANG': 'en_US.UTF-8', 13:26:12 INFO - 'LANGUAGE': 'en_US:en', 13:26:12 INFO - 'LOGNAME': 'cltbld', 13:26:12 INFO - 'MAIL': '/var/mail/cltbld', 13:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:12 INFO - 'MOZ_NO_REMOTE': '1', 13:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:12 INFO - 'NO_EM_RESTART': '1', 13:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:12 INFO - 'PWD': '/builds/slave/test', 13:26:12 INFO - 'SHELL': '/bin/bash', 13:26:12 INFO - 'SHLVL': '1', 13:26:12 INFO - 'TERM': 'linux', 13:26:12 INFO - 'TMOUT': '86400', 13:26:12 INFO - 'USER': 'cltbld', 13:26:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:12 INFO - '_': '/tools/buildbot/bin/python'} 13:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:12 INFO - Downloading/unpacking psutil>=3.1.1 13:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:14 INFO - Installing collected packages: psutil 13:26:14 INFO - Running setup.py install for psutil 13:26:14 INFO - building 'psutil._psutil_linux' extension 13:26:14 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 13:26:14 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 13:26:14 INFO - building 'psutil._psutil_posix' extension 13:26:14 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 13:26:14 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 13:26:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:15 INFO - Successfully installed psutil 13:26:15 INFO - Cleaning up... 13:26:15 INFO - Return code: 0 13:26:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:26:15 INFO - Using env: {'DISPLAY': ':0', 13:26:15 INFO - 'HOME': '/home/cltbld', 13:26:15 INFO - 'LANG': 'en_US.UTF-8', 13:26:15 INFO - 'LANGUAGE': 'en_US:en', 13:26:15 INFO - 'LOGNAME': 'cltbld', 13:26:15 INFO - 'MAIL': '/var/mail/cltbld', 13:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:15 INFO - 'MOZ_NO_REMOTE': '1', 13:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:15 INFO - 'NO_EM_RESTART': '1', 13:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:15 INFO - 'PWD': '/builds/slave/test', 13:26:15 INFO - 'SHELL': '/bin/bash', 13:26:15 INFO - 'SHLVL': '1', 13:26:15 INFO - 'TERM': 'linux', 13:26:15 INFO - 'TMOUT': '86400', 13:26:15 INFO - 'USER': 'cltbld', 13:26:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:15 INFO - '_': '/tools/buildbot/bin/python'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:17 INFO - Installing collected packages: mozsystemmonitor 13:26:17 INFO - Running setup.py install for mozsystemmonitor 13:26:17 INFO - Successfully installed mozsystemmonitor 13:26:17 INFO - Cleaning up... 13:26:17 INFO - Return code: 0 13:26:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:26:17 INFO - Using env: {'DISPLAY': ':0', 13:26:17 INFO - 'HOME': '/home/cltbld', 13:26:17 INFO - 'LANG': 'en_US.UTF-8', 13:26:17 INFO - 'LANGUAGE': 'en_US:en', 13:26:17 INFO - 'LOGNAME': 'cltbld', 13:26:17 INFO - 'MAIL': '/var/mail/cltbld', 13:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:17 INFO - 'MOZ_NO_REMOTE': '1', 13:26:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:17 INFO - 'NO_EM_RESTART': '1', 13:26:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:17 INFO - 'PWD': '/builds/slave/test', 13:26:17 INFO - 'SHELL': '/bin/bash', 13:26:17 INFO - 'SHLVL': '1', 13:26:17 INFO - 'TERM': 'linux', 13:26:17 INFO - 'TMOUT': '86400', 13:26:17 INFO - 'USER': 'cltbld', 13:26:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:17 INFO - '_': '/tools/buildbot/bin/python'} 13:26:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:17 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:19 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:20 INFO - Downloading docopt-0.6.1.tar.gz 13:26:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:20 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:20 INFO - Running setup.py install for blobuploader 13:26:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:20 INFO - Running setup.py install for requests 13:26:20 INFO - Running setup.py install for docopt 13:26:20 INFO - Successfully installed blobuploader requests docopt 13:26:20 INFO - Cleaning up... 13:26:20 INFO - Return code: 0 13:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:20 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 13:26:20 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 13:26:20 INFO - Using env: {'DISPLAY': ':0', 13:26:20 INFO - 'HOME': '/home/cltbld', 13:26:20 INFO - 'LANG': 'en_US.UTF-8', 13:26:20 INFO - 'LANGUAGE': 'en_US:en', 13:26:20 INFO - 'LOGNAME': 'cltbld', 13:26:20 INFO - 'MAIL': '/var/mail/cltbld', 13:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:20 INFO - 'MOZ_NO_REMOTE': '1', 13:26:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:20 INFO - 'NO_EM_RESTART': '1', 13:26:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:20 INFO - 'PWD': '/builds/slave/test', 13:26:20 INFO - 'SHELL': '/bin/bash', 13:26:20 INFO - 'SHLVL': '1', 13:26:20 INFO - 'TERM': 'linux', 13:26:20 INFO - 'TMOUT': '86400', 13:26:20 INFO - 'USER': 'cltbld', 13:26:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:20 INFO - '_': '/tools/buildbot/bin/python'} 13:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:21 INFO - Running setup.py (path:/tmp/pip-0AHbUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:21 INFO - Running setup.py (path:/tmp/pip-TgvfaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:21 INFO - Running setup.py (path:/tmp/pip-YqM456-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:21 INFO - Running setup.py (path:/tmp/pip-QppLEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:21 INFO - Running setup.py (path:/tmp/pip-Ej_WZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:21 INFO - Running setup.py (path:/tmp/pip-z6IhcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:21 INFO - Running setup.py (path:/tmp/pip-4lHDfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:21 INFO - Running setup.py (path:/tmp/pip-euz2CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:21 INFO - Running setup.py (path:/tmp/pip-pZHi7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:21 INFO - Running setup.py (path:/tmp/pip-rI53_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:21 INFO - Running setup.py (path:/tmp/pip-AcRRdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:21 INFO - Running setup.py (path:/tmp/pip-tg6I8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:21 INFO - Running setup.py (path:/tmp/pip-MQb1rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:22 INFO - Running setup.py (path:/tmp/pip-uWBsfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:22 INFO - Running setup.py (path:/tmp/pip-ZTmoY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:22 INFO - Running setup.py (path:/tmp/pip-eYO5Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:22 INFO - Running setup.py (path:/tmp/pip-InA_20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:22 INFO - Running setup.py install for manifestparser 13:26:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:22 INFO - Running setup.py install for mozcrash 13:26:22 INFO - Running setup.py install for mozdebug 13:26:22 INFO - Running setup.py install for mozdevice 13:26:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:22 INFO - Running setup.py install for mozfile 13:26:22 INFO - Running setup.py install for mozhttpd 13:26:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:22 INFO - Running setup.py install for mozinfo 13:26:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for mozInstall 13:26:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for mozleak 13:26:23 INFO - Running setup.py install for mozlog 13:26:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for moznetwork 13:26:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for mozprocess 13:26:23 INFO - Running setup.py install for mozprofile 13:26:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for mozrunner 13:26:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:23 INFO - Running setup.py install for mozscreenshot 13:26:23 INFO - Running setup.py install for moztest 13:26:23 INFO - Running setup.py install for mozversion 13:26:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:24 INFO - Cleaning up... 13:26:24 INFO - Return code: 0 13:26:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:24 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:24 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 13:26:24 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 13:26:24 INFO - Using env: {'DISPLAY': ':0', 13:26:24 INFO - 'HOME': '/home/cltbld', 13:26:24 INFO - 'LANG': 'en_US.UTF-8', 13:26:24 INFO - 'LANGUAGE': 'en_US:en', 13:26:24 INFO - 'LOGNAME': 'cltbld', 13:26:24 INFO - 'MAIL': '/var/mail/cltbld', 13:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:24 INFO - 'MOZ_NO_REMOTE': '1', 13:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:24 INFO - 'NO_EM_RESTART': '1', 13:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:24 INFO - 'PWD': '/builds/slave/test', 13:26:24 INFO - 'SHELL': '/bin/bash', 13:26:24 INFO - 'SHLVL': '1', 13:26:24 INFO - 'TERM': 'linux', 13:26:24 INFO - 'TMOUT': '86400', 13:26:24 INFO - 'USER': 'cltbld', 13:26:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:24 INFO - '_': '/tools/buildbot/bin/python'} 13:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:24 INFO - Running setup.py (path:/tmp/pip-VyoggX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:24 INFO - Running setup.py (path:/tmp/pip-0Z_38q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:24 INFO - Running setup.py (path:/tmp/pip-k5okGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:24 INFO - Running setup.py (path:/tmp/pip-m01AEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:24 INFO - Running setup.py (path:/tmp/pip-Sv69_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:24 INFO - Running setup.py (path:/tmp/pip-BHtHLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:24 INFO - Running setup.py (path:/tmp/pip-XPlDpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:24 INFO - Running setup.py (path:/tmp/pip-69wcYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:24 INFO - Running setup.py (path:/tmp/pip-IdsrPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:24 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)) 13:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:24 INFO - Running setup.py (path:/tmp/pip-vrwSAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:25 INFO - Running setup.py (path:/tmp/pip-b5J_HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:25 INFO - Running setup.py (path:/tmp/pip-_LDJXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:25 INFO - Running setup.py (path:/tmp/pip-22TmkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:25 INFO - Running setup.py (path:/tmp/pip-X2fy_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:25 INFO - Running setup.py (path:/tmp/pip-YpJ1OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:25 INFO - Running setup.py (path:/tmp/pip-9U6sRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:25 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)) 13:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:25 INFO - Running setup.py (path:/tmp/pip-H7TFvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:25 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)) 13:26:25 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)) 13:26:25 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)) 13:26:25 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)) 13:26:25 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)) 13:26:25 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)) 13:26:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:27 INFO - Downloading blessings-1.6.tar.gz 13:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:27 INFO - Installing collected packages: blessings 13:26:27 INFO - Running setup.py install for blessings 13:26:27 INFO - Successfully installed blessings 13:26:27 INFO - Cleaning up... 13:26:27 INFO - Return code: 0 13:26:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:27 INFO - Reading from file tmpfile_stdout 13:26:27 INFO - Current package versions: 13:26:27 INFO - argparse == 1.2.1 13:26:27 INFO - blessings == 1.6 13:26:27 INFO - blobuploader == 1.2.4 13:26:27 INFO - docopt == 0.6.1 13:26:27 INFO - manifestparser == 1.1 13:26:27 INFO - mozInstall == 1.12 13:26:27 INFO - mozcrash == 0.17 13:26:27 INFO - mozdebug == 0.1 13:26:27 INFO - mozdevice == 0.48 13:26:27 INFO - mozfile == 1.2 13:26:27 INFO - mozhttpd == 0.7 13:26:27 INFO - mozinfo == 0.9 13:26:27 INFO - mozleak == 0.1 13:26:27 INFO - mozlog == 3.2 13:26:27 INFO - moznetwork == 0.27 13:26:27 INFO - mozprocess == 0.22 13:26:27 INFO - mozprofile == 0.28 13:26:27 INFO - mozrunner == 6.11 13:26:27 INFO - mozscreenshot == 0.1 13:26:27 INFO - mozsystemmonitor == 0.3 13:26:27 INFO - moztest == 0.7 13:26:27 INFO - mozversion == 1.4 13:26:27 INFO - psutil == 3.1.1 13:26:27 INFO - requests == 1.2.3 13:26:27 INFO - wsgiref == 0.1.2 13:26:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:27 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 13:26:27 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 13:26:27 INFO - Using env: {'DISPLAY': ':0', 13:26:27 INFO - 'HOME': '/home/cltbld', 13:26:27 INFO - 'LANG': 'en_US.UTF-8', 13:26:27 INFO - 'LANGUAGE': 'en_US:en', 13:26:27 INFO - 'LOGNAME': 'cltbld', 13:26:27 INFO - 'MAIL': '/var/mail/cltbld', 13:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:27 INFO - 'MOZ_NO_REMOTE': '1', 13:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:27 INFO - 'NO_EM_RESTART': '1', 13:26:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:27 INFO - 'PWD': '/builds/slave/test', 13:26:27 INFO - 'SHELL': '/bin/bash', 13:26:27 INFO - 'SHLVL': '1', 13:26:27 INFO - 'TERM': 'linux', 13:26:27 INFO - 'TMOUT': '86400', 13:26:27 INFO - 'USER': 'cltbld', 13:26:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:27 INFO - '_': '/tools/buildbot/bin/python'} 13:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 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)) 13:26:28 INFO - Cleaning up... 13:26:28 INFO - Return code: 0 13:26:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:28 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:28 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 13:26:28 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 13:26:28 INFO - Using env: {'DISPLAY': ':0', 13:26:28 INFO - 'HOME': '/home/cltbld', 13:26:28 INFO - 'LANG': 'en_US.UTF-8', 13:26:28 INFO - 'LANGUAGE': 'en_US:en', 13:26:28 INFO - 'LOGNAME': 'cltbld', 13:26:28 INFO - 'MAIL': '/var/mail/cltbld', 13:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:28 INFO - 'MOZ_NO_REMOTE': '1', 13:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:28 INFO - 'NO_EM_RESTART': '1', 13:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:28 INFO - 'PWD': '/builds/slave/test', 13:26:28 INFO - 'SHELL': '/bin/bash', 13:26:28 INFO - 'SHLVL': '1', 13:26:28 INFO - 'TERM': 'linux', 13:26:28 INFO - 'TMOUT': '86400', 13:26:28 INFO - 'USER': 'cltbld', 13:26:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:28 INFO - '_': '/tools/buildbot/bin/python'} 13:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:28 INFO - Downloading/unpacking jsonschema 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:30 INFO - Downloading/unpacking functools32 (from jsonschema) 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:30 INFO - warning: no files found matching '*.txt' 13:26:30 INFO - no previously-included directories found matching 'build' 13:26:30 INFO - no previously-included directories found matching 'dist' 13:26:30 INFO - no previously-included directories found matching '.git*' 13:26:30 INFO - Installing collected packages: jsonschema, functools32 13:26:30 INFO - Running setup.py install for functools32 13:26:30 INFO - warning: no files found matching '*.txt' 13:26:30 INFO - no previously-included directories found matching 'build' 13:26:30 INFO - no previously-included directories found matching 'dist' 13:26:30 INFO - no previously-included directories found matching '.git*' 13:26:30 INFO - Successfully installed jsonschema functools32 13:26:30 INFO - Cleaning up... 13:26:30 INFO - Return code: 0 13:26:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:26:30 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')]} 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:30 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')]} 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:30 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 0x7fd1eea0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2540770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, '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': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', '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 13:26:30 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 13:26:30 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 13:26:30 INFO - Using env: {'DISPLAY': ':0', 13:26:30 INFO - 'HOME': '/home/cltbld', 13:26:30 INFO - 'LANG': 'en_US.UTF-8', 13:26:30 INFO - 'LANGUAGE': 'en_US:en', 13:26:30 INFO - 'LOGNAME': 'cltbld', 13:26:30 INFO - 'MAIL': '/var/mail/cltbld', 13:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:30 INFO - 'MOZ_NO_REMOTE': '1', 13:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:30 INFO - 'NO_EM_RESTART': '1', 13:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:30 INFO - 'PWD': '/builds/slave/test', 13:26:30 INFO - 'SHELL': '/bin/bash', 13:26:30 INFO - 'SHLVL': '1', 13:26:30 INFO - 'TERM': 'linux', 13:26:30 INFO - 'TMOUT': '86400', 13:26:30 INFO - 'USER': 'cltbld', 13:26:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:30 INFO - '_': '/tools/buildbot/bin/python'} 13:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:30 INFO - Downloading/unpacking flake8 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:30 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 13:26:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:26:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:26:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:32 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 13:26:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:26:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:33 INFO - no previously-included directories found matching 'docs/_build' 13:26:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:26:33 INFO - Running setup.py install for pep8 13:26:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:33 INFO - no previously-included directories found matching 'docs/_build' 13:26:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:26:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:26:33 INFO - Cleaning up... 13:26:33 INFO - Return code: 0 13:26:33 INFO - Running post-action listener: _resource_record_post_action 13:26:33 INFO - Running post-action listener: _start_resource_monitoring 13:26:33 INFO - Starting resource monitoring. 13:26:33 INFO - ##### 13:26:33 INFO - ##### Finished create-virtualenv step (success) 13:26:33 INFO - ##### 13:26:33 INFO - ##### 13:26:33 INFO - ##### Running install step. 13:26:33 INFO - ##### 13:26:33 INFO - Running pre-action listener: _resource_record_pre_action 13:26:33 INFO - Running main action method: install 13:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:33 INFO - Reading from file tmpfile_stdout 13:26:33 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:34 INFO - Reading from file tmpfile_stdout 13:26:34 INFO - Output received: 13:26:34 INFO - Usage: mozinstall [options] installer 13:26:34 INFO - Options: 13:26:34 INFO - -h, --help show this help message and exit 13:26:34 INFO - -d DEST, --destination=DEST 13:26:34 INFO - Directory to install application into. [default: 13:26:34 INFO - "/builds/slave/test"] 13:26:34 INFO - --app=APP Application being installed. [default: firefox] 13:26:34 INFO - mkdir: /builds/slave/test/build/application 13:26:34 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'] 13:26:34 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 13:26:49 INFO - Reading from file tmpfile_stdout 13:26:49 INFO - Output received: 13:26:49 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:49 INFO - Running post-action listener: _resource_record_post_action 13:26:49 INFO - ##### 13:26:49 INFO - ##### Finished install step (success) 13:26:49 INFO - ##### 13:26:49 INFO - ##### 13:26:49 INFO - ##### Running run-tests step. 13:26:49 INFO - ##### 13:26:49 INFO - Running pre-action listener: _resource_record_pre_action 13:26:49 INFO - Running main action method: run_tests 13:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:49 INFO - Python 2.7.3 13:26:49 INFO - Return code: 0 13:26:49 INFO - grabbing minidump binary from tooltool 13:26:49 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')]} 13:26:49 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 0x25cf9c0>, '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 0x25d08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25d0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:49 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 13:26:49 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 13:26:49 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 13:26:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:50 INFO - Return code: 0 13:26:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:26:50 INFO - Return code: 0 13:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:26:50 INFO - Using env: {'DISPLAY': ':0', 13:26:50 INFO - 'HOME': '/home/cltbld', 13:26:50 INFO - 'LANG': 'en_US.UTF-8', 13:26:50 INFO - 'LANGUAGE': 'en_US:en', 13:26:50 INFO - 'LOGNAME': 'cltbld', 13:26:50 INFO - 'MAIL': '/var/mail/cltbld', 13:26:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:50 INFO - 'MOZ_NO_REMOTE': '1', 13:26:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:50 INFO - 'NO_EM_RESTART': '1', 13:26:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:50 INFO - 'PWD': '/builds/slave/test', 13:26:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:50 INFO - 'SHELL': '/bin/bash', 13:26:50 INFO - 'SHLVL': '1', 13:26:50 INFO - 'TERM': 'linux', 13:26:50 INFO - 'TMOUT': '86400', 13:26:50 INFO - 'USER': 'cltbld', 13:26:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464812757.274013-163266467', 13:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:50 INFO - '_': '/tools/buildbot/bin/python'} 13:26:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:26:51 INFO - mozversion application_buildid: 20160601115742 13:26:51 INFO - mozversion application_changeset: 248d35aedf8866d3b5bf747324a1384aa1228d8e 13:26:51 INFO - mozversion application_display_name: Nightly 13:26:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:51 INFO - mozversion application_name: Firefox 13:26:51 INFO - mozversion application_remotingname: firefox 13:26:51 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:26:51 INFO - mozversion application_vendor: Mozilla 13:26:51 INFO - mozversion application_version: 49.0a1 13:26:51 INFO - mozversion platform_buildid: 20160601115742 13:26:51 INFO - mozversion platform_changeset: 248d35aedf8866d3b5bf747324a1384aa1228d8e 13:26:51 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:26:51 INFO - mozversion platform_version: 49.0a1 13:26:51 INFO - using testdate: 1464812811 13:26:51 INFO - actual date: 1464812811 13:26:51 INFO - starting webserver on 'localhost:53742' 13:26:51 INFO - SUITE-START | Running 2 tests 13:26:51 INFO - TEST-START | dromaeo_css 13:26:51 INFO - operating with platform_type : linux_ 13:26:51 INFO - Initialising browser for dromaeo_css test... 13:26:51 INFO - TEST-INFO | started process 12248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBiHo7g/profile http://localhost:53742/getInfo.html) 13:26:55 INFO - PROCESS | 12248 | __metrics Screen width/height:1600/1200 13:26:55 INFO - PROCESS | 12248 | colorDepth:24 13:26:55 INFO - PROCESS | 12248 | Browser inner width/height: 1024/697 13:26:55 INFO - PROCESS | 12248 | __metrics 13:26:56 ERROR - PROCESS | 12248 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:26:57 INFO - TEST-INFO | 12248: exit 0 13:26:57 INFO - Browser initialized. 13:26:57 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:57 INFO - TEST-INFO | started process 12329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBiHo7g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:09 INFO - PROCESS | 12329 | RSS: Main: 158126080 13:27:09 INFO - PROCESS | 12329 | 13:28:00 INFO - PROCESS | 12329 | 1464812880746 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] 13:30:12 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53742/tests/dromaeo/cssquery-ext.html) 13:30:13 INFO - PROCESS | 12329 | RSS: Main: 265060352 13:30:13 INFO - PROCESS | 12329 | 13:33:16 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-ext.html (next: http://localhost:53742/tests/dromaeo/cssquery-jquery.html) 13:33:16 INFO - PROCESS | 12329 | RSS: Main: 243523584 13:33:16 INFO - PROCESS | 12329 | 13:36:18 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53742/tests/dromaeo/cssquery-mootools.html) 13:36:19 INFO - PROCESS | 12329 | RSS: Main: 242044928 13:36:19 INFO - PROCESS | 12329 | 13:39:21 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53742/tests/dromaeo/cssquery-prototype.html) 13:39:22 INFO - PROCESS | 12329 | RSS: Main: 243150848 13:39:22 INFO - PROCESS | 12329 | 13:42:25 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53742/tests/dromaeo/cssquery-yui.html) 13:42:25 INFO - PROCESS | 12329 | RSS: Main: 221376512 13:42:25 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | Cycle 1(1): loaded http://localhost:53742/tests/dromaeo/cssquery-yui.html (next: http://localhost:53742/tests/dromaeo/cssquery-dojo.html) 13:45:28 INFO - PROCESS | 12329 | RSS: Main: 288124928 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | __start_tp_report 13:45:28 INFO - PROCESS | 12329 | _x_x_mozilla_page_load 13:45:28 INFO - PROCESS | 12329 | _x_x_mozilla_page_load_details 13:45:28 INFO - PROCESS | 12329 | |i|pagename|runs| 13:45:28 INFO - PROCESS | 12329 | |0;dojo.html;2583.7545433183845;2598.4803039392127;2630.4607555451134;2631.67104111986;2638.8548629825364;4628.375169352141;4638.628909687225;4674.1352849722825;4714.175019371609;4741.525847415257;4695.201815691332;4739.289106634006;4770.952290477103;4779.7610119493975;4783.449903261126;4243.045314804168;4260.084081922386;4271.6155546000855;4328.891777705567;4336.306191009439;4376.146651402978;4381.167578160155;4460.776961151945;4502.909941801162;4504.617107545862;4282;4391.692581519295;4393;4436;4458.777061146946;4327.502337231227;4338.197433474817;4339.891502712426;4351.586599273064;4371.125774845043;4332.220200363933;4370.366296886966;4395.077033822869;4399.12017596482;4432.911341773147;4493.68544201906;4717.292406139072;4722.055588882203;4738.47876733559;4742.549457801503;5018.623603229772;5059.06407314648;5065.4174769901565;5126.71803050832;5133.12736834739;5130.9230361544605;5139.12634852076;5144.228365745131;5153.871153221162;5157.613179011589;4630.282306242538;4670.69640473375;4742.075295317449;4787.2101103318255;4789.712617242976;5167.1474206755465;5190.065788158167;5190.351206099238;5226.477352264743;5252.763625636855;4976.278439626234;5025.522575355335;5027.648064635514;5032.295478632921;5037.823676171316;4972.950270497321;5037.269595908573;5052.444231134572;5107.284980102789;5114.33513643224;5043.773030213649;5052.797888084509;5063.5695965843315;5064.417591976896;5094.6688465249645;5038.370203724535;5045.47022562633;5046.041252162077;5048.343715316985;5082.440931497532;4063.0248740302113;4070.531888832822;4146.771927543954;4168.353905144708;4282.807273672693;3655.2141289622327;3666.6883314917995;3666.8954745774813;3703.0372103252807;3724.050367156358;4381.956180438155;4389.231884420214;4390.05613793036;4427.092446048552;4430.224710675619;4943.431505376928;4970.204767237297;5029.547340739351;5051.343325367752;5060.51925067118;4379.781010949439;4397.076613911115;4433.800478978454;4436.245838207513;4438.245498265303;4540.750258735801;4545.068261006486;4552.11233809404;4593.47175074864;4596.7931443085145;4645.953540464552;4704.435467743892;4756.667033307635;4764.809407623726;4767.33257343979;5062.848114556569;5087.4403815581;5097.362829646294;5099.337086178922;5139.357580302462;4699.318598803223;4736.550027747358;4747.620190384692;4754.072955773591;4795.304680821192;4948.505149485023;4992.301077849032;5008.724520151427;5014.122528557415;5048.873778155576;5089.847304580869;5109.846704598868;5114.46298138705;5121.641485096007;5170.612204084633;4974.353334066548;4982.97848940959;4985.002999400207;4985.551300382983;5024.070546948826;4807.95192048089;4897.0450762101045;4928.457869634409;4940.75296235194;4954.628402869727;4886.706797592155;4903.754812259444;4910.06708725341;4953.405591329064;4955.950440495549;5004.3494345734825;5005.4744251853035;5007.449180590205;5041.697498150123;5056.115179843439;4711.693739906895;4736.550027747358;4759.547842954914;4761.119192949315;4770.642201834946 13:45:28 INFO - PROCESS | 12329 | |1;ext.html;538.7064050092699;592.7836339735998;593.2643522032678;597.7758340622266;610.4170517156115;27672.30819229518;40423.39364909525;41150.58849411505;41169;41172.382414263775;42904.785476072575;43382.349264761055;43417.34873976893;43467.34798978018;43564.564354356444;7383.520071195382;7712.421568382366;7895.684172633117;7896.802579935519;10017.248706347016;9890.752731181707;10068.345557538772;10075.899241007606;10076.143527800146;10081.647142350019;10040.899591004107;10214.744631384201;10251.948740256326;10252.743681407987;10256.94871525645;7581.962090189569;7835.569043702594;7847.5291482510665;10003.049710277584;10140.543675534618;9885.950570247103;10013.49932503372;10278.07497325237;10278.17774578032;10285.588576456932;40343.7982810087;40851.38722919158;40892.59107408918;41001.38497922534;41033.38449923253;3179.268768183331;3198.760092993035;3230.91922701932;3246.7111981151465;3335.1495368681076;30167.698323016928;30186.245343866358;30329.241768955733;30561.23596910073;31263.37473250545;3559.3363176236794;3604.9279014419826;3617.981910090459;3636.1636823530735;3643.2895585360866;283404;287202;287308.2691730831;287592;287791;61175;61564;61902.380976190565;61924.69037654873;61993;34417.13957151091;64545.67727161428;64909;64917;64962.35037649658;15077.095374277578;16114.355425782838;16135.919320403558;16138.75791863123;16138.919305403633;10394.480275986321;11457.828132578017;11636.3600001999;11654.941725291319;11958.940205298917;19864.900675496818;19922;20096.89951550262;20208.69686954697;20234.291799786937;7241.493095483371;7310.96344518274;7380.409567234608;7384.852302953911;7403.962980185064;828.6146941672151;925.6528801699362;933.2067742419025;965.8696076029787;1035.6219979707353;28412.431751364857;28954.855225723735;29305.56041659377;29414;29438.264043398656;948.4356807699407;968.3850754770772;982.0425085541683;996.2378780233128;1019.3119644240109;15212.923935380251;15698.76451853223;16110.194490275439;16450.835491645168;16819.83180168207;374700.7589772311;375551;377896;378106;379135;53043;53540.73229633827;53648;53669.73165134149;53760;1109.955601775936;1207.559240877091;1228.3121451986915;1235.234154823997;1241.540629966918;28515.572266416435;29623.407531849673;30027;30049.54925676073;30311.393772124877;42675.57324426716;43020.56979430166;43441.565584345015;43442.131157377305;43446.78276608597;245390;246981;247499;248045;249702;22715.77284227203;26579.867100664374;27378;27411;27452.313692157855;41932.161356772085;42435.1512969745;42559;42842.1431571373;43473.34789978216;36142.63857361498;36155.457668135525;36378;37017.62982370142;37089.814550927076;35494.93127743684;35918.8204058978;36175.63824361723;36403.63596364002;36544.81727591345;35410.114747130494;35875.82062089673;36232.63767362398;36503;36559.08602284964;31825.522617161223;32936.176595585304;33099.50350744693;33112.17219569434;33318;24707.876460617583;24861;25286.494270114126;25705.100321489404;25713.87143064273 13:45:28 INFO - PROCESS | 12329 | |2;jquery.html;355.87900113961246;356.8857965451055;357.271166819688;367.96320367963193;379.36645801511474;15706.136162511057;16863.325466981307;17134.314627414904;17249.741253881202;17670.381536646237;15902.443414480496;16581.585460363498;17097.57256068596;17106.572335691584;17130.82869171308;4963.106640804654;5108.2848401223855;5123.2827404163445;5170.172772356424;5175.87060323493;3723.94414083789;3914.4911161549103;5109.3613298337705;5661.150827375906;5962.25471816023;5995.040793473046;6000.549958753089;6006.399360064002;6012.909806352908;6018.6689732064715;5774.249347584829;5938.584299099065;5949.6727679977585;6017.669028203469;6023.066424704178;3243.9837800811083;4880.975595122037;5153.3815942087185;5189.792408303663;5196.376434827845;20046.699299510372;20663.380098597067;20666.380008599765;20801.479963000893;20817.68773468399;1907.3705677126516;1944.387517931847;2051.415346626219;2060.9072591733407;2516.7231604523486;11655.533778648844;11757.88300111488;12076.21504602198;12967.610971670865;13491;1732.9480115596552;1745.7555942168106;1766.7791526059243;1780.813014633458;1793.2020250988317;67120.3287967119;67242.66378668124;67450;70131;72191.63904180499;9777.071178238057;9789.510524473748;9814.65648702292;9875.654352097787;9922.305438619227;13373.130746501642;13479.123856949267;13488.865111348958;13510.93244533771;13513.121647092907;7123.109611298588;7209.603471808996;7260.854782904313;7326.3406293433845;7444.106707195171;6853.931460685429;6856;6881.174259088942;6971.233164351917;6991.091158149408;4154.543000269968;4202.810873510638;4232;4236.4492615959725;4292.82828686849;1667.6497935433451;1705.8038325592468;1739.4692670449922;1747.0653200537652;1755.379951294662;634.3542471999152;859.458541119091;889.155302462663;904.3624244907325;980.9558569864373;15963.680726385639;16705.83294167067;16759;17085.743713844302;17331.913340433468;863.1066845814552;877.7191298784328;901.7384958362002;929.8465753150655;940.0364626258004;9177.579988422844;9633.951830240803;9726.465044422624;9729.756756081155;9782;363958;364870;369190;380172;387080;79442;80135;80399;80574.59712701399;81277;922.8338898998111;929.1451864284874;931.7204838548408;932.1470854168496;935.2284365398573;14758.262086895827;14884.255787210812;14893;15078;15398.230088495755;27185.86407067952;32759.34481310313;34911.476327854594;36644.26711465809;36935.44596831103;45476.77261613671;50870;51003;51187.232191517905;51409.48590514196;7066.116735408074;7077.150741911004;7100.396466300423;7159.534630249017;7190.460715446257;7744.728934487266;9376.531173441437;10507.789844203226;10835.67492975212;11046.723831904266;8790.824183516423;9494.90505094968;9651.131398174199;9927.751806204902;10844.728881778019;9986.800263994824;10221.029002244775;10234.488275586042;10283.22875784334;10543.841842372523;5357.0357335679955;7629.389648828192;9456.385334953206;9666.226701863974;9723.805523889625;7652.234776522303;7692.576908270099;7791.610419479117;7801.96099019524;7881.172476890073;10101.797964040825;10434.947825260826;10623.468826558796;10726.141908647445;10923.453827308762 13:45:28 INFO - PROCESS | 12329 | |3;mootools.html;1249.0819247852833;1368.4594585138873;1419.708959663269;1497.4160077569743;1737.4527023987443;7158.463115266356;7504.061992250969;7566.470347075707;7632.122305934819;7645.732399366023;7444.330010299072;7560.432967527444;7567.432442566802;7579.962100189491;7636.694532218718;2153.257126291427;2176.5102851858364;2179.8801065941366;2180.3785921012513;2182.454386403399;2192.27654873892;2213.4798322394226;2231.141010710872;2234.486068204314;2235.821134309251;2182.552576721768;2186.4533866533366;2210.3037543173928;2212.1593794358123;2220.9222677206303;2157.6979222908803;2169.262450766747;2173.847830651855;2176.183931025865;2176.651735722293;2145.3671167005773;2183.9017244224046;2184.9344519664437;2185.825133989277;2188.0372636040092;7308.96345518269;7461.515001524884;7482.363999060032;7500.849983000309;7506.099268087864;4536.61438777701;4617.792199351037;4651.906961860744;4654;4657.69724967876;2840.97724819065;2934.4717950768854;2975.9851200744074;3005.8046226995393;3007.9398412031637;961.403929563675;975.2246963663904;998.1964518562554;999.9700008999741;1014.1329163565119;10117.038881306264;10195.33730307535;10249.53877075526;10266.845997310047;10299.073083422529;3908.511436070491;3942.586028467027;3982.7411218270718;4052.3313653246882;4060.269151552749;7990.560519171501;8054.637541310655;8066.274035336731;8066.31436327907;8068.314193293519;4495.25828238337;4495.730256184639;4500.369948207253;4500.774961251925;4508.954910450853;3653.8355773990234;3811.904702382463;4145.1295228002455;4149.211649786531;4192.224438478891;3369.511420843964;3430.6397828227678;3438.9656103439147;3447.4484082546674;3486.16332080304;1000.9449480278655;1000.9949950250202;1007.2848277722899;1016.11090295991;1022.4376592874038;830.9584520773938;838.4172999765227;848.9363297752693;866.0776273268948;875.3172525430175;4883.243097319921;4917.434495033045;4935.383077115361;4953.777080031407;5001.649554620232;393.54742046646015;398.90426297688344;400.0458905510321;400.14568895407933;403.81020920167475;3459.7405194610506;3599.532140457418;3646.197836475971;3660.633936606318;3661.9267614647556;8982.955085224532;9340.159385655325;9356.391834530734;9362.06379362072;9363.672271470467;9150;9247;9268.25853931684;9271.119243671841;9287.48918809472;7069.929300706927;7072.575645461186;7073.328033836778;7073.752418665322;7165.677544510405;5014;5116.565091967075;5183.922241166461;5213.478652134756;5226.29445024932;8588.312934965314;8613.870791938001;8692.826143477221;8701.956490217508;8712.825743485222;8567.057623661267;8736.432131911406;8753.212210901049;8802;8954.059823718415;5573.6098473106495;5783.8554036149435;5796.855078623068;5797.79707710245;5809.564282678901;7088.291170883077;7278.454115941219;7281.05346304977;7363.705451782083;7384.556926584422;6451.387118223761;6628.469722422291;6636.502262330441;6701.363370479797;6739.528233023641;6632.568883022588;6635.966820165868;6710.328967103446;6716.059751634873;6777.762778302736;6208.161898143873;6254.155688981929;6310.5267104968225;6319.747210111544;6326.398992095744;4530.70550414222;4582.793774280099;4630;4671.976640116778;4682;4596.3565100885235;4608.239640459286;4648.790804413742;4657.161710892072;4699.201135806853 13:45:28 INFO - PROCESS | 12329 | |4;prototype.html;287.9021132814843;294.71265516121787;301.7540704325974;303.23584566891435;305.70346763639265;4852.660313778037;4886.975565122174;4901.485344038878;4913.508649135089;4942.802287908479;4603.907921841561;4614.169449499089;4721.480637129913;4743.430788305408;4893.168161412568;3784.489093972306;3789.696824254053;3791.2607041626893;3802.410626352906;3817.312883680929;3806.8286927088348;3810.3522401191863;3821.6560509554133;3848.8845334640005;3880.7865567393783;3602;3681.558213014442;3688.8155592220414;3704.3887758519945;3721.809021113245;3779.60314167014;3784.7729136251774;3796.316663000659;3811.6188381161937;3818.16000479894;3355.557110442509;3356.060303115107;3368.3936891359544;3372.9494057589154;3373.2578832656777;4447.310666846644;4567.634589232886;4583.610393116589;4608.470025946992;4654.9069018619775;4293.549177336366;4313.741175529478;4334.609885110355;4336.371226172188;4349.826006959718;5035.697858128524;5035.985605757726;5038;5044.092063428581;5059.898802023976;3641.927161456756;3647.7993710345922;3665.3402387570227;3669.4679271505747;3677.7793332399874;5027.472115427864;5284.339457567804;5292.576593872481;5295.279034313863;5326.733663316857;3589.3898037333715;3597.8486884196805;3619;3631.7094632429344;3637.417723290377;3654.524911761454;3672.981635091807;3693.649103335179;3705.166337574024;3708.8687950174917;4142.5857414258935;4227.915441691211;4248.383984322256;4265.722728022731;4277.165952639206;5059.696418214919;5072.28987941681;5087.771050302746;5093.0577843099145;5108.565771909355;1228.4656174563916;1271.4659842865833;1292.476546998467;1294.1006000829334;1294.9223046617233;846.0608724316004;868.370431437203;874.3005595523556;874.908134645853;875.4309698695771;4458.77706114693;4467.977660111744;4476.194285028661;4488.5511448855505;4490.12442573695;5169.4830516948;5210.140326846104;5232.869178270497;5234.842954711365;5269.473052694777;4277.615014648696;4413.955860441419;4453.77731113443;4487.326900964816;4490.348899409567;2754.2012816283054;2757.9448411031667;2759.572266298727;2770.96334194367;2795.259256297083;4868.732219727878;4891.095147397743;4891.828785992473;4912.336834527365;4921.532454416824;5139.794408223704;5271.288376069181;5361.919571206435;5417.4582541746295;5424.105022671294;4950.356453661001;4958.330625365529;4962;4962.5533701967;4995.225740010304;5289.629725919149;5335.279737235423;5348.1442969124755;5359.276497672764;5375.682957675394;4964.478729733471;5183.948160518346;5186.585073194211;5199.792008319625;5208.427073021889;4941.97529012367;4972.831384624683;4982.55157035854;4984.501549844987;4986.877952460667;3685.120588499938;3688.280785246851;3701;3702.315071711742;3717.312297225022;5199.376074871039;5256.947430525645;5262.815801446931;5273.973630131824;5279.7096159710045;5054.4692807254705;5064.797408103635;5075.543201111917;5104.9744751276;5122.641415100908;4924.374956264496;5097.222014002304;5103.260027296095;5106.208537676666;5126.769295381791;4810.326554282473;4830.396200474941;5064;5084;5088.796448142033;5073.822416215415;5080.314157588678;5083.237514372874;5083.364579427572;5087.771050302819;5002.299678045004;5007.574356179765;5026;5026.572741317029;5026.85284640166 13:45:28 INFO - PROCESS | 12329 | |5;yui.html;658.1969996604141;666.4535081233388;718.2781304788687;724.214227563094;737.2001378504324;12276.508939642415;12359.134860559765;12393.876061239385;12426.565070222545;12450.750984980306;12376.690582735437;12427.502899884017;12466.750664986695;12469.25184488929;12604.369781510934;608.4584719599537;747.8130467383154;769.0617446714999;777.8483195776826;780.8047988003;774.4540099230029;774.8915151878713;774.9922500775004;775.2286474957425;778.7936196907824;802.2418814220564;802.8875957365973;805.046020465747;806.2985202873508;808.7007807111377;626.8777588370247;800.8078061265313;801.2388231180373;802.0976401548259;814.5357146426539;598.4554055809193;599.8290487211124;600.1927407636722;600.2466904035451;601.3385276196193;12609.873901260962;12615.116941814076;12629.74740505194;12636.368181590884;12658.556950506689;11873.821892671616;12270.631881043493;12319.445624946899;12325.260484370967;12770.042246831432;9949.30354875159;9952.104310612007;10253.897461025368;10304.278700490968;10952.671419857417;4157.792110394468;4160.687948403882;4201.76890271035;4215.072684009544;4279.33670281107;44269;44598;45090.09819803618;45238.54761452376;45323.86690332735;9817.32445712472;9875.209983201326;9908.20734341251;9976.60093596248;9986;15636.609084772745;16590.08754518513;16620.168991550374;16635.750463743054;16641.50075497737;6651.86696266072;6730.125083739083;6747.966260168766;6773.45812335012;6885.2770459101075;3647.598764135943;3666.5416822897137;3689.723270754704;3746.269477451925;3764.3976963685677;2654.283343497245;2725.5094083065237;2728.290644432422;2731.726827317292;2736.3569561153113;481.7422678866789;504.54590868218895;509.5897802269209;515.0188890164243;518.0597216052852;435.6079528424443;494.4042428873199;562.3364429972671;566.1960016776188;583.3379114704841;7590.316871481593;7695.884561731578;7780.727674531364;7927.128015918244;7927.643256053491;561.514290139035;573.0544601407711;574.097209828072;584.4856526256867;603.9486643635253;3401.149712571857;4162.229987452331;4211.978940105341;4278.871633850989;4374.825006999748;53313.20030199472;53873.1919021215;54397.1840422394;54415.18377224345;56765.14852277219;47538.524614754104;48133.75933120312;48633.27050094251;49097.263541046916;50446.747766261666;44323;44607.77696111563;44842;45019.324710129375;45248;8127.634256458356;8322.583870806557;8656.337818010048;8731.869021964549;8897.2882169425;30151.698483015767;30430.087097387113;30468;30662.386752264385;30878.91923782657;36706.44940325844;37614.81192594129;39481.605183947795;39851.80074099727;40679.38980915348;10755.838662420227;10878.564857405616;10945.398003109905;10960.561577537128;11044.447777611247;11328.546858125583;11408.82886756716;11526.423678815858;11555.768884622428;11721.472533735832;11615.419229038684;11946.880531194576;12173.57392491294;12174.634760957186;12289.815652765037;11388.259763115371;11675.241109327866;11856.822147667619;12169.391530423267;12377.566785162477;10771.084457821173;11074.395817446946;11519.30884146954;11773.411329433666;11958.940205298917;9435.764105897408;9690.757731056498;9814.901850981685;10012.449315287438;10116.342437741523;9148.725538233864;9191.494467804336;9530.237580993642;10208.285420020824;10291.794164116525 13:45:28 INFO - PROCESS | 12329 | __end_tp_report 13:45:28 INFO - PROCESS | 12329 | __start_cc_report 13:45:28 INFO - PROCESS | 12329 | _x_x_mozilla_cycle_collect,997 13:45:28 INFO - PROCESS | 12329 | __end_cc_report 13:45:28 INFO - PROCESS | 12329 | __startTimestamp1464813928685__endTimestamp 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | ------- Summary: start ------- 13:45:28 INFO - PROCESS | 12329 | Number of tests: 6 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#0] dojo.html Cycles:165 Average:4680.27 Median:4767.33 stddev:504.83 (10.6%) stddev-sans-first:478.84 13:45:28 INFO - PROCESS | 12329 | Values: 2583.8 2598.5 2630.5 2631.7 2638.9 4628.4 4638.6 4674.1 4714.2 4741.5 4695.2 4739.3 4771.0 4779.8 4783.4 4243.0 4260.1 4271.6 4328.9 4336.3 4376.1 4381.2 4460.8 4502.9 4504.6 4282.0 4391.7 4393.0 4436.0 4458.8 4327.5 4338.2 4339.9 4351.6 4371.1 4332.2 4370.4 4395.1 4399.1 4432.9 4493.7 4717.3 4722.1 4738.5 4742.5 5018.6 5059.1 5065.4 5126.7 5133.1 5130.9 5139.1 5144.2 5153.9 5157.6 4630.3 4670.7 4742.1 4787.2 4789.7 5167.1 5190.1 5190.4 5226.5 5252.8 4976.3 5025.5 5027.6 5032.3 5037.8 4973.0 5037.3 5052.4 5107.3 5114.3 5043.8 5052.8 5063.6 5064.4 5094.7 5038.4 5045.5 5046.0 5048.3 5082.4 4063.0 4070.5 4146.8 4168.4 4282.8 3655.2 3666.7 3666.9 3703.0 3724.1 4382.0 4389.2 4390.1 4427.1 4430.2 4943.4 4970.2 5029.5 5051.3 5060.5 4379.8 4397.1 4433.8 4436.2 4438.2 4540.8 4545.1 4552.1 4593.5 4596.8 4646.0 4704.4 4756.7 4764.8 4767.3 5062.8 5087.4 5097.4 5099.3 5139.4 4699.3 4736.6 4747.6 4754.1 4795.3 4948.5 4992.3 5008.7 5014.1 5048.9 5089.8 5109.8 5114.5 5121.6 5170.6 4974.4 4983.0 4985.0 4985.6 5024.1 4808.0 4897.0 4928.5 4940.8 4954.6 4886.7 4903.8 4910.1 4953.4 4956.0 5004.3 5005.5 5007.4 5041.7 5056.1 4711.7 4736.6 4759.5 4761.1 4770.6 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#1] ext.html Cycles:180 Average:47353.78 Median:35452.52 stddev:80935.64 (228.3%) stddev-sans-first:81086.36 13:45:28 INFO - PROCESS | 12329 | Values: 538.7 592.8 593.3 597.8 610.4 27672.3 40423.4 41150.6 41169.0 41172.4 42904.8 43382.3 43417.3 43467.3 43564.6 7383.5 7712.4 7895.7 7896.8 10017.2 9890.8 10068.3 10075.9 10076.1 10081.6 10040.9 10214.7 10251.9 10252.7 10256.9 7582.0 7835.6 7847.5 10003.0 10140.5 9886.0 10013.5 10278.1 10278.2 10285.6 40343.8 40851.4 40892.6 41001.4 41033.4 3179.3 3198.8 3230.9 3246.7 3335.1 30167.7 30186.2 30329.2 30561.2 31263.4 3559.3 3604.9 3618.0 3636.2 3643.3 283404.0 287202.0 287308.3 287592.0 287791.0 61175.0 61564.0 61902.4 61924.7 61993.0 34417.1 64545.7 64909.0 64917.0 64962.4 15077.1 16114.4 16135.9 16138.8 16138.9 10394.5 11457.8 11636.4 11654.9 11958.9 19864.9 19922.0 20096.9 20208.7 20234.3 7241.5 7311.0 7380.4 7384.9 7404.0 828.6 925.7 933.2 965.9 1035.6 28412.4 28954.9 29305.6 29414.0 29438.3 948.4 968.4 982.0 996.2 1019.3 15212.9 15698.8 16110.2 16450.8 16819.8 374700.8 375551.0 377896.0 378106.0 379135.0 53043.0 53540.7 53648.0 53669.7 53760.0 1110.0 1207.6 1228.3 1235.2 1241.5 28515.6 29623.4 30027.0 30049.5 30311.4 42675.6 43020.6 43441.6 43442.1 43446.8 245390.0 246981.0 247499.0 248045.0 249702.0 22715.8 26579.9 27378.0 27411.0 27452.3 41932.2 42435.2 42559.0 42842.1 43473.3 36142.6 36155.5 36378.0 37017.6 37089.8 35494.9 35918.8 36175.6 36403.6 36544.8 35410.1 35875.8 36232.6 36503.0 36559.1 31825.5 32936.2 33099.5 33112.2 33318.0 24707.9 24861.0 25286.5 25705.1 25713.9 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#2] jquery.html Cycles:180 Average:23741.75 Median:28055.64 stddev:61795.16 (220.3%) stddev-sans-first:61943.56 13:45:28 INFO - PROCESS | 12329 | Values: 355.9 356.9 357.3 368.0 379.4 15706.1 16863.3 17134.3 17249.7 17670.4 15902.4 16581.6 17097.6 17106.6 17130.8 4963.1 5108.3 5123.3 5170.2 5175.9 3723.9 3914.5 5109.4 5661.2 5962.3 5995.0 6000.5 6006.4 6012.9 6018.7 5774.2 5938.6 5949.7 6017.7 6023.1 3244.0 4881.0 5153.4 5189.8 5196.4 20046.7 20663.4 20666.4 20801.5 20817.7 1907.4 1944.4 2051.4 2060.9 2516.7 11655.5 11757.9 12076.2 12967.6 13491.0 1732.9 1745.8 1766.8 1780.8 1793.2 67120.3 67242.7 67450.0 70131.0 72191.6 9777.1 9789.5 9814.7 9875.7 9922.3 13373.1 13479.1 13488.9 13510.9 13513.1 7123.1 7209.6 7260.9 7326.3 7444.1 6853.9 6856.0 6881.2 6971.2 6991.1 4154.5 4202.8 4232.0 4236.4 4292.8 1667.6 1705.8 1739.5 1747.1 1755.4 634.4 859.5 889.2 904.4 981.0 15963.7 16705.8 16759.0 17085.7 17331.9 863.1 877.7 901.7 929.8 940.0 9177.6 9634.0 9726.5 9729.8 9782.0 363958.0 364870.0 369190.0 380172.0 387080.0 79442.0 80135.0 80399.0 80574.6 81277.0 922.8 929.1 931.7 932.1 935.2 14758.3 14884.3 14893.0 15078.0 15398.2 27185.9 32759.3 34911.5 36644.3 36935.4 45476.8 50870.0 51003.0 51187.2 51409.5 7066.1 7077.2 7100.4 7159.5 7190.5 7744.7 9376.5 10507.8 10835.7 11046.7 8790.8 9494.9 9651.1 9927.8 10844.7 9986.8 10221.0 10234.5 10283.2 10543.8 5357.0 7629.4 9456.4 9666.2 9723.8 7652.2 7692.6 7791.6 7802.0 7881.2 10101.8 10434.9 10623.5 10726.1 10923.5 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#3] mootools.html Cycles:180 Average:4960.21 Median:4791.22 stddev:2749.20 (57.4%) stddev-sans-first:2742.77 13:45:28 INFO - PROCESS | 12329 | Values: 1249.1 1368.5 1419.7 1497.4 1737.5 7158.5 7504.1 7566.5 7632.1 7645.7 7444.3 7560.4 7567.4 7580.0 7636.7 2153.3 2176.5 2179.9 2180.4 2182.5 2192.3 2213.5 2231.1 2234.5 2235.8 2182.6 2186.5 2210.3 2212.2 2220.9 2157.7 2169.3 2173.8 2176.2 2176.7 2145.4 2183.9 2184.9 2185.8 2188.0 7309.0 7461.5 7482.4 7500.8 7506.1 4536.6 4617.8 4651.9 4654.0 4657.7 2841.0 2934.5 2976.0 3005.8 3007.9 961.4 975.2 998.2 1000.0 1014.1 10117.0 10195.3 10249.5 10266.8 10299.1 3908.5 3942.6 3982.7 4052.3 4060.3 7990.6 8054.6 8066.3 8066.3 8068.3 4495.3 4495.7 4500.4 4500.8 4509.0 3653.8 3811.9 4145.1 4149.2 4192.2 3369.5 3430.6 3439.0 3447.4 3486.2 1000.9 1001.0 1007.3 1016.1 1022.4 831.0 838.4 848.9 866.1 875.3 4883.2 4917.4 4935.4 4953.8 5001.6 393.5 398.9 400.0 400.1 403.8 3459.7 3599.5 3646.2 3660.6 3661.9 8983.0 9340.2 9356.4 9362.1 9363.7 9150.0 9247.0 9268.3 9271.1 9287.5 7069.9 7072.6 7073.3 7073.8 7165.7 5014.0 5116.6 5183.9 5213.5 5226.3 8588.3 8613.9 8692.8 8702.0 8712.8 8567.1 8736.4 8753.2 8802.0 8954.1 5573.6 5783.9 5796.9 5797.8 5809.6 7088.3 7278.5 7281.1 7363.7 7384.6 6451.4 6628.5 6636.5 6701.4 6739.5 6632.6 6636.0 6710.3 6716.1 6777.8 6208.2 6254.2 6310.5 6319.7 6326.4 4530.7 4582.8 4630.0 4672.0 4682.0 4596.4 4608.2 4648.8 4657.2 4699.2 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#4] prototype.html Cycles:180 Average:4214.52 Median:4841.53 stddev:1229.12 (25.4%) stddev-sans-first:1196.71 13:45:28 INFO - PROCESS | 12329 | Values: 287.9 294.7 301.8 303.2 305.7 4852.7 4887.0 4901.5 4913.5 4942.8 4603.9 4614.2 4721.5 4743.4 4893.2 3784.5 3789.7 3791.3 3802.4 3817.3 3806.8 3810.4 3821.7 3848.9 3880.8 3602.0 3681.6 3688.8 3704.4 3721.8 3779.6 3784.8 3796.3 3811.6 3818.2 3355.6 3356.1 3368.4 3372.9 3373.3 4447.3 4567.6 4583.6 4608.5 4654.9 4293.5 4313.7 4334.6 4336.4 4349.8 5035.7 5036.0 5038.0 5044.1 5059.9 3641.9 3647.8 3665.3 3669.5 3677.8 5027.5 5284.3 5292.6 5295.3 5326.7 3589.4 3597.8 3619.0 3631.7 3637.4 3654.5 3673.0 3693.6 3705.2 3708.9 4142.6 4227.9 4248.4 4265.7 4277.2 5059.7 5072.3 5087.8 5093.1 5108.6 1228.5 1271.5 1292.5 1294.1 1294.9 846.1 868.4 874.3 874.9 875.4 4458.8 4468.0 4476.2 4488.6 4490.1 5169.5 5210.1 5232.9 5234.8 5269.5 4277.6 4414.0 4453.8 4487.3 4490.3 2754.2 2757.9 2759.6 2771.0 2795.3 4868.7 4891.1 4891.8 4912.3 4921.5 5139.8 5271.3 5361.9 5417.5 5424.1 4950.4 4958.3 4962.0 4962.6 4995.2 5289.6 5335.3 5348.1 5359.3 5375.7 4964.5 5183.9 5186.6 5199.8 5208.4 4942.0 4972.8 4982.6 4984.5 4986.9 3685.1 3688.3 3701.0 3702.3 3717.3 5199.4 5256.9 5262.8 5274.0 5279.7 5054.5 5064.8 5075.5 5105.0 5122.6 4924.4 5097.2 5103.3 5106.2 5126.8 4810.3 4830.4 5064.0 5084.0 5088.8 5073.8 5080.3 5083.2 5083.4 5087.8 5002.3 5007.6 5026.0 5026.6 5026.9 13:45:28 INFO - PROCESS | 12329 | 13:45:28 INFO - PROCESS | 12329 | [#5] yui.html Cycles:180 Average:13052.64 Median:44602.89 stddev:14840.19 (33.3%) stddev-sans-first:14852.63 13:45:28 INFO - PROCESS | 12329 | Values: 658.2 666.5 718.3 724.2 737.2 12276.5 12359.1 12393.9 12426.6 12450.8 12376.7 12427.5 12466.8 12469.3 12604.4 608.5 747.8 769.1 777.8 780.8 774.5 774.9 775.0 775.2 778.8 802.2 802.9 805.0 806.3 808.7 626.9 800.8 801.2 802.1 814.5 598.5 599.8 600.2 600.2 601.3 12609.9 12615.1 12629.7 12636.4 12658.6 11873.8 12270.6 12319.4 12325.3 12770.0 9949.3 9952.1 10253.9 10304.3 10952.7 4157.8 4160.7 4201.8 4215.1 4279.3 44269.0 44598.0 45090.1 45238.5 45323.9 9817.3 9875.2 9908.2 9976.6 9986.0 15636.6 16590.1 16620.2 16635.8 16641.5 6651.9 6730.1 6748.0 6773.5 6885.3 3647.6 3666.5 3689.7 3746.3 3764.4 2654.3 2725.5 2728.3 2731.7 2736.4 481.7 504.5 509.6 515.0 518.1 435.6 494.4 562.3 566.2 583.3 7590.3 7695.9 7780.7 7927.1 7927.6 561.5 573.1 574.1 584.5 603.9 3401.1 4162.2 4212.0 4278.9 4374.8 53313.2 53873.2 54397.2 54415.2 56765.1 47538.5 48133.8 48633.3 49097.3 50446.7 44323.0 44607.8 44842.0 45019.3 45248.0 8127.6 8322.6 8656.3 8731.9 8897.3 30151.7 30430.1 30468.0 30662.4 30878.9 36706.4 37614.8 39481.6 39851.8 40679.4 10755.8 10878.6 10945.4 10960.6 11044.4 11328.5 11408.8 11526.4 11555.8 11721.5 11615.4 11946.9 12173.6 12174.6 12289.8 11388.3 11675.2 11856.8 12169.4 12377.6 10771.1 11074.4 11519.3 11773.4 11958.9 9435.8 9690.8 9814.9 10012.4 10116.3 9148.7 9191.5 9530.2 10208.3 10291.8 13:45:28 INFO - PROCESS | 12329 | -------- Summary: end -------- 13:45:28 INFO - PROCESS | 12329 | 13:45:29 INFO - TEST-INFO | 12329: exit 0 13:45:29 INFO - TEST-OK | dromaeo_css | took 1118321ms 13:45:29 INFO - TEST-START | kraken 13:45:29 INFO - operating with platform_type : linux_ 13:45:29 INFO - Initialising browser for kraken test... 13:45:29 INFO - TEST-INFO | started process 12508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboxONi/profile http://localhost:53742/getInfo.html) 13:45:33 INFO - PROCESS | 12508 | __metrics Screen width/height:1600/1200 13:45:33 INFO - PROCESS | 12508 | colorDepth:24 13:45:33 INFO - PROCESS | 12508 | Browser inner width/height: 1024/697 13:45:33 INFO - PROCESS | 12508 | __metrics 13:45:34 ERROR - PROCESS | 12508 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:45:35 INFO - TEST-INFO | 12508: exit 0 13:45:35 INFO - Browser initialized. 13:45:35 INFO - Running cycle 1/1 for kraken test... 13:45:35 INFO - TEST-INFO | started process 12588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboxONi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:47 INFO - PROCESS | 12588 | RSS: Main: 157757440 13:45:47 INFO - PROCESS | 12588 | 13:45:50 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:50 INFO - PROCESS | 12588 | RSS: Main: 215482368 13:45:50 INFO - PROCESS | 12588 | 13:45:53 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-dft) 13:45:54 INFO - PROCESS | 12588 | RSS: Main: 201732096 13:45:54 INFO - PROCESS | 12588 | 13:45:57 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-fft) 13:45:58 INFO - PROCESS | 12588 | RSS: Main: 269979648 13:45:58 INFO - PROCESS | 12588 | 13:46:00 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53742/tests/kraken/driver.html?testName=audio-oscillator) 13:46:01 INFO - PROCESS | 12588 | RSS: Main: 180404224 13:46:01 INFO - PROCESS | 12588 | 13:46:03 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:03 INFO - PROCESS | 12588 | RSS: Main: 184479744 13:46:03 INFO - PROCESS | 12588 | 13:46:07 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:07 INFO - PROCESS | 12588 | RSS: Main: 220680192 13:46:07 INFO - PROCESS | 12588 | 13:46:11 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53742/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:11 INFO - PROCESS | 12588 | RSS: Main: 221933568 13:46:11 INFO - PROCESS | 12588 | 13:46:14 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53742/tests/kraken/driver.html?testName=json-parse-financial) 13:46:15 INFO - PROCESS | 12588 | RSS: Main: 221159424 13:46:15 INFO - PROCESS | 12588 | 13:46:16 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:17 INFO - PROCESS | 12588 | RSS: Main: 203751424 13:46:17 INFO - PROCESS | 12588 | 13:46:19 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:20 INFO - PROCESS | 12588 | RSS: Main: 209178624 13:46:20 INFO - PROCESS | 12588 | 13:46:22 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:22 INFO - PROCESS | 12588 | RSS: Main: 219000832 13:46:22 INFO - PROCESS | 12588 | 13:46:25 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:26 INFO - PROCESS | 12588 | RSS: Main: 222957568 13:46:26 INFO - PROCESS | 12588 | 13:46:29 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:29 INFO - PROCESS | 12588 | RSS: Main: 222928896 13:46:29 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | Cycle 1(1): loaded http://localhost:53742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53742/tests/kraken/driver.html?testName=ai-astar) 13:46:31 INFO - PROCESS | 12588 | RSS: Main: 265658368 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | __start_tp_report 13:46:31 INFO - PROCESS | 12588 | _x_x_mozilla_page_load 13:46:31 INFO - PROCESS | 12588 | _x_x_mozilla_page_load_details 13:46:31 INFO - PROCESS | 12588 | |i|pagename|runs| 13:46:31 INFO - PROCESS | 12588 | |0;ai-astar;113;108;111;113;112;114;112;112;115;113 13:46:31 INFO - PROCESS | 12588 | |1;audio-beat-detection;163;129;130;189;133;133;161;130;189;130 13:46:31 INFO - PROCESS | 12588 | |2;audio-dft;161;161;160;160;161;160;162;160;163;160 13:46:31 INFO - PROCESS | 12588 | |3;audio-fft;76;75;78;135;76;76;74;75;108;75 13:46:31 INFO - PROCESS | 12588 | |4;audio-oscillator;85;85;122;85;84;84;140;84;85;119 13:46:31 INFO - PROCESS | 12588 | |5;imaging-gaussian-blur;117;116;117;116;117;116;116;117;117;116 13:46:31 INFO - PROCESS | 12588 | |6;imaging-darkroom;147;146;147;146;146;147;147;146;147;147 13:46:31 INFO - PROCESS | 12588 | |7;imaging-desaturate;95;95;95;96;96;95;95;95;95;95 13:46:31 INFO - PROCESS | 12588 | |8;json-parse-financial;64;64;62;63;64;65;66;63;64;63 13:46:31 INFO - PROCESS | 12588 | |9;json-stringify-tinderbox;65;64;65;65;65;64;65;65;64;65 13:46:31 INFO - PROCESS | 12588 | |10;stanford-crypto-aes;86;90;82;84;83;85;83;85;119;84 13:46:31 INFO - PROCESS | 12588 | |11;stanford-crypto-ccm;133;133;134;133;139;140;131;141;133;134 13:46:31 INFO - PROCESS | 12588 | |12;stanford-crypto-pbkdf2;175;169;169;172;172;170;175;170;172;170 13:46:31 INFO - PROCESS | 12588 | |13;stanford-crypto-sha256-iterative;66;67;68;67;68;67;66;67;66;67 13:46:31 INFO - PROCESS | 12588 | __end_tp_report 13:46:31 INFO - PROCESS | 12588 | __start_cc_report 13:46:31 INFO - PROCESS | 12588 | _x_x_mozilla_cycle_collect,1874 13:46:31 INFO - PROCESS | 12588 | __end_cc_report 13:46:31 INFO - PROCESS | 12588 | __startTimestamp1464813991864__endTimestamp 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | ------- Summary: start ------- 13:46:31 INFO - PROCESS | 12588 | Number of tests: 14 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 13:46:31 INFO - PROCESS | 12588 | Values: 113.0 108.0 111.0 113.0 112.0 114.0 112.0 112.0 115.0 113.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:147.00 stddev:24.80 (16.9%) stddev-sans-first:25.76 13:46:31 INFO - PROCESS | 12588 | Values: 163.0 129.0 130.0 189.0 133.0 133.0 161.0 130.0 189.0 130.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 13:46:31 INFO - PROCESS | 12588 | Values: 161.0 161.0 160.0 160.0 161.0 160.0 162.0 160.0 163.0 160.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#3] audio-fft Cycles:10 Average:84.80 Median:75.50 stddev:20.39 (27.0%) stddev-sans-first:21.38 13:46:31 INFO - PROCESS | 12588 | Values: 76.0 75.0 78.0 135.0 76.0 76.0 74.0 75.0 108.0 75.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:84.50 stddev:21.19 (25.1%) stddev-sans-first:22.00 13:46:31 INFO - PROCESS | 12588 | Values: 85.0 85.0 122.0 85.0 84.0 84.0 140.0 84.0 85.0 119.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:46:31 INFO - PROCESS | 12588 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:46:31 INFO - PROCESS | 12588 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:46:31 INFO - PROCESS | 12588 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 13:46:31 INFO - PROCESS | 12588 | Values: 64.0 64.0 62.0 63.0 64.0 65.0 66.0 63.0 64.0 63.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 13:46:31 INFO - PROCESS | 12588 | Values: 65.0 64.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:84.50 stddev:11.08 (13.1%) stddev-sans-first:11.73 13:46:31 INFO - PROCESS | 12588 | Values: 86.0 90.0 82.0 84.0 83.0 85.0 83.0 85.0 119.0 84.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:134.00 stddev:3.51 (2.6%) stddev-sans-first:3.64 13:46:31 INFO - PROCESS | 12588 | Values: 133.0 133.0 134.0 133.0 139.0 140.0 131.0 141.0 133.0 134.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.22 (1.3%) stddev-sans-first:1.94 13:46:31 INFO - PROCESS | 12588 | Values: 175.0 169.0 169.0 172.0 172.0 170.0 175.0 170.0 172.0 170.0 13:46:31 INFO - PROCESS | 12588 | 13:46:31 INFO - PROCESS | 12588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 13:46:31 INFO - PROCESS | 12588 | Values: 66.0 67.0 68.0 67.0 68.0 67.0 66.0 67.0 66.0 67.0 13:46:31 INFO - PROCESS | 12588 | -------- Summary: end -------- 13:46:31 INFO - PROCESS | 12588 | 13:46:32 INFO - TEST-INFO | 12588: exit 0 13:46:32 INFO - TEST-OK | kraken | took 63476ms 13:46:32 INFO - SUITE-END | took 1181s 13:46:33 INFO - Completed test suite (00:19:41) 13:46:33 INFO - javascript benchmark 13:46:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.7545433183845, 2598.4803039392127, 2630.4607555451134, 2631.67104111986, 2638.8548629825364, 4628.375169352141, 4638.628909687225, 4674.1352849722825, 4714.175019371609, 4741.525847415257, 4695.201815691332, 4739.289106634006, 4770.952290477103, 4779.7610119493975, 4783.449903261126, 4243.045314804168, 4260.084081922386, 4271.6155546000855, 4328.891777705567, 4336.306191009439, 4376.146651402978, 4381.167578160155, 4460.776961151945, 4502.909941801162, 4504.617107545862, 4282.0, 4391.692581519295, 4393.0, 4436.0, 4458.777061146946, 4327.502337231227, 4338.197433474817, 4339.891502712426, 4351.586599273064, 4371.125774845043, 4332.220200363933, 4370.366296886966, 4395.077033822869, 4399.12017596482, 4432.911341773147, 4493.68544201906, 4717.292406139072, 4722.055588882203, 4738.47876733559, 4742.549457801503, 5018.623603229772, 5059.06407314648, 5065.4174769901565, 5126.71803050832, 5133.12736834739, 5130.9230361544605, 5139.12634852076, 5144.228365745131, 5153.871153221162, 5157.613179011589, 4630.282306242538, 4670.69640473375, 4742.075295317449, 4787.2101103318255, 4789.712617242976, 5167.1474206755465, 5190.065788158167, 5190.351206099238, 5226.477352264743, 5252.763625636855, 4976.278439626234, 5025.522575355335, 5027.648064635514, 5032.295478632921, 5037.823676171316, 4972.950270497321, 5037.269595908573, 5052.444231134572, 5107.284980102789, 5114.33513643224, 5043.773030213649, 5052.797888084509, 5063.5695965843315, 5064.417591976896, 5094.6688465249645, 5038.370203724535, 5045.47022562633, 5046.041252162077, 5048.343715316985, 5082.440931497532, 4063.0248740302113, 4070.531888832822, 4146.771927543954, 4168.353905144708, 4282.807273672693, 3655.2141289622327, 3666.6883314917995, 3666.8954745774813, 3703.0372103252807, 3724.050367156358, 4381.956180438155, 4389.231884420214, 4390.05613793036, 4427.092446048552, 4430.224710675619, 4943.431505376928, 4970.204767237297, 5029.547340739351, 5051.343325367752, 5060.51925067118, 4379.781010949439, 4397.076613911115, 4433.800478978454, 4436.245838207513, 4438.245498265303, 4540.750258735801, 4545.068261006486, 4552.11233809404, 4593.47175074864, 4596.7931443085145, 4645.953540464552, 4704.435467743892, 4756.667033307635, 4764.809407623726, 4767.33257343979, 5062.848114556569, 5087.4403815581, 5097.362829646294, 5099.337086178922, 5139.357580302462, 4699.318598803223, 4736.550027747358, 4747.620190384692, 4754.072955773591, 4795.304680821192, 4948.505149485023, 4992.301077849032, 5008.724520151427, 5014.122528557415, 5048.873778155576, 5089.847304580869, 5109.846704598868, 5114.46298138705, 5121.641485096007, 5170.612204084633, 4974.353334066548, 4982.97848940959, 4985.002999400207, 4985.551300382983, 5024.070546948826, 4807.95192048089, 4897.0450762101045, 4928.457869634409, 4940.75296235194, 4954.628402869727, 4886.706797592155, 4903.754812259444, 4910.06708725341, 4953.405591329064, 4955.950440495549, 5004.3494345734825, 5005.4744251853035, 5007.449180590205, 5041.697498150123, 5056.115179843439, 4711.693739906895, 4736.550027747358, 4759.547842954914, 4761.119192949315, 4770.642201834946], "value": 4647.003144025084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7064050092699, 592.7836339735998, 593.2643522032678, 597.7758340622266, 610.4170517156115, 27672.30819229518, 40423.39364909525, 41150.58849411505, 41169.0, 41172.382414263775, 42904.785476072575, 43382.349264761055, 43417.34873976893, 43467.34798978018, 43564.564354356444, 7383.520071195382, 7712.421568382366, 7895.684172633117, 7896.802579935519, 10017.248706347016, 9890.752731181707, 10068.345557538772, 10075.899241007606, 10076.143527800146, 10081.647142350019, 10040.899591004107, 10214.744631384201, 10251.948740256326, 10252.743681407987, 10256.94871525645, 7581.962090189569, 7835.569043702594, 7847.5291482510665, 10003.049710277584, 10140.543675534618, 9885.950570247103, 10013.49932503372, 10278.07497325237, 10278.17774578032, 10285.588576456932, 40343.7982810087, 40851.38722919158, 40892.59107408918, 41001.38497922534, 41033.38449923253, 3179.268768183331, 3198.760092993035, 3230.91922701932, 3246.7111981151465, 3335.1495368681076, 30167.698323016928, 30186.245343866358, 30329.241768955733, 30561.23596910073, 31263.37473250545, 3559.3363176236794, 3604.9279014419826, 3617.981910090459, 3636.1636823530735, 3643.2895585360866, 283404.0, 287202.0, 287308.2691730831, 287592.0, 287791.0, 61175.0, 61564.0, 61902.380976190565, 61924.69037654873, 61993.0, 34417.13957151091, 64545.67727161428, 64909.0, 64917.0, 64962.35037649658, 15077.095374277578, 16114.355425782838, 16135.919320403558, 16138.75791863123, 16138.919305403633, 10394.480275986321, 11457.828132578017, 11636.3600001999, 11654.941725291319, 11958.940205298917, 19864.900675496818, 19922.0, 20096.89951550262, 20208.69686954697, 20234.291799786937, 7241.493095483371, 7310.96344518274, 7380.409567234608, 7384.852302953911, 7403.962980185064, 828.6146941672151, 925.6528801699362, 933.2067742419025, 965.8696076029787, 1035.6219979707353, 28412.431751364857, 28954.855225723735, 29305.56041659377, 29414.0, 29438.264043398656, 948.4356807699407, 968.3850754770772, 982.0425085541683, 996.2378780233128, 1019.3119644240109, 15212.923935380251, 15698.76451853223, 16110.194490275439, 16450.835491645168, 16819.83180168207, 374700.7589772311, 375551.0, 377896.0, 378106.0, 379135.0, 53043.0, 53540.73229633827, 53648.0, 53669.73165134149, 53760.0, 1109.955601775936, 1207.559240877091, 1228.3121451986915, 1235.234154823997, 1241.540629966918, 28515.572266416435, 29623.407531849673, 30027.0, 30049.54925676073, 30311.393772124877, 42675.57324426716, 43020.56979430166, 43441.565584345015, 43442.131157377305, 43446.78276608597, 245390.0, 246981.0, 247499.0, 248045.0, 249702.0, 22715.77284227203, 26579.867100664374, 27378.0, 27411.0, 27452.313692157855, 41932.161356772085, 42435.1512969745, 42559.0, 42842.1431571373, 43473.34789978216, 36142.63857361498, 36155.457668135525, 36378.0, 37017.62982370142, 37089.814550927076, 35494.93127743684, 35918.8204058978, 36175.63824361723, 36403.63596364002, 36544.81727591345, 35410.114747130494, 35875.82062089673, 36232.63767362398, 36503.0, 36559.08602284964, 31825.522617161223, 32936.176595585304, 33099.50350744693, 33112.17219569434, 33318.0, 24707.876460617583, 24861.0, 25286.494270114126, 25705.100321489404, 25713.87143064273], "value": 18521.62506091219, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.87900113961246, 356.8857965451055, 357.271166819688, 367.96320367963193, 379.36645801511474, 15706.136162511057, 16863.325466981307, 17134.314627414904, 17249.741253881202, 17670.381536646237, 15902.443414480496, 16581.585460363498, 17097.57256068596, 17106.572335691584, 17130.82869171308, 4963.106640804654, 5108.2848401223855, 5123.2827404163445, 5170.172772356424, 5175.87060323493, 3723.94414083789, 3914.4911161549103, 5109.3613298337705, 5661.150827375906, 5962.25471816023, 5995.040793473046, 6000.549958753089, 6006.399360064002, 6012.909806352908, 6018.6689732064715, 5774.249347584829, 5938.584299099065, 5949.6727679977585, 6017.669028203469, 6023.066424704178, 3243.9837800811083, 4880.975595122037, 5153.3815942087185, 5189.792408303663, 5196.376434827845, 20046.699299510372, 20663.380098597067, 20666.380008599765, 20801.479963000893, 20817.68773468399, 1907.3705677126516, 1944.387517931847, 2051.415346626219, 2060.9072591733407, 2516.7231604523486, 11655.533778648844, 11757.88300111488, 12076.21504602198, 12967.610971670865, 13491.0, 1732.9480115596552, 1745.7555942168106, 1766.7791526059243, 1780.813014633458, 1793.2020250988317, 67120.3287967119, 67242.66378668124, 67450.0, 70131.0, 72191.63904180499, 9777.071178238057, 9789.510524473748, 9814.65648702292, 9875.654352097787, 9922.305438619227, 13373.130746501642, 13479.123856949267, 13488.865111348958, 13510.93244533771, 13513.121647092907, 7123.109611298588, 7209.603471808996, 7260.854782904313, 7326.3406293433845, 7444.106707195171, 6853.931460685429, 6856.0, 6881.174259088942, 6971.233164351917, 6991.091158149408, 4154.543000269968, 4202.810873510638, 4232.0, 4236.4492615959725, 4292.82828686849, 1667.6497935433451, 1705.8038325592468, 1739.4692670449922, 1747.0653200537652, 1755.379951294662, 634.3542471999152, 859.458541119091, 889.155302462663, 904.3624244907325, 980.9558569864373, 15963.680726385639, 16705.83294167067, 16759.0, 17085.743713844302, 17331.913340433468, 863.1066845814552, 877.7191298784328, 901.7384958362002, 929.8465753150655, 940.0364626258004, 9177.579988422844, 9633.951830240803, 9726.465044422624, 9729.756756081155, 9782.0, 363958.0, 364870.0, 369190.0, 380172.0, 387080.0, 79442.0, 80135.0, 80399.0, 80574.59712701399, 81277.0, 922.8338898998111, 929.1451864284874, 931.7204838548408, 932.1470854168496, 935.2284365398573, 14758.262086895827, 14884.255787210812, 14893.0, 15078.0, 15398.230088495755, 27185.86407067952, 32759.34481310313, 34911.476327854594, 36644.26711465809, 36935.44596831103, 45476.77261613671, 50870.0, 51003.0, 51187.232191517905, 51409.48590514196, 7066.116735408074, 7077.150741911004, 7100.396466300423, 7159.534630249017, 7190.460715446257, 7744.728934487266, 9376.531173441437, 10507.789844203226, 10835.67492975212, 11046.723831904266, 8790.824183516423, 9494.90505094968, 9651.131398174199, 9927.751806204902, 10844.728881778019, 9986.800263994824, 10221.029002244775, 10234.488275586042, 10283.22875784334, 10543.841842372523, 5357.0357335679955, 7629.389648828192, 9456.385334953206, 9666.226701863974, 9723.805523889625, 7652.234776522303, 7692.576908270099, 7791.610419479117, 7801.96099019524, 7881.172476890073, 10101.797964040825, 10434.947825260826, 10623.468826558796, 10726.141908647445, 10923.453827308762], "value": 8130.3107930985525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.0819247852833, 1368.4594585138873, 1419.708959663269, 1497.4160077569743, 1737.4527023987443, 7158.463115266356, 7504.061992250969, 7566.470347075707, 7632.122305934819, 7645.732399366023, 7444.330010299072, 7560.432967527444, 7567.432442566802, 7579.962100189491, 7636.694532218718, 2153.257126291427, 2176.5102851858364, 2179.8801065941366, 2180.3785921012513, 2182.454386403399, 2192.27654873892, 2213.4798322394226, 2231.141010710872, 2234.486068204314, 2235.821134309251, 2182.552576721768, 2186.4533866533366, 2210.3037543173928, 2212.1593794358123, 2220.9222677206303, 2157.6979222908803, 2169.262450766747, 2173.847830651855, 2176.183931025865, 2176.651735722293, 2145.3671167005773, 2183.9017244224046, 2184.9344519664437, 2185.825133989277, 2188.0372636040092, 7308.96345518269, 7461.515001524884, 7482.363999060032, 7500.849983000309, 7506.099268087864, 4536.61438777701, 4617.792199351037, 4651.906961860744, 4654.0, 4657.69724967876, 2840.97724819065, 2934.4717950768854, 2975.9851200744074, 3005.8046226995393, 3007.9398412031637, 961.403929563675, 975.2246963663904, 998.1964518562554, 999.9700008999741, 1014.1329163565119, 10117.038881306264, 10195.33730307535, 10249.53877075526, 10266.845997310047, 10299.073083422529, 3908.511436070491, 3942.586028467027, 3982.7411218270718, 4052.3313653246882, 4060.269151552749, 7990.560519171501, 8054.637541310655, 8066.274035336731, 8066.31436327907, 8068.314193293519, 4495.25828238337, 4495.730256184639, 4500.369948207253, 4500.774961251925, 4508.954910450853, 3653.8355773990234, 3811.904702382463, 4145.1295228002455, 4149.211649786531, 4192.224438478891, 3369.511420843964, 3430.6397828227678, 3438.9656103439147, 3447.4484082546674, 3486.16332080304, 1000.9449480278655, 1000.9949950250202, 1007.2848277722899, 1016.11090295991, 1022.4376592874038, 830.9584520773938, 838.4172999765227, 848.9363297752693, 866.0776273268948, 875.3172525430175, 4883.243097319921, 4917.434495033045, 4935.383077115361, 4953.777080031407, 5001.649554620232, 393.54742046646015, 398.90426297688344, 400.0458905510321, 400.14568895407933, 403.81020920167475, 3459.7405194610506, 3599.532140457418, 3646.197836475971, 3660.633936606318, 3661.9267614647556, 8982.955085224532, 9340.159385655325, 9356.391834530734, 9362.06379362072, 9363.672271470467, 9150.0, 9247.0, 9268.25853931684, 9271.119243671841, 9287.48918809472, 7069.929300706927, 7072.575645461186, 7073.328033836778, 7073.752418665322, 7165.677544510405, 5014.0, 5116.565091967075, 5183.922241166461, 5213.478652134756, 5226.29445024932, 8588.312934965314, 8613.870791938001, 8692.826143477221, 8701.956490217508, 8712.825743485222, 8567.057623661267, 8736.432131911406, 8753.212210901049, 8802.0, 8954.059823718415, 5573.6098473106495, 5783.8554036149435, 5796.855078623068, 5797.79707710245, 5809.564282678901, 7088.291170883077, 7278.454115941219, 7281.05346304977, 7363.705451782083, 7384.556926584422, 6451.387118223761, 6628.469722422291, 6636.502262330441, 6701.363370479797, 6739.528233023641, 6632.568883022588, 6635.966820165868, 6710.328967103446, 6716.059751634873, 6777.762778302736, 6208.161898143873, 6254.155688981929, 6310.5267104968225, 6319.747210111544, 6326.398992095744, 4530.70550414222, 4582.793774280099, 4630.0, 4671.976640116778, 4682.0, 4596.3565100885235, 4608.239640459286, 4648.790804413742, 4657.161710892072, 4699.201135806853], "value": 3953.2995733947255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.9021132814843, 294.71265516121787, 301.7540704325974, 303.23584566891435, 305.70346763639265, 4852.660313778037, 4886.975565122174, 4901.485344038878, 4913.508649135089, 4942.802287908479, 4603.907921841561, 4614.169449499089, 4721.480637129913, 4743.430788305408, 4893.168161412568, 3784.489093972306, 3789.696824254053, 3791.2607041626893, 3802.410626352906, 3817.312883680929, 3806.8286927088348, 3810.3522401191863, 3821.6560509554133, 3848.8845334640005, 3880.7865567393783, 3602.0, 3681.558213014442, 3688.8155592220414, 3704.3887758519945, 3721.809021113245, 3779.60314167014, 3784.7729136251774, 3796.316663000659, 3811.6188381161937, 3818.16000479894, 3355.557110442509, 3356.060303115107, 3368.3936891359544, 3372.9494057589154, 3373.2578832656777, 4447.310666846644, 4567.634589232886, 4583.610393116589, 4608.470025946992, 4654.9069018619775, 4293.549177336366, 4313.741175529478, 4334.609885110355, 4336.371226172188, 4349.826006959718, 5035.697858128524, 5035.985605757726, 5038.0, 5044.092063428581, 5059.898802023976, 3641.927161456756, 3647.7993710345922, 3665.3402387570227, 3669.4679271505747, 3677.7793332399874, 5027.472115427864, 5284.339457567804, 5292.576593872481, 5295.279034313863, 5326.733663316857, 3589.3898037333715, 3597.8486884196805, 3619.0, 3631.7094632429344, 3637.417723290377, 3654.524911761454, 3672.981635091807, 3693.649103335179, 3705.166337574024, 3708.8687950174917, 4142.5857414258935, 4227.915441691211, 4248.383984322256, 4265.722728022731, 4277.165952639206, 5059.696418214919, 5072.28987941681, 5087.771050302746, 5093.0577843099145, 5108.565771909355, 1228.4656174563916, 1271.4659842865833, 1292.476546998467, 1294.1006000829334, 1294.9223046617233, 846.0608724316004, 868.370431437203, 874.3005595523556, 874.908134645853, 875.4309698695771, 4458.77706114693, 4467.977660111744, 4476.194285028661, 4488.5511448855505, 4490.12442573695, 5169.4830516948, 5210.140326846104, 5232.869178270497, 5234.842954711365, 5269.473052694777, 4277.615014648696, 4413.955860441419, 4453.77731113443, 4487.326900964816, 4490.348899409567, 2754.2012816283054, 2757.9448411031667, 2759.572266298727, 2770.96334194367, 2795.259256297083, 4868.732219727878, 4891.095147397743, 4891.828785992473, 4912.336834527365, 4921.532454416824, 5139.794408223704, 5271.288376069181, 5361.919571206435, 5417.4582541746295, 5424.105022671294, 4950.356453661001, 4958.330625365529, 4962.0, 4962.5533701967, 4995.225740010304, 5289.629725919149, 5335.279737235423, 5348.1442969124755, 5359.276497672764, 5375.682957675394, 4964.478729733471, 5183.948160518346, 5186.585073194211, 5199.792008319625, 5208.427073021889, 4941.97529012367, 4972.831384624683, 4982.55157035854, 4984.501549844987, 4986.877952460667, 3685.120588499938, 3688.280785246851, 3701.0, 3702.315071711742, 3717.312297225022, 5199.376074871039, 5256.947430525645, 5262.815801446931, 5273.973630131824, 5279.7096159710045, 5054.4692807254705, 5064.797408103635, 5075.543201111917, 5104.9744751276, 5122.641415100908, 4924.374956264496, 5097.222014002304, 5103.260027296095, 5106.208537676666, 5126.769295381791, 4810.326554282473, 4830.396200474941, 5064.0, 5084.0, 5088.796448142033, 5073.822416215415, 5080.314157588678, 5083.237514372874, 5083.364579427572, 5087.771050302819, 5002.299678045004, 5007.574356179765, 5026.0, 5026.572741317029, 5026.85284640166], "value": 3823.404760199898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.1969996604141, 666.4535081233388, 718.2781304788687, 724.214227563094, 737.2001378504324, 12276.508939642415, 12359.134860559765, 12393.876061239385, 12426.565070222545, 12450.750984980306, 12376.690582735437, 12427.502899884017, 12466.750664986695, 12469.25184488929, 12604.369781510934, 608.4584719599537, 747.8130467383154, 769.0617446714999, 777.8483195776826, 780.8047988003, 774.4540099230029, 774.8915151878713, 774.9922500775004, 775.2286474957425, 778.7936196907824, 802.2418814220564, 802.8875957365973, 805.046020465747, 806.2985202873508, 808.7007807111377, 626.8777588370247, 800.8078061265313, 801.2388231180373, 802.0976401548259, 814.5357146426539, 598.4554055809193, 599.8290487211124, 600.1927407636722, 600.2466904035451, 601.3385276196193, 12609.873901260962, 12615.116941814076, 12629.74740505194, 12636.368181590884, 12658.556950506689, 11873.821892671616, 12270.631881043493, 12319.445624946899, 12325.260484370967, 12770.042246831432, 9949.30354875159, 9952.104310612007, 10253.897461025368, 10304.278700490968, 10952.671419857417, 4157.792110394468, 4160.687948403882, 4201.76890271035, 4215.072684009544, 4279.33670281107, 44269.0, 44598.0, 45090.09819803618, 45238.54761452376, 45323.86690332735, 9817.32445712472, 9875.209983201326, 9908.20734341251, 9976.60093596248, 9986.0, 15636.609084772745, 16590.08754518513, 16620.168991550374, 16635.750463743054, 16641.50075497737, 6651.86696266072, 6730.125083739083, 6747.966260168766, 6773.45812335012, 6885.2770459101075, 3647.598764135943, 3666.5416822897137, 3689.723270754704, 3746.269477451925, 3764.3976963685677, 2654.283343497245, 2725.5094083065237, 2728.290644432422, 2731.726827317292, 2736.3569561153113, 481.7422678866789, 504.54590868218895, 509.5897802269209, 515.0188890164243, 518.0597216052852, 435.6079528424443, 494.4042428873199, 562.3364429972671, 566.1960016776188, 583.3379114704841, 7590.316871481593, 7695.884561731578, 7780.727674531364, 7927.128015918244, 7927.643256053491, 561.514290139035, 573.0544601407711, 574.097209828072, 584.4856526256867, 603.9486643635253, 3401.149712571857, 4162.229987452331, 4211.978940105341, 4278.871633850989, 4374.825006999748, 53313.20030199472, 53873.1919021215, 54397.1840422394, 54415.18377224345, 56765.14852277219, 47538.524614754104, 48133.75933120312, 48633.27050094251, 49097.263541046916, 50446.747766261666, 44323.0, 44607.77696111563, 44842.0, 45019.324710129375, 45248.0, 8127.634256458356, 8322.583870806557, 8656.337818010048, 8731.869021964549, 8897.2882169425, 30151.698483015767, 30430.087097387113, 30468.0, 30662.386752264385, 30878.91923782657, 36706.44940325844, 37614.81192594129, 39481.605183947795, 39851.80074099727, 40679.38980915348, 10755.838662420227, 10878.564857405616, 10945.398003109905, 10960.561577537128, 11044.447777611247, 11328.546858125583, 11408.82886756716, 11526.423678815858, 11555.768884622428, 11721.472533735832, 11615.419229038684, 11946.880531194576, 12173.57392491294, 12174.634760957186, 12289.815652765037, 11388.259763115371, 11675.241109327866, 11856.822147667619, 12169.391530423267, 12377.566785162477, 10771.084457821173, 11074.395817446946, 11519.30884146954, 11773.411329433666, 11958.940205298917, 9435.764105897408, 9690.757731056498, 9814.901850981685, 10012.449315287438, 10116.342437741523, 9148.725538233864, 9191.494467804336, 9530.237580993642, 10208.285420020824, 10291.794164116525], "value": 5977.315003188113, "unit": "score"}], "name": "dromaeo_css", "value": 6311.823112395453, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 111.0, 113.0, 112.0, 114.0, 112.0, 112.0, 115.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 130.0, 189.0, 133.0, 133.0, 161.0, 130.0, 189.0, 130.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 162.0, 160.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 135.0, 76.0, 76.0, 74.0, 75.0, 108.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 85.0, 84.0, 84.0, 140.0, 84.0, 85.0, 119.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 63.0, 64.0, 65.0, 66.0, 63.0, 64.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 82.0, 84.0, 83.0, 85.0, 83.0, 85.0, 119.0, 84.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 134.0, 133.0, 139.0, 140.0, 131.0, 141.0, 133.0, 134.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 169.0, 172.0, 172.0, 170.0, 175.0, 170.0, 172.0, 170.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1552.2, "alertThreshold": 2.0}]} 13:46:33 INFO - Return code: 0 13:46:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:46:33 ERROR - # TBPL SUCCESS # 13:46:33 INFO - Running post-action listener: _resource_record_post_action 13:46:33 INFO - ##### 13:46:33 INFO - ##### Finished run-tests step (success) 13:46:33 INFO - ##### 13:46:33 INFO - Running post-run listener: _resource_record_post_run 13:46:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 524410880; Read time: 0; Write time: 363504 13:46:33 INFO - TinderboxPrint: CPU usage
13.1% 13:46:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:46:33 INFO - TinderboxPrint: I/O write bytes / time
524,410,880 / 363,504 13:46:33 INFO - TinderboxPrint: CPU idle
8,319.1 (86.9%) 13:46:33 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 13:46:33 INFO - TinderboxPrint: Swap in / out
0 / 0 13:46:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 243625984; Read time: 0; Write time: 185408 13:46:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 280784896; Read time: 0; Write time: 178096 13:46:33 INFO - Running post-run listener: _upload_blobber_files 13:46:33 INFO - Blob upload gear active. 13:46:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:33 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 13:46:33 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:46:33 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:46:34 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:34 INFO - (blobuploader) - INFO - Done attempting. 13:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:38 INFO - (blobuploader) - INFO - Done attempting. 13:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:39 INFO - (blobuploader) - INFO - Done attempting. 13:46:39 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:39 INFO - Return code: 0 13:46:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/d9f7ca76d9816b78e93751ecd97f45ab4ae11daeee41b55ac7ba2fb1cd6f05a5dfcb4657f7d3f61dd77cab2e9da622a290799c1350ff570d8a2a9ada92047e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f7b3e0a52d7a6231838a73857b45236133bf07426e83a96fe111bdf37d9a2ac55e3c0ad8b6a4a3c46b79f34d0561bf92597183f75c9f1e6a2de65108b84b89d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e9fb7142983dfc915d6cee75a53c26370ef143d72125b34851c7f04e078d94b0255e6472171014e8e0aee1a99afccfce73ec6a3fa54acef130eba4669851e6d8"} 13:46:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:39 INFO - Contents: 13:46:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/d9f7ca76d9816b78e93751ecd97f45ab4ae11daeee41b55ac7ba2fb1cd6f05a5dfcb4657f7d3f61dd77cab2e9da622a290799c1350ff570d8a2a9ada92047e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f7b3e0a52d7a6231838a73857b45236133bf07426e83a96fe111bdf37d9a2ac55e3c0ad8b6a4a3c46b79f34d0561bf92597183f75c9f1e6a2de65108b84b89d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e9fb7142983dfc915d6cee75a53c26370ef143d72125b34851c7f04e078d94b0255e6472171014e8e0aee1a99afccfce73ec6a3fa54acef130eba4669851e6d8"} 13:46:39 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:39 INFO - Copying logs to upload dir... 13:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.625494 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-01 13:46:39.380460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 13:46:39.383905) ========= 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=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/d9f7ca76d9816b78e93751ecd97f45ab4ae11daeee41b55ac7ba2fb1cd6f05a5dfcb4657f7d3f61dd77cab2e9da622a290799c1350ff570d8a2a9ada92047e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f7b3e0a52d7a6231838a73857b45236133bf07426e83a96fe111bdf37d9a2ac55e3c0ad8b6a4a3c46b79f34d0561bf92597183f75c9f1e6a2de65108b84b89d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e9fb7142983dfc915d6cee75a53c26370ef143d72125b34851c7f04e078d94b0255e6472171014e8e0aee1a99afccfce73ec6a3fa54acef130eba4669851e6d8"} build_url:https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/a_Pw3LFgQhepDecHX_WHxQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/d9f7ca76d9816b78e93751ecd97f45ab4ae11daeee41b55ac7ba2fb1cd6f05a5dfcb4657f7d3f61dd77cab2e9da622a290799c1350ff570d8a2a9ada92047e2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f7b3e0a52d7a6231838a73857b45236133bf07426e83a96fe111bdf37d9a2ac55e3c0ad8b6a4a3c46b79f34d0561bf92597183f75c9f1e6a2de65108b84b89d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e9fb7142983dfc915d6cee75a53c26370ef143d72125b34851c7f04e078d94b0255e6472171014e8e0aee1a99afccfce73ec6a3fa54acef130eba4669851e6d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 13:46:39.409566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:46:39.409890) ========= 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=00204705a9daa57ed339a427000001b9-1464812757.274013-163266467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 13:46:39.495373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 13:46:39.495704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 13:46:39.496000) ========= ========= Total master_lag: 0.18 =========