builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1464145097.85 results: success (0) buildid: 20160524173017 builduid: 21dc8c984ecd44c581e20f7f7fc6d176 revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:17.845703) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:17.846214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:17.846565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:17.926130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:17.926454) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 19:58:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-24 19:58:18 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.057834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.058193) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018463 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.111875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.112279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 788365ddaf61746bc66479335ae72d3e566c38ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 788365ddaf61746bc66479335ae72d3e566c38ec --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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 19:58:18,127 truncating revision to first 12 chars 2016-05-24 19:58:18,127 Setting DEBUG logging. 2016-05-24 19:58:18,127 attempt 1/10 2016-05-24 19:58:18,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/788365ddaf61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 19:58:18,375 unpacking tar archive at: fx-team-788365ddaf61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.655652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.655969) ========= script_repo_revision: 788365ddaf61746bc66479335ae72d3e566c38ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.656419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.656787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 19:58:18.672508) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 19:58:18.672820) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:18 INFO - MultiFileLogger online at 20160524 19:58:18 in /builds/slave/test 19:58:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:58:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:18 INFO - {'append_to_log': False, 19:58:18 INFO - 'base_work_dir': '/builds/slave/test', 19:58:18 INFO - 'blob_upload_branch': 'Fx-Team', 19:58:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:18 INFO - 'branch': 'Fx-Team', 19:58:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:18 INFO - 'config_files': ('talos/linux_config.py',), 19:58:18 INFO - 'default_actions': ('clobber', 19:58:18 INFO - 'read-buildbot-config', 19:58:18 INFO - 'download-and-extract', 19:58:18 INFO - 'populate-webroot', 19:58:18 INFO - 'create-virtualenv', 19:58:18 INFO - 'install', 19:58:18 INFO - 'run-tests'), 19:58:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:18 INFO - 'download_minidump_stackwalk': True, 19:58:18 INFO - 'download_symbols': 'ondemand', 19:58:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:18 INFO - 'installer_path': 'installer.exe', 19:58:18 INFO - 'log_level': 'info', 19:58:18 INFO - 'log_name': 'talos', 19:58:18 INFO - 'log_to_console': True, 19:58:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:18 INFO - 'opt_config_files': (), 19:58:18 INFO - 'pip_index': False, 19:58:18 INFO - 'sps_profile': False, 19:58:18 INFO - 'sps_profile_interval': 0, 19:58:18 INFO - 'suite': 'dromaeojs-e10s', 19:58:18 INFO - 'system_bits': '32', 19:58:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:18 INFO - 'title': 'talos-linux64-ix-051', 19:58:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:18 INFO - 'use_talos_json': True, 19:58:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:18 INFO - 'work_dir': 'build'} 19:58:18 INFO - ##### 19:58:18 INFO - ##### Running clobber step. 19:58:18 INFO - ##### 19:58:18 INFO - Running pre-action listener: _resource_record_pre_action 19:58:18 INFO - Running main action method: clobber 19:58:18 INFO - rmtree: /builds/slave/test/build 19:58:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:19 INFO - Running post-action listener: _resource_record_post_action 19:58:19 INFO - ##### 19:58:19 INFO - ##### Finished clobber step (success) 19:58:19 INFO - ##### 19:58:19 INFO - ##### 19:58:19 INFO - ##### Running read-buildbot-config step. 19:58:19 INFO - ##### 19:58:19 INFO - Running pre-action listener: _resource_record_pre_action 19:58:19 INFO - Running main action method: read_buildbot_config 19:58:19 INFO - Using buildbot properties: 19:58:19 INFO - { 19:58:19 INFO - "project": "", 19:58:19 INFO - "product": "firefox", 19:58:19 INFO - "script_repo_revision": "production", 19:58:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:58:19 INFO - "repository": "", 19:58:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:58:19 INFO - "buildid": "20160524173017", 19:58:19 INFO - "pgo_build": "True", 19:58:19 INFO - "basedir": "/builds/slave/test", 19:58:19 INFO - "buildnumber": 371, 19:58:19 INFO - "slavename": "talos-linux64-ix-051", 19:58:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:58:19 INFO - "platform": "ubuntu64_hw", 19:58:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:58:19 INFO - "branch": "fx-team", 19:58:19 INFO - "repo_path": "integration/fx-team", 19:58:19 INFO - "revision": "788365ddaf61746bc66479335ae72d3e566c38ec", 19:58:19 INFO - "stage_platform": "linux64-pgo", 19:58:19 INFO - "builduid": "21dc8c984ecd44c581e20f7f7fc6d176", 19:58:19 INFO - "slavebuilddir": "test" 19:58:19 INFO - } 19:58:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:58:19 INFO - Running post-action listener: _resource_record_post_action 19:58:19 INFO - ##### 19:58:19 INFO - ##### Finished read-buildbot-config step (success) 19:58:19 INFO - ##### 19:58:19 INFO - ##### 19:58:19 INFO - ##### Running download-and-extract step. 19:58:19 INFO - ##### 19:58:19 INFO - Running pre-action listener: _resource_record_pre_action 19:58:19 INFO - Running main action method: download_and_extract 19:58:19 INFO - mkdir: /builds/slave/test/build/tests 19:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:19 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:58:23 INFO - Downloaded 1361 bytes. 19:58:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:58:23 INFO - Using the following test package requirements: 19:58:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:58:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'jsshell-linux-x86_64.zip'], 19:58:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:23 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:58:31 INFO - Downloaded 24417235 bytes. 19:58:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:58:32 INFO - Return code: 0 19:58:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:32 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:58:34 INFO - Downloaded 24417235 bytes. 19:58:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:58:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:58:35 INFO - Return code: 0 19:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:35 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:58:37 INFO - Downloaded 10840359 bytes. 19:58:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:58:37 INFO - Return code: 0 19:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:37 INFO - https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:58:39 INFO - Downloaded 58621454 bytes. 19:58:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:39 INFO - mkdir: /builds/slave/test/properties 19:58:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:58:39 INFO - Writing to file /builds/slave/test/properties/build_url 19:58:39 INFO - Contents: 19:58:39 INFO - build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:58:39 INFO - Running post-action listener: _resource_record_post_action 19:58:39 INFO - Running post-action listener: set_extra_try_arguments 19:58:39 INFO - ##### 19:58:39 INFO - ##### Finished download-and-extract step (success) 19:58:39 INFO - ##### 19:58:39 INFO - ##### 19:58:39 INFO - ##### Running populate-webroot step. 19:58:39 INFO - ##### 19:58:39 INFO - Running pre-action listener: _resource_record_pre_action 19:58:39 INFO - Running main action method: populate_webroot 19:58:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:40 INFO - '--tppagecycles', 19:58:40 INFO - '7'], 19:58:40 INFO - 'tests': ['tsvgm']}}, 19:58:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:58:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:58:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:58:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['damp', 'tps']}, 19:58:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'tests': ['damp', 'tps']}, 19:58:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['dromaeo_dom']}, 19:58:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:58:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'other-e10s': {'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['a11yr', 19:58:40 INFO - 'ts_paint', 19:58:40 INFO - 'tpaint', 19:58:40 INFO - 'sessionrestore', 19:58:40 INFO - 'sessionrestore_no_auto_restore', 19:58:40 INFO - 'tabpaint']}, 19:58:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['tsvgx', 19:58:40 INFO - 'tsvgr_opacity', 19:58:40 INFO - 'tart', 19:58:40 INFO - 'tscrollx', 19:58:40 INFO - 'cart']}, 19:58:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:58:40 INFO - 'tsvgr_opacity', 19:58:40 INFO - 'tart', 19:58:40 INFO - 'tscrollx', 19:58:40 INFO - 'cart']}, 19:58:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'talos_options': ['--disable-e10s'], 19:58:40 INFO - 'tests': ['tp5o']}, 19:58:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'tests': ['tp5o']}, 19:58:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'talos_options': ['--disable-e10s', 19:58:40 INFO - '--xperf_path', 19:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:40 INFO - 'tests': ['tp5n']}, 19:58:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:40 INFO - 'talos_options': ['--xperf_path', 19:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:40 INFO - 'tests': ['tp5n']}}, 19:58:40 INFO - 'talos.zip': {'path': '', 19:58:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:40 INFO - Running post-action listener: _resource_record_post_action 19:58:40 INFO - ##### 19:58:40 INFO - ##### Finished populate-webroot step (success) 19:58:40 INFO - ##### 19:58:40 INFO - ##### 19:58:40 INFO - ##### Running create-virtualenv step. 19:58:40 INFO - ##### 19:58:40 INFO - Running pre-action listener: _resource_record_pre_action 19:58:40 INFO - Running main action method: create_virtualenv 19:58:40 INFO - Creating virtualenv /builds/slave/test/build/venv 19:58:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:58:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:58:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:40 INFO - Using real prefix '/usr' 19:58:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:58:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:42 INFO - Installing pip.................done. 19:58:42 INFO - Return code: 0 19:58:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:58:42 INFO - Using env: {'DISPLAY': ':0', 19:58:42 INFO - 'HOME': '/home/cltbld', 19:58:42 INFO - 'LANG': 'en_US.UTF-8', 19:58:42 INFO - 'LANGUAGE': 'en_US:en', 19:58:42 INFO - 'LOGNAME': 'cltbld', 19:58:42 INFO - 'MAIL': '/var/mail/cltbld', 19:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:42 INFO - 'MOZ_NO_REMOTE': '1', 19:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:42 INFO - 'NO_EM_RESTART': '1', 19:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:42 INFO - 'PWD': '/builds/slave/test', 19:58:42 INFO - 'SHELL': '/bin/bash', 19:58:42 INFO - 'SHLVL': '1', 19:58:42 INFO - 'TERM': 'linux', 19:58:42 INFO - 'TMOUT': '86400', 19:58:42 INFO - 'USER': 'cltbld', 19:58:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:42 INFO - '_': '/tools/buildbot/bin/python'} 19:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:58:42 INFO - Cleaning up... 19:58:42 INFO - Return code: 0 19:58:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:58:42 INFO - Using env: {'DISPLAY': ':0', 19:58:42 INFO - 'HOME': '/home/cltbld', 19:58:42 INFO - 'LANG': 'en_US.UTF-8', 19:58:42 INFO - 'LANGUAGE': 'en_US:en', 19:58:42 INFO - 'LOGNAME': 'cltbld', 19:58:42 INFO - 'MAIL': '/var/mail/cltbld', 19:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:42 INFO - 'MOZ_NO_REMOTE': '1', 19:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:42 INFO - 'NO_EM_RESTART': '1', 19:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:42 INFO - 'PWD': '/builds/slave/test', 19:58:42 INFO - 'SHELL': '/bin/bash', 19:58:42 INFO - 'SHLVL': '1', 19:58:42 INFO - 'TERM': 'linux', 19:58:42 INFO - 'TMOUT': '86400', 19:58:42 INFO - 'USER': 'cltbld', 19:58:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:42 INFO - '_': '/tools/buildbot/bin/python'} 19:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:42 INFO - Downloading/unpacking psutil>=3.1.1 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:45 INFO - Installing collected packages: psutil 19:58:45 INFO - Running setup.py install for psutil 19:58:45 INFO - building 'psutil._psutil_linux' extension 19:58:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:58:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:58:45 INFO - building 'psutil._psutil_posix' extension 19:58:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:58:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:45 INFO - Successfully installed psutil 19:58:45 INFO - Cleaning up... 19:58:45 INFO - Return code: 0 19:58:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:45 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:58:45 INFO - Using env: {'DISPLAY': ':0', 19:58:45 INFO - 'HOME': '/home/cltbld', 19:58:45 INFO - 'LANG': 'en_US.UTF-8', 19:58:45 INFO - 'LANGUAGE': 'en_US:en', 19:58:45 INFO - 'LOGNAME': 'cltbld', 19:58:45 INFO - 'MAIL': '/var/mail/cltbld', 19:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:45 INFO - 'MOZ_NO_REMOTE': '1', 19:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:45 INFO - 'NO_EM_RESTART': '1', 19:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:45 INFO - 'PWD': '/builds/slave/test', 19:58:45 INFO - 'SHELL': '/bin/bash', 19:58:45 INFO - 'SHLVL': '1', 19:58:45 INFO - 'TERM': 'linux', 19:58:45 INFO - 'TMOUT': '86400', 19:58:45 INFO - 'USER': 'cltbld', 19:58:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:45 INFO - '_': '/tools/buildbot/bin/python'} 19:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:58:47 INFO - Installing collected packages: mozsystemmonitor 19:58:47 INFO - Running setup.py install for mozsystemmonitor 19:58:47 INFO - Successfully installed mozsystemmonitor 19:58:47 INFO - Cleaning up... 19:58:47 INFO - Return code: 0 19:58:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:47 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:58:47 INFO - Using env: {'DISPLAY': ':0', 19:58:47 INFO - 'HOME': '/home/cltbld', 19:58:47 INFO - 'LANG': 'en_US.UTF-8', 19:58:47 INFO - 'LANGUAGE': 'en_US:en', 19:58:47 INFO - 'LOGNAME': 'cltbld', 19:58:47 INFO - 'MAIL': '/var/mail/cltbld', 19:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:47 INFO - 'MOZ_NO_REMOTE': '1', 19:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:47 INFO - 'NO_EM_RESTART': '1', 19:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:47 INFO - 'PWD': '/builds/slave/test', 19:58:47 INFO - 'SHELL': '/bin/bash', 19:58:47 INFO - 'SHLVL': '1', 19:58:47 INFO - 'TERM': 'linux', 19:58:47 INFO - 'TMOUT': '86400', 19:58:47 INFO - 'USER': 'cltbld', 19:58:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:47 INFO - '_': '/tools/buildbot/bin/python'} 19:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:50 INFO - Downloading docopt-0.6.1.tar.gz 19:58:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:50 INFO - Running setup.py install for blobuploader 19:58:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:50 INFO - Running setup.py install for requests 19:58:51 INFO - Running setup.py install for docopt 19:58:51 INFO - Successfully installed blobuploader requests docopt 19:58:51 INFO - Cleaning up... 19:58:51 INFO - Return code: 0 19:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:58:51 INFO - Using env: {'DISPLAY': ':0', 19:58:51 INFO - 'HOME': '/home/cltbld', 19:58:51 INFO - 'LANG': 'en_US.UTF-8', 19:58:51 INFO - 'LANGUAGE': 'en_US:en', 19:58:51 INFO - 'LOGNAME': 'cltbld', 19:58:51 INFO - 'MAIL': '/var/mail/cltbld', 19:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:51 INFO - 'MOZ_NO_REMOTE': '1', 19:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:51 INFO - 'NO_EM_RESTART': '1', 19:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:51 INFO - 'PWD': '/builds/slave/test', 19:58:51 INFO - 'SHELL': '/bin/bash', 19:58:51 INFO - 'SHLVL': '1', 19:58:51 INFO - 'TERM': 'linux', 19:58:51 INFO - 'TMOUT': '86400', 19:58:51 INFO - 'USER': 'cltbld', 19:58:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:51 INFO - '_': '/tools/buildbot/bin/python'} 19:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:51 INFO - Running setup.py (path:/tmp/pip-uScdeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:51 INFO - Running setup.py (path:/tmp/pip-j5lcZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:51 INFO - Running setup.py (path:/tmp/pip-3K9Bk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:51 INFO - Running setup.py (path:/tmp/pip-CtQBgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:51 INFO - Running setup.py (path:/tmp/pip-YRhNgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:51 INFO - Running setup.py (path:/tmp/pip-diMYEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:51 INFO - Running setup.py (path:/tmp/pip-KZKSXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:52 INFO - Running setup.py (path:/tmp/pip-xlSQzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:52 INFO - Running setup.py (path:/tmp/pip-fcmaFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:52 INFO - Running setup.py (path:/tmp/pip-mVtTyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:52 INFO - Running setup.py (path:/tmp/pip-UqtpxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:52 INFO - Running setup.py (path:/tmp/pip-fhc7zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:52 INFO - Running setup.py (path:/tmp/pip-8kVP73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:52 INFO - Running setup.py (path:/tmp/pip-FxlHK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:52 INFO - Running setup.py (path:/tmp/pip-jidTZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:52 INFO - Running setup.py (path:/tmp/pip-5rFQyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:52 INFO - Running setup.py (path:/tmp/pip-V_u1gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:52 INFO - Running setup.py install for manifestparser 19:58:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:52 INFO - Running setup.py install for mozcrash 19:58:52 INFO - Running setup.py install for mozdebug 19:58:53 INFO - Running setup.py install for mozdevice 19:58:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for mozfile 19:58:53 INFO - Running setup.py install for mozhttpd 19:58:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for mozinfo 19:58:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for mozInstall 19:58:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for mozleak 19:58:53 INFO - Running setup.py install for mozlog 19:58:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for moznetwork 19:58:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:58:53 INFO - Running setup.py install for mozprocess 19:58:53 INFO - Running setup.py install for mozprofile 19:58:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:58:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:58:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:58:54 INFO - Running setup.py install for mozrunner 19:58:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:58:54 INFO - Running setup.py install for mozscreenshot 19:58:54 INFO - Running setup.py install for moztest 19:58:54 INFO - Running setup.py install for mozversion 19:58:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:54 INFO - Cleaning up... 19:58:54 INFO - Return code: 0 19:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:54 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:58:54 INFO - Using env: {'DISPLAY': ':0', 19:58:54 INFO - 'HOME': '/home/cltbld', 19:58:54 INFO - 'LANG': 'en_US.UTF-8', 19:58:54 INFO - 'LANGUAGE': 'en_US:en', 19:58:54 INFO - 'LOGNAME': 'cltbld', 19:58:54 INFO - 'MAIL': '/var/mail/cltbld', 19:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:54 INFO - 'MOZ_NO_REMOTE': '1', 19:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:54 INFO - 'NO_EM_RESTART': '1', 19:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:54 INFO - 'PWD': '/builds/slave/test', 19:58:54 INFO - 'SHELL': '/bin/bash', 19:58:54 INFO - 'SHLVL': '1', 19:58:54 INFO - 'TERM': 'linux', 19:58:54 INFO - 'TMOUT': '86400', 19:58:54 INFO - 'USER': 'cltbld', 19:58:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:54 INFO - '_': '/tools/buildbot/bin/python'} 19:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:54 INFO - Running setup.py (path:/tmp/pip-ByubnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:54 INFO - Running setup.py (path:/tmp/pip-8RdQvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:54 INFO - Running setup.py (path:/tmp/pip-7eRVRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:54 INFO - Running setup.py (path:/tmp/pip-zTyNi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:55 INFO - Running setup.py (path:/tmp/pip-tNrR3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:55 INFO - Running setup.py (path:/tmp/pip-Vl_lUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:55 INFO - Running setup.py (path:/tmp/pip-Qvdiyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:55 INFO - Running setup.py (path:/tmp/pip-wonHSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:55 INFO - Running setup.py (path:/tmp/pip-S_ui0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:55 INFO - Running setup.py (path:/tmp/pip-LDyDCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:55 INFO - Running setup.py (path:/tmp/pip-fpBJmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:55 INFO - Running setup.py (path:/tmp/pip-zQKQJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:55 INFO - Running setup.py (path:/tmp/pip-WOT9Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:55 INFO - Running setup.py (path:/tmp/pip-zYNlk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:55 INFO - Running setup.py (path:/tmp/pip-bTMcQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:55 INFO - Running setup.py (path:/tmp/pip-Hi8TOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:55 INFO - Running setup.py (path:/tmp/pip-FTcUPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:58:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - Downloading blessings-1.6.tar.gz 19:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:57 INFO - Installing collected packages: blessings 19:58:57 INFO - Running setup.py install for blessings 19:58:58 INFO - Successfully installed blessings 19:58:58 INFO - Cleaning up... 19:58:58 INFO - Return code: 0 19:58:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:58 INFO - Reading from file tmpfile_stdout 19:58:58 INFO - Current package versions: 19:58:58 INFO - argparse == 1.2.1 19:58:58 INFO - blessings == 1.6 19:58:58 INFO - blobuploader == 1.2.4 19:58:58 INFO - docopt == 0.6.1 19:58:58 INFO - manifestparser == 1.1 19:58:58 INFO - mozInstall == 1.12 19:58:58 INFO - mozcrash == 0.17 19:58:58 INFO - mozdebug == 0.1 19:58:58 INFO - mozdevice == 0.48 19:58:58 INFO - mozfile == 1.2 19:58:58 INFO - mozhttpd == 0.7 19:58:58 INFO - mozinfo == 0.9 19:58:58 INFO - mozleak == 0.1 19:58:58 INFO - mozlog == 3.2 19:58:58 INFO - moznetwork == 0.27 19:58:58 INFO - mozprocess == 0.22 19:58:58 INFO - mozprofile == 0.28 19:58:58 INFO - mozrunner == 6.11 19:58:58 INFO - mozscreenshot == 0.1 19:58:58 INFO - mozsystemmonitor == 0.3 19:58:58 INFO - moztest == 0.7 19:58:58 INFO - mozversion == 1.4 19:58:58 INFO - psutil == 3.1.1 19:58:58 INFO - requests == 1.2.3 19:58:58 INFO - wsgiref == 0.1.2 19:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:58 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:58:58 INFO - Using env: {'DISPLAY': ':0', 19:58:58 INFO - 'HOME': '/home/cltbld', 19:58:58 INFO - 'LANG': 'en_US.UTF-8', 19:58:58 INFO - 'LANGUAGE': 'en_US:en', 19:58:58 INFO - 'LOGNAME': 'cltbld', 19:58:58 INFO - 'MAIL': '/var/mail/cltbld', 19:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:58 INFO - 'MOZ_NO_REMOTE': '1', 19:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:58 INFO - 'NO_EM_RESTART': '1', 19:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:58 INFO - 'PWD': '/builds/slave/test', 19:58:58 INFO - 'SHELL': '/bin/bash', 19:58:58 INFO - 'SHLVL': '1', 19:58:58 INFO - 'TERM': 'linux', 19:58:58 INFO - 'TMOUT': '86400', 19:58:58 INFO - 'USER': 'cltbld', 19:58:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:58 INFO - '_': '/tools/buildbot/bin/python'} 19:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:58:58 INFO - Cleaning up... 19:58:58 INFO - Return code: 0 19:58:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:58 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:58:58 INFO - Using env: {'DISPLAY': ':0', 19:58:58 INFO - 'HOME': '/home/cltbld', 19:58:58 INFO - 'LANG': 'en_US.UTF-8', 19:58:58 INFO - 'LANGUAGE': 'en_US:en', 19:58:58 INFO - 'LOGNAME': 'cltbld', 19:58:58 INFO - 'MAIL': '/var/mail/cltbld', 19:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:58 INFO - 'MOZ_NO_REMOTE': '1', 19:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:58 INFO - 'NO_EM_RESTART': '1', 19:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:58 INFO - 'PWD': '/builds/slave/test', 19:58:58 INFO - 'SHELL': '/bin/bash', 19:58:58 INFO - 'SHLVL': '1', 19:58:58 INFO - 'TERM': 'linux', 19:58:58 INFO - 'TMOUT': '86400', 19:58:58 INFO - 'USER': 'cltbld', 19:58:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:58 INFO - '_': '/tools/buildbot/bin/python'} 19:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:58 INFO - Downloading/unpacking jsonschema 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:59:00 INFO - Downloading/unpacking functools32 (from jsonschema) 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:59:00 INFO - warning: no files found matching '*.txt' 19:59:00 INFO - no previously-included directories found matching 'build' 19:59:00 INFO - no previously-included directories found matching 'dist' 19:59:00 INFO - no previously-included directories found matching '.git*' 19:59:00 INFO - Installing collected packages: jsonschema, functools32 19:59:00 INFO - Running setup.py install for functools32 19:59:01 INFO - warning: no files found matching '*.txt' 19:59:01 INFO - no previously-included directories found matching 'build' 19:59:01 INFO - no previously-included directories found matching 'dist' 19:59:01 INFO - no previously-included directories found matching '.git*' 19:59:01 INFO - Successfully installed jsonschema functools32 19:59:01 INFO - Cleaning up... 19:59:01 INFO - Return code: 0 19:59:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:59: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')]} 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:01 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 0x7f80f4521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:59:01 INFO - Using env: {'DISPLAY': ':0', 19:59:01 INFO - 'HOME': '/home/cltbld', 19:59:01 INFO - 'LANG': 'en_US.UTF-8', 19:59:01 INFO - 'LANGUAGE': 'en_US:en', 19:59:01 INFO - 'LOGNAME': 'cltbld', 19:59:01 INFO - 'MAIL': '/var/mail/cltbld', 19:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:01 INFO - 'MOZ_NO_REMOTE': '1', 19:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:01 INFO - 'NO_EM_RESTART': '1', 19:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:01 INFO - 'PWD': '/builds/slave/test', 19:59:01 INFO - 'SHELL': '/bin/bash', 19:59:01 INFO - 'SHLVL': '1', 19:59:01 INFO - 'TERM': 'linux', 19:59:01 INFO - 'TMOUT': '86400', 19:59:01 INFO - 'USER': 'cltbld', 19:59:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:01 INFO - '_': '/tools/buildbot/bin/python'} 19:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:01 INFO - Downloading/unpacking flake8 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:03 INFO - no previously-included directories found matching 'docs/_build' 19:59:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:04 INFO - Running setup.py install for pep8 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:04 INFO - no previously-included directories found matching 'docs/_build' 19:59:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:59:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:04 INFO - Cleaning up... 19:59:04 INFO - Return code: 0 19:59:04 INFO - Running post-action listener: _resource_record_post_action 19:59:04 INFO - Running post-action listener: _start_resource_monitoring 19:59:04 INFO - Starting resource monitoring. 19:59:04 INFO - ##### 19:59:04 INFO - ##### Finished create-virtualenv step (success) 19:59:04 INFO - ##### 19:59:04 INFO - ##### 19:59:04 INFO - ##### Running install step. 19:59:04 INFO - ##### 19:59:04 INFO - Running pre-action listener: _resource_record_pre_action 19:59:04 INFO - Running main action method: install 19:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:04 INFO - Reading from file tmpfile_stdout 19:59:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:04 INFO - Reading from file tmpfile_stdout 19:59:04 INFO - Output received: 19:59:04 INFO - Usage: mozinstall [options] installer 19:59:04 INFO - Options: 19:59:04 INFO - -h, --help show this help message and exit 19:59:04 INFO - -d DEST, --destination=DEST 19:59:04 INFO - Directory to install application into. [default: 19:59:04 INFO - "/builds/slave/test"] 19:59:04 INFO - --app=APP Application being installed. [default: firefox] 19:59:04 INFO - mkdir: /builds/slave/test/build/application 19:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:59:21 INFO - Reading from file tmpfile_stdout 19:59:21 INFO - Output received: 19:59:21 INFO - /builds/slave/test/build/application/firefox/firefox 19:59:21 INFO - Running post-action listener: _resource_record_post_action 19:59:21 INFO - ##### 19:59:21 INFO - ##### Finished install step (success) 19:59:21 INFO - ##### 19:59:21 INFO - ##### 19:59:21 INFO - ##### Running run-tests step. 19:59:21 INFO - ##### 19:59:21 INFO - Running pre-action listener: _resource_record_pre_action 19:59:21 INFO - Running main action method: run_tests 19:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:21 INFO - Python 2.7.3 19:59:21 INFO - Return code: 0 19:59:21 INFO - grabbing minidump binary from tooltool 19:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:21 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 0x16299c0>, '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 0x162a8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x162ad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:59:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:59:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:59:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:21 INFO - Return code: 0 19:59:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:59:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:59:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:59:22 INFO - Return code: 0 19:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:59:22 INFO - Using env: {'DISPLAY': ':0', 19:59:22 INFO - 'HOME': '/home/cltbld', 19:59:22 INFO - 'LANG': 'en_US.UTF-8', 19:59:22 INFO - 'LANGUAGE': 'en_US:en', 19:59:22 INFO - 'LOGNAME': 'cltbld', 19:59:22 INFO - 'MAIL': '/var/mail/cltbld', 19:59:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:22 INFO - 'MOZ_NO_REMOTE': '1', 19:59:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:22 INFO - 'NO_EM_RESTART': '1', 19:59:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:22 INFO - 'PWD': '/builds/slave/test', 19:59:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:22 INFO - 'SHELL': '/bin/bash', 19:59:22 INFO - 'SHLVL': '1', 19:59:22 INFO - 'TERM': 'linux', 19:59:22 INFO - 'TMOUT': '86400', 19:59:22 INFO - 'USER': 'cltbld', 19:59:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484', 19:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:22 INFO - '_': '/tools/buildbot/bin/python'} 19:59:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:59:22 INFO - mozversion application_buildid: 20160524173017 19:59:22 INFO - mozversion application_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 19:59:22 INFO - mozversion application_display_name: Nightly 19:59:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:22 INFO - mozversion application_name: Firefox 19:59:22 INFO - mozversion application_remotingname: firefox 19:59:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:22 INFO - mozversion application_vendor: Mozilla 19:59:22 INFO - mozversion application_version: 49.0a1 19:59:22 INFO - mozversion platform_buildid: 20160524173017 19:59:22 INFO - mozversion platform_changeset: 788365ddaf61746bc66479335ae72d3e566c38ec 19:59:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:22 INFO - mozversion platform_version: 49.0a1 19:59:22 INFO - using testdate: 1464145162 19:59:22 INFO - actual date: 1464145162 19:59:22 INFO - starting webserver on 'localhost:41050' 19:59:22 INFO - SUITE-START | Running 2 tests 19:59:22 INFO - TEST-START | dromaeo_css 19:59:22 INFO - operating with platform_type : linux_ 19:59:22 INFO - Initialising browser for dromaeo_css test... 19:59:22 INFO - TEST-INFO | started process 3944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedmL0A/profile http://localhost:41050/getInfo.html) 19:59:26 INFO - PROCESS | 3944 | 19:59:26 INFO - PROCESS | 3944 | (process:4009): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:59:27 INFO - PROCESS | 3944 | __metrics Screen width/height:1600/1200 19:59:27 INFO - PROCESS | 3944 | colorDepth:24 19:59:27 INFO - PROCESS | 3944 | Browser inner width/height: 1024/697 19:59:27 INFO - PROCESS | 3944 | __metrics 19:59:27 ERROR - PROCESS | 3944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 19:59:28 INFO - TEST-INFO | 3944: exit 0 19:59:28 INFO - Browser initialized. 19:59:28 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:28 INFO - TEST-INFO | started process 4060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpedmL0A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:30 INFO - PROCESS | 4060 | 19:59:30 INFO - PROCESS | 4060 | (process:4119): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:59:40 INFO - PROCESS | 4060 | RSS: Main: 164331520 19:59:40 INFO - PROCESS | 4060 | 20:00:30 INFO - PROCESS | 4060 | 1464145230078 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] 20:02:37 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41050/tests/dromaeo/cssquery-ext.html) 20:02:38 INFO - PROCESS | 4060 | RSS: Main: 167673856 20:02:38 INFO - PROCESS | 4060 | 20:05:40 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-ext.html (next: http://localhost:41050/tests/dromaeo/cssquery-jquery.html) 20:05:41 INFO - PROCESS | 4060 | RSS: Main: 167211008 20:05:41 INFO - PROCESS | 4060 | 20:08:43 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41050/tests/dromaeo/cssquery-mootools.html) 20:08:44 INFO - PROCESS | 4060 | RSS: Main: 168644608 20:08:44 INFO - PROCESS | 4060 | 20:11:45 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41050/tests/dromaeo/cssquery-prototype.html) 20:11:46 INFO - PROCESS | 4060 | RSS: Main: 166252544 20:11:46 INFO - PROCESS | 4060 | 20:14:48 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41050/tests/dromaeo/cssquery-yui.html) 20:14:49 INFO - PROCESS | 4060 | RSS: Main: 167477248 20:14:49 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:41050/tests/dromaeo/cssquery-yui.html (next: http://localhost:41050/tests/dromaeo/cssquery-dojo.html) 20:17:51 INFO - PROCESS | 4060 | RSS: Main: 169275392 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | __start_tp_report 20:17:51 INFO - PROCESS | 4060 | _x_x_mozilla_page_load 20:17:51 INFO - PROCESS | 4060 | _x_x_mozilla_page_load_details 20:17:51 INFO - PROCESS | 4060 | |i|pagename|runs| 20:17:51 INFO - PROCESS | 4060 | |0;dojo.html;3145.842707864607;3153.9211519712017;3181.395534848379;3190.186502441877;3193.80837149771;5366.597505187107;5419.241306217128;5445.591580631449;5493.505584497394;5516.282883225185;5277.788888444457;5338.62629615927;5399.352077750666;5411.675299482034;5507.834764957048;4921.409430868292;4956.752162391884;5010.924836127461;5091.974540127294;5141.383034035921;4935.161022626162;5009.599232061426;5062.670926389791;5108.974455127719;5109.744512774365;4878.634102442314;4916.262560615901;4928.7535623219055;4973.104841128596;4978.576820970222;4956.983818317236;4972.900541989176;4973.602111831045;4978.701277923336;5022.748862556858;4932.679375840559;4954.157793175169;4967.180415231483;4978.8257410990445;5013.949860501385;5155.742212889378;5270.314859068335;5289.418164001957;5350.38470575881;5362.249285100089;5777.075667893159;5779.508741756956;5782.190493330895;5792.189093526909;5805.390434004411;5738.6556806591325;5828.6211396259105;5833.533317334603;5840;5852.180694702745;5457.399686034533;5498.697571633558;5516.806911758109;5522.088855338864;5524.226608274845;6020.187274717945;6021.126936594169;6053.606515576474;6055.122007308915;6055.394460553909;5582.162675598612;5596.888062238732;5771.624844385102;5777;5801.50687191585;5691.77232910679;5744.626599271118;5760.279965004374;5772.7113644317615;5810.535157187415;5616.438356164351;5654.264945557051;5692.31692196939;5726.77092916287;5729.8567535811935;5624.634398764068;5808.767649294065;5815.94184058154;5851.707414629252;5858;4389.956100439019;4420.160169567772;4430.136123455895;4438.289873620205;4448.132614140211;3912.5109361329833;3947.131631041166;3949.624785645359;3965.5241371035086;4001.519817621904;5587.273654424899;5593.776248949996;5618;5639;5641.407652196543;5847.210626565445;5867.2959244890035;5886.05823068307;5895.086261629454;5933.436323549256;5611.130274807411;5644.491995720405;5648.209250704905;5664.68844213564;5669.036263835158;4899.436564795023;4920.286558449076;4950.232713929275;4957.876053098629;5038.345015148007;5918.615290006136;5923.022701254245;5939.851503712355;5957.76168953237;5965.194698715618;5725.456081672234;5731.598788084794;5734.770609175753;5772.018756811268;5792.247007888947;5932.080527518242;5948.10778383246;5969.552283578836;5980.790672326448;5991.550633702403;5709;5711.942880571141;5722.856928576819;5726.169705392612;5731.942680573141;5797.768089276382;5806.883862322815;5807.128930660435;5817.156512305607;5818.970905145447;5525.171224316385;5535.667859928417;5570.053090974463;5596.972015139898;5611.551075913999;5572.969000734877;5664.886702266014;5671.829845104653;5685;5688.345840228427;5603.299587551556;5647.971760141173;5652.689102099424;5662.292213473316;5672.461116193955;5607.691576963143;5670.234518339971;5736.196932429547;5761.337446193741;5773.97113014449;5633.549316054624;5655;5660.716964151694;5674.943250567441;5676.063449530781 20:17:51 INFO - PROCESS | 4060 | |1;ext.html;617.2469587103735;632.285517365377;637.3881074168797;638.1640051532491;669.0599707411089;37167.81416092919;41413.79293103534;41451.79274103629;41456.17087658245;41550.16899662005;42285;42719.35920961188;43009.35485967713;43014;43195.784021079926;8545.4445461045;8720.563971801415;8747.343949203803;8779.692710755126;8781.517016564087;8618.181272779077;8761.036286008566;8769.517676527788;8780.560971951409;8794.86807697885;8777.2100510954;8780.385373023892;8818.294536437103;8823.11768823119;8838.55807209637;8721.302295816351;8735.868961965576;8786.912130878705;8798.12018798115;8810.603522841488;8636.784080397978;8720.607572659246;8726.127387261287;8726.214640682305;8734.170253825876;32348.6765132348;38881.80559097186;39448.802755986326;39557;39592.60407395918;3372.089535825338;3424.178197232671;3433.8111403872776;3464.497647841049;3507.2810073934784;28476.145715628565;28950.855245723636;30731.692683073332;30794.076177714705;31343;4031.7217695109935;4083.673306135502;4112.876613701594;4129.236091323085;4186.079062606222;297611;299858;299875.99999999785;303709;304318;33379.49930751041;33388.499172512435;33835.66164338374;33852.999999999505;33879.32241355159;35344;36310.63689363126;36328.09179770474;38239.80880095637;38253.04367390782;15625.06249625026;15796.526104216891;15821.841781582038;15859;15882.444114455939;11685.415729213675;11826.053915686725;11828.58599949015;11851.88148118525;11862.22895511789;19184.232630694616;19203.615927681647;19211.852028497266;19257.903710481358;19409;7066.328698773608;7253.601051942193;7268;7376.668049937658;7459.664315105833;1043.7181960870523;1154.330488316791;1186.2230239193343;1190.4761904761876;1227.3863068465766;31655;31975.52036719451;32053.839730801665;32168.678313217035;32762.508562371582;1165.3939951225484;1166.859976802789;1223.406647775828;1254.4292346982102;1257.1765493601706;16473.588160296087;16640.334386624643;16811.831881681028;16828.74756878648;16886.915565422096;493656;498104;501122;501714;504476;56716.149257761164;56792.43207567954;57397.71301143467;57460.71269643625;57622;1349.1500354776429;1391.2973948156116;1399.5451478269604;1411.823522059763;1415.4409008441814;30880.227994299425;31195.37609247757;31498.37003259968;31747.84126079355;31898.20254493656;50847.745761270955;52467;53615.46384536261;54150.45849541454;60362.09456858238;491693;492547;493572;494363;495712;43756.78121609499;43941.560584395025;44020;44045;44129.77935110432;48923.755381222865;49152;49349.25976110289;50247.748761255956;50552.24171637502;40553;41625;42365.36451953161;42659.57340426556;42836.571634284504;40752.59247407488;40876.59123408728;41157.588424115376;41460;42504.5749542513;40426.39360409655;40900.59099408968;40987;41811.37282940819;44095.33856992212;34830.30339393147;35900.8204958984;36621.633783661826;37285.81357093306;37539;27983.30041748891;28619.918536857447;28645.856770716015;28941.131766047052;29021.85489072541 20:17:51 INFO - PROCESS | 4060 | |2;jquery.html;375.26260897336726;377.1890435563538;383.49187326791997;384.7960580892128;392.3154096102302;17322.826771732278;18939.431817045475;19166.520836979063;19684.901575492102;19761.209551617954;18501.35245266416;18731.812681873176;19087.809121908813;19197.904010479928;19316.806831931677;5343.412224655285;5491.890162196753;5504.972475137639;5528.9723551382185;5537.916931246034;5374;5514.972425137868;5516.724163791794;5564.1931919871595;5570.721463926808;5246.711430871301;5455.263539422187;5487.533559647435;5495.0658388073925;5513.393526712059;5588.636738611997;5604.971975140098;5606.467385598362;5635.380108188096;5639.041362968284;5381.4349493303425;5662.886742265132;5671.347795003586;5672.8865422691315;5686.943130568683;12954.611361659165;13104.606861794162;13509.189448633113;13532.323383830868;13625.727485450236;2238.910443582271;2258.7967082962614;2428.550718117154;2495.089292408276;2873.310405502685;9657.130858222794;10055.949720251425;10164.542595583216;10260.69217923456;10320.896791032144;1943.922243110274;1954.2183126749271;2018.4449276448947;2030.5938812237612;2030.614183305182;74389.25610743878;78158.60920695416;78910.21089789143;79241.60379198125;80039.19960800375;10262;10324.380537167794;10421.739456513647;10462.319949203278;10618.044376006197;14333.14001159913;14406.567802965928;14453.566393008226;14522.564323070324;14531.782023269448;7476.401887848959;7668.38652907766;7686.3082322591235;7834.686612535549;7904.723334683374;7483.663235154431;7498.100227972678;7572.810679733051;7627.275408836263;7645.694172233159;4365.388845561624;4374.19077470669;4418.293073108352;4472.0608672179205;4546.909061818745;1844.9262029518936;1867.8225568570963;1871.7941026487076;1912.311567835578;1929.4404622659551;955.5270141279972;989.124624707125;1037.3568387599585;1052.1950707708609;1080.081930359204;18405.723914141297;18574.399584058243;18673.972931488897;18990.71513927292;19278.32525861616;984.2421335571713;1027.8509616105773;1039.6725031615017;1080.956761729522;1097.6158344579333;9913.603455861828;10370.792584148276;10894.67315980522;10952.945235273932;11327.660170194908;186747;341949;485905;490046;493333;93020.53489732508;93863.53068234616;93999.53000234955;94298.5285073584;95509;1028.92797504174;1032.6798692405227;1050.1388861133796;1057.6879820452984;1061.384397049694;17387.913060435123;17551.122443878012;17551.912240438716;17746.5563360917;17857.46427607174;40545.594544054184;40612.59387406088;40672.38991415191;40741.38887916625;41090;55962;58043;58114.41885581259;58147;58827.70586147042;8110.553919534483;8487.575621219037;8495.78760530967;8711.738647840575;8748.737537873874;12572.559960401342;12614;13160.934195328962;13165.934170329087;13435.932820335836;11362.772744545227;11491.195616307112;11798.174127810971;11845.111616628616;11921.34432606215;10476.266661333633;11081.168912331446;11561.653150405502;11576.305421674726;11650.718420973855;11202.775944480902;11306.717332066435;11600;11625.534978600761;11885.465154067915;8185.345172386075;8298.543580103153;8327.6668933242;8380.53907035119;8499.447535910145;11081.168912331446;11753.353565553976;11761.647150585497;11838.230515016496;11906.285622862655 20:17:51 INFO - PROCESS | 4060 | |3;mootools.html;1497.8577035181656;1517.8330383657799;1673.9497815065552;1773.299546679061;1775.857931365491;7690.6539205735735;8313.625886835092;8359.623816928237;8880.777980550482;8905.599248033837;8437.3671974602;8616.138386161381;8676.52279124648;8681.609327580258;8691.217790398863;2272.36373815332;2307.746147923727;2310.722713274401;2311.1910831209025;2317.177402022283;2266.5126997695493;2292.4612716011725;2294.8623082615013;2311.410590299471;2315.0855412112205;2279.87460689662;2298.4368829636765;2306;2336.7312759032675;2337.9766202338014;2263.875486848223;2268.5009297954425;2299.8620082795087;2301.413139649387;2306.550222706573;2284.23478134825;2287.348105789842;2300.068472268734;2308.9653655195184;2315.7336906255828;8664.8700269496;8689.26141277992;8693.347998900108;8744.081871403474;8758.2993360531;5196.53231209193;5290.9735451322495;5321.175217841241;5324.840254792362;5326.36083669962;3227.5481432599454;3293.3907227162813;3357.4292370297107;3434.6050204226585;3485.8431370588382;1047.2564479219764;1054.4253381906803;1062.8990245926702;1068.5565490321508;1084.951177197028;12071.758564828655;12114.394280285951;12127.332996685178;12143.271403715806;12163.148579599432;4594.770261486912;4699.412573428322;4721.197396442613;4743.810247590127;4784.68899521537;10227.335223210468;10227.488625568692;10259.076683098558;10261.02520260574;10263.12763415118;5330.520253177233;5334.946650533522;5352.598555108382;5356.946430535645;5372.140457526777;4279.486461624625;4625.306204069417;4706.482286948433;4767.903382222108;4803.087413391444;3956.6547373893013;4023.939640905389;4061.1268577256033;4095.713300069026;4113.71204015722;1252.486480542973;1267.3979859566632;1271.7965125580047;1272.0586765793432;1280.801475771257;869.9043105258417;880.577322885006;945.0974319524837;963.8313295173317;976.3653625143713;5710.885782284331;5839.357670656224;5865.824025279248;5949.1076338549565;5963.4334738199805;439.0669826618436;440.8567215654925;441.940338054365;445.21419694239694;449.2789073536926;4171.290880550314;4178.707490475698;4198;4207.284761590476;4238;10557.36655800639;10846.511906964206;10903.345799251912;10926.726831829268;10974;10687.78624427507;10742.462876856125;10774.622888198875;10832.295900766583;10836.458177091114;8033.55815430157;8211.8357632847;8268.793280168044;8276;8321.625526851185;6140.4473597376455;6193.969030154821;6221.191245138103;6250.312465628686;6258.43674069336;9947.502624868583;9991.650292239738;9992.550335234786;10027.899721002697;10148.54331555067;10014.64948726791;10181.829089654488;10192.592296308361;10243.539040743035;10277.434741089312;7039.472039596948;7469.626518674153;7749.147593764794;7789.298963093349;7906;8535.786605334668;8551.230389264996;8603.698870539502;8663.783405414915;8664.783380415289;7582.317591416799;7666.693332266647;7697.268759467842;7773.494722842997;7853.803654908673;7490.063742032246;7664;7684.65419056155;7704.383649308154;7762.7671169865;6972.023916651774;6972.372486476242;6994.5803251805055;7044.15470143586;7046.753363632249;5154.252633368215;5176.818811341585;5281.683099014072;5318.202269659582;5334.306540149756;5180.274761533464;5246.055709972242;5289.18017707256;5295.285136506523;5345.919811202757 20:17:51 INFO - PROCESS | 4060 | |4;prototype.html;319.73621762046315;330.73541167066355;332.3751347466763;335.47498165371206;337.5847707319996;5517.3792448586955;5517.531009864167;5562.5271851892585;5582.413846546115;5632.746526406317;5487.204355368469;5505.3393592768825;5526.115821468566;5528.391876893548;5539.224508568804;4122.835086596532;4207.894802629943;4303.91392172158;4318.503372112216;4322.805473753673;4313.956860431403;4325.480942286914;4326.572231163725;4328.156009578118;4334.349847522865;4294.613484786369;4308.82764689412;4321.9783901080455;4323.805428755713;4325.48094228693;3948.4472173895533;4202;4207.305794543897;4231.576842315774;4301.333293339538;3665.1753355495066;3666.9083272918124;3677.1542545214484;3693.538307711536;3703.666669999686;5287.286216360781;5289.761960711778;5340.252364668911;5350.250964864922;5380.704061276629;4602.516735742765;4852.563269305744;4855.368802055746;4875.780589873464;4903.779329930162;5730.570207234474;5761.683107429089;5776.86256085247;5783.71081445926;5788.247527821399;4079.571644977294;4091.529474110486;4094.324436467979;4112.835486580533;4114.839709152719;5898.262717160355;5990.700464976778;6007.519398448114;6035.426634469718;6037.9396206038255;4179.558052471893;4181.581841815855;4186.471937742702;4190.664746820247;4193.287141186006;4244.766537840386;4246;4253.553376895444;4258.701890867609;4265.893352666146;4672.602828759525;4836.975815120902;4858.882457034902;4872.1473742094995;4875.19559272716;5752.827415177551;5787.681677507778;5802.419758024248;5896.616719913192;5901.645901245939;1444.1407362619225;1450.5938337265582;1450.9709805803825;1463.8289368505152;1466.8826493880465;919.4437365393974;920.8434566123775;924.8520236762085;934.5747684803398;972.6917296236551;5590.86022849432;5600.719964001865;5633.661980281115;5641.802536911188;5642.971785141048;5836.270466191726;5867.3839246879315;5876.588638795243;5908.291005079418;5924.348321684612;5384.488473595002;5617.269754931833;5620.161818281742;5632.648164440587;5666.4900158985065;3152.8019352645847;3157.463231250693;3160.0993716791063;3164.9683503164674;3165.699258570432;5918.852028699231;6090.23872015998;6136.2636483622255;6160.691965401712;6177;5955.612885162537;5987.730552125165;5999.910001349983;6001.159837622737;6013.579049466583;6048.455638992424;6102.908456373158;6108.664023478663;6142.174599684106;6142.539309551712;5699.2590963174525;5837.270341207349;5881.823545293648;5889.175515427929;5927.8221653350465;5805.477507024388;5808.15781711641;5829.242198514166;5861.677607731615;5866.560007999332;6036.486898613667;6139.693015349304;6156.784512542219;6164.660943647963;6172.845678858064;4135.31767258399;4161.937570936378;4165.312723400605;4167.499900011897;4169.56219596938;5860.648361098348;5881.2942446906645;5888.676122813286;5901.3213480448585;5915.231019967377;5511.834644960658;5624.437556244343;5734.541236701138;5764.740586673526;5777.91333129995;5713.542916566747;5728.653766364984;5748.597598168088;5814.772801095432;5826.067829147316;5483.177523371526;5566.693831839288;5643.77071056922;5723.656580605177;5726;5812.982728022664;5816.789619944394;5826.533877289891;5841.649501029951;5846;5466.508014278734;5728.627639203605;5738.913916291175;5742.224799652161;5746.655200687972 20:17:51 INFO - PROCESS | 4060 | |5;yui.html;833.9541325227113;863.6588547523728;870.2124577257576;874.5645811282876;896.1620884473018;14376.49682261121;14630.926845365771;14818.999999999987;14819;14845.109293442401;13016.60950171494;13683.315834208299;13687.863121368784;13692.110012849183;13752;684.288340126268;800.8438354520871;806.0367860406816;811.059171361221;814.7107776739261;810.4772421787943;813.3290035720524;818.3248819723722;818.3984771193198;818.9140140285274;856.3063918226256;859.299670768325;862.7972426479772;863.0765081362913;868.8783570300131;860.4880096342666;862.9137086291383;862.9525376104311;863.3093525179862;863.6027427383411;616.5745635511482;622.0327390907138;623.7068577768441;624.9937500625026;625.0218408191166;13536.390862411215;13582.388792504262;13666.043376963617;13684.452621895112;13697.726045479034;14077.507287244896;14336.713265734626;14399.352029158714;14834.554963351116;15015;11752.118591105702;11761.176717629769;11848.881511184863;12043.156979011474;12194.756104877853;3825.2731980923813;3857.5549190063166;3863.459115723801;3912.784796836173;3956.109875278068;56171.43828561703;57106.428935710945;59392;59486;59587.40412595905;11473.942630286962;11595.594154204562;11609.187356885106;11704.122190835722;11901.285922844658;20689.482762930747;20698.275560355316;20712.792872071386;20793.1682732689;20808.47978800512;8169.63236654352;8328.125546817619;8347.833043339098;8524.27543658796;8673.219410253107;4637.1421287062;4646.95353046472;4794.113089078532;4794.400699912511;4815.614750819926;3349.7990120592845;3375.5105509700957;3419.743519236067;3446.9310613787584;3500.299940012008;696.8257935516122;699.8180473077036;701.551007355293;704.1198501872659;715.992840071603;696.6447111972828;713.6645776485148;784.7331907151596;804.2721337189853;818.1532114261711;10243.84634230487;10347.379157250438;10588.61626603562;10685.96966576348;10761.677149685522;687.9002544631101;789.7078081110026;795.7533164718956;796.0765512006045;813.4915677701437;4842.055799119208;4843.515648435128;4923.729194894244;4937.21004639256;4957.231629097496;75960.62019689976;76133.23866761372;76707.23292767;78344.60827695826;78922.21077789148;68672.31327686759;69021;70430.2956970434;70506;70660;51378;52512.47487525152;61703.69148154231;62843.371566284666;63438.0484292736;9735.26985476078;9842.803143937224;9938.751531211488;10223.233257505568;10364.429956352473;37361.626383736904;37706.43440348342;37708.81145594364;37797.62202377941;37894.24211515809;46547;51263;51309.743451282506;51384.74307628438;51893.7405312971;12674;12861.807072894102;13222;13242.271675057964;13539.255340956342;14438.927805361327;14639.853601463848;14640.194789286692;14752.778708319598;15013.324400401789;13053.086283960032;13470.52853150135;13772.10481318711;13828.654283642989;13957.302134893418;13539;13584.252866092065;13703.794443083561;13879.306034698022;13950.441982320594;13003;13349.199048057148;13390;13498.662533436742;13935.721285574435;11015.449227538751;11165.106791456827;11257.831132533182;11431.371274579978;11906.107041971714;11474.368909710047;11547.330308629518;11713.531458741554;11779.52881884715;11958.103142264192 20:17:51 INFO - PROCESS | 4060 | __end_tp_report 20:17:51 INFO - PROCESS | 4060 | __start_cc_report 20:17:51 INFO - PROCESS | 4060 | _x_x_mozilla_cycle_collect,357 20:17:51 INFO - PROCESS | 4060 | __end_cc_report 20:17:51 INFO - PROCESS | 4060 | __startTimestamp1464146271952__endTimestamp 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | ------- Summary: start ------- 20:17:51 INFO - PROCESS | 4060 | Number of tests: 6 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#0] dojo.html Cycles:165 Average:5401.49 Median:5639.00 stddev:604.62 (10.7%) stddev-sans-first:580.00 20:17:51 INFO - PROCESS | 4060 | Values: 3145.8 3153.9 3181.4 3190.2 3193.8 5366.6 5419.2 5445.6 5493.5 5516.3 5277.8 5338.6 5399.4 5411.7 5507.8 4921.4 4956.8 5010.9 5092.0 5141.4 4935.2 5009.6 5062.7 5109.0 5109.7 4878.6 4916.3 4928.8 4973.1 4978.6 4957.0 4972.9 4973.6 4978.7 5022.7 4932.7 4954.2 4967.2 4978.8 5013.9 5155.7 5270.3 5289.4 5350.4 5362.2 5777.1 5779.5 5782.2 5792.2 5805.4 5738.7 5828.6 5833.5 5840.0 5852.2 5457.4 5498.7 5516.8 5522.1 5524.2 6020.2 6021.1 6053.6 6055.1 6055.4 5582.2 5596.9 5771.6 5777.0 5801.5 5691.8 5744.6 5760.3 5772.7 5810.5 5616.4 5654.3 5692.3 5726.8 5729.9 5624.6 5808.8 5815.9 5851.7 5858.0 4390.0 4420.2 4430.1 4438.3 4448.1 3912.5 3947.1 3949.6 3965.5 4001.5 5587.3 5593.8 5618.0 5639.0 5641.4 5847.2 5867.3 5886.1 5895.1 5933.4 5611.1 5644.5 5648.2 5664.7 5669.0 4899.4 4920.3 4950.2 4957.9 5038.3 5918.6 5923.0 5939.9 5957.8 5965.2 5725.5 5731.6 5734.8 5772.0 5792.2 5932.1 5948.1 5969.6 5980.8 5991.6 5709.0 5711.9 5722.9 5726.2 5731.9 5797.8 5806.9 5807.1 5817.2 5819.0 5525.2 5535.7 5570.1 5597.0 5611.6 5573.0 5664.9 5671.8 5685.0 5688.3 5603.3 5648.0 5652.7 5662.3 5672.5 5607.7 5670.2 5736.2 5761.3 5774.0 5633.5 5655.0 5660.7 5674.9 5676.1 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#1] ext.html Cycles:180 Average:58384.43 Median:22480.13 stddev:117140.48 (521.1%) stddev-sans-first:117388.79 20:17:51 INFO - PROCESS | 4060 | Values: 617.2 632.3 637.4 638.2 669.1 37167.8 41413.8 41451.8 41456.2 41550.2 42285.0 42719.4 43009.4 43014.0 43195.8 8545.4 8720.6 8747.3 8779.7 8781.5 8618.2 8761.0 8769.5 8780.6 8794.9 8777.2 8780.4 8818.3 8823.1 8838.6 8721.3 8735.9 8786.9 8798.1 8810.6 8636.8 8720.6 8726.1 8726.2 8734.2 32348.7 38881.8 39448.8 39557.0 39592.6 3372.1 3424.2 3433.8 3464.5 3507.3 28476.1 28950.9 30731.7 30794.1 31343.0 4031.7 4083.7 4112.9 4129.2 4186.1 297611.0 299858.0 299876.0 303709.0 304318.0 33379.5 33388.5 33835.7 33853.0 33879.3 35344.0 36310.6 36328.1 38239.8 38253.0 15625.1 15796.5 15821.8 15859.0 15882.4 11685.4 11826.1 11828.6 11851.9 11862.2 19184.2 19203.6 19211.9 19257.9 19409.0 7066.3 7253.6 7268.0 7376.7 7459.7 1043.7 1154.3 1186.2 1190.5 1227.4 31655.0 31975.5 32053.8 32168.7 32762.5 1165.4 1166.9 1223.4 1254.4 1257.2 16473.6 16640.3 16811.8 16828.7 16886.9 493656.0 498104.0 501122.0 501714.0 504476.0 56716.1 56792.4 57397.7 57460.7 57622.0 1349.2 1391.3 1399.5 1411.8 1415.4 30880.2 31195.4 31498.4 31747.8 31898.2 50847.7 52467.0 53615.5 54150.5 60362.1 491693.0 492547.0 493572.0 494363.0 495712.0 43756.8 43941.6 44020.0 44045.0 44129.8 48923.8 49152.0 49349.3 50247.7 50552.2 40553.0 41625.0 42365.4 42659.6 42836.6 40752.6 40876.6 41157.6 41460.0 42504.6 40426.4 40900.6 40987.0 41811.4 44095.3 34830.3 35900.8 36621.6 37285.8 37539.0 27983.3 28619.9 28645.9 28941.1 29021.9 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#2] jquery.html Cycles:180 Average:26026.97 Median:2134.76 stddev:69540.09 (3257.5%) stddev-sans-first:69708.49 20:17:51 INFO - PROCESS | 4060 | Values: 375.3 377.2 383.5 384.8 392.3 17322.8 18939.4 19166.5 19684.9 19761.2 18501.4 18731.8 19087.8 19197.9 19316.8 5343.4 5491.9 5505.0 5529.0 5537.9 5374.0 5515.0 5516.7 5564.2 5570.7 5246.7 5455.3 5487.5 5495.1 5513.4 5588.6 5605.0 5606.5 5635.4 5639.0 5381.4 5662.9 5671.3 5672.9 5686.9 12954.6 13104.6 13509.2 13532.3 13625.7 2238.9 2258.8 2428.6 2495.1 2873.3 9657.1 10055.9 10164.5 10260.7 10320.9 1943.9 1954.2 2018.4 2030.6 2030.6 74389.3 78158.6 78910.2 79241.6 80039.2 10262.0 10324.4 10421.7 10462.3 10618.0 14333.1 14406.6 14453.6 14522.6 14531.8 7476.4 7668.4 7686.3 7834.7 7904.7 7483.7 7498.1 7572.8 7627.3 7645.7 4365.4 4374.2 4418.3 4472.1 4546.9 1844.9 1867.8 1871.8 1912.3 1929.4 955.5 989.1 1037.4 1052.2 1080.1 18405.7 18574.4 18674.0 18990.7 19278.3 984.2 1027.9 1039.7 1081.0 1097.6 9913.6 10370.8 10894.7 10952.9 11327.7 186747.0 341949.0 485905.0 490046.0 493333.0 93020.5 93863.5 93999.5 94298.5 95509.0 1028.9 1032.7 1050.1 1057.7 1061.4 17387.9 17551.1 17551.9 17746.6 17857.5 40545.6 40612.6 40672.4 40741.4 41090.0 55962.0 58043.0 58114.4 58147.0 58827.7 8110.6 8487.6 8495.8 8711.7 8748.7 12572.6 12614.0 13160.9 13165.9 13435.9 11362.8 11491.2 11798.2 11845.1 11921.3 10476.3 11081.2 11561.7 11576.3 11650.7 11202.8 11306.7 11600.0 11625.5 11885.5 8185.3 8298.5 8327.7 8380.5 8499.4 11081.2 11753.4 11761.6 11838.2 11906.3 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#3] mootools.html Cycles:180 Average:5772.19 Median:4702.95 stddev:3281.51 (69.8%) stddev-sans-first:3275.00 20:17:51 INFO - PROCESS | 4060 | Values: 1497.9 1517.8 1673.9 1773.3 1775.9 7690.7 8313.6 8359.6 8880.8 8905.6 8437.4 8616.1 8676.5 8681.6 8691.2 2272.4 2307.7 2310.7 2311.2 2317.2 2266.5 2292.5 2294.9 2311.4 2315.1 2279.9 2298.4 2306.0 2336.7 2338.0 2263.9 2268.5 2299.9 2301.4 2306.6 2284.2 2287.3 2300.1 2309.0 2315.7 8664.9 8689.3 8693.3 8744.1 8758.3 5196.5 5291.0 5321.2 5324.8 5326.4 3227.5 3293.4 3357.4 3434.6 3485.8 1047.3 1054.4 1062.9 1068.6 1085.0 12071.8 12114.4 12127.3 12143.3 12163.1 4594.8 4699.4 4721.2 4743.8 4784.7 10227.3 10227.5 10259.1 10261.0 10263.1 5330.5 5334.9 5352.6 5356.9 5372.1 4279.5 4625.3 4706.5 4767.9 4803.1 3956.7 4023.9 4061.1 4095.7 4113.7 1252.5 1267.4 1271.8 1272.1 1280.8 869.9 880.6 945.1 963.8 976.4 5710.9 5839.4 5865.8 5949.1 5963.4 439.1 440.9 441.9 445.2 449.3 4171.3 4178.7 4198.0 4207.3 4238.0 10557.4 10846.5 10903.3 10926.7 10974.0 10687.8 10742.5 10774.6 10832.3 10836.5 8033.6 8211.8 8268.8 8276.0 8321.6 6140.4 6194.0 6221.2 6250.3 6258.4 9947.5 9991.7 9992.6 10027.9 10148.5 10014.6 10181.8 10192.6 10243.5 10277.4 7039.5 7469.6 7749.1 7789.3 7906.0 8535.8 8551.2 8603.7 8663.8 8664.8 7582.3 7666.7 7697.3 7773.5 7853.8 7490.1 7664.0 7684.7 7704.4 7762.8 6972.0 6972.4 6994.6 7044.2 7046.8 5154.3 5176.8 5281.7 5318.2 5334.3 5180.3 5246.1 5289.2 5295.3 5345.9 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#4] prototype.html Cycles:180 Average:4848.83 Median:5608.99 stddev:1440.02 (25.7%) stddev-sans-first:1403.37 20:17:51 INFO - PROCESS | 4060 | Values: 319.7 330.7 332.4 335.5 337.6 5517.4 5517.5 5562.5 5582.4 5632.7 5487.2 5505.3 5526.1 5528.4 5539.2 4122.8 4207.9 4303.9 4318.5 4322.8 4314.0 4325.5 4326.6 4328.2 4334.3 4294.6 4308.8 4322.0 4323.8 4325.5 3948.4 4202.0 4207.3 4231.6 4301.3 3665.2 3666.9 3677.2 3693.5 3703.7 5287.3 5289.8 5340.3 5350.3 5380.7 4602.5 4852.6 4855.4 4875.8 4903.8 5730.6 5761.7 5776.9 5783.7 5788.2 4079.6 4091.5 4094.3 4112.8 4114.8 5898.3 5990.7 6007.5 6035.4 6037.9 4179.6 4181.6 4186.5 4190.7 4193.3 4244.8 4246.0 4253.6 4258.7 4265.9 4672.6 4837.0 4858.9 4872.1 4875.2 5752.8 5787.7 5802.4 5896.6 5901.6 1444.1 1450.6 1451.0 1463.8 1466.9 919.4 920.8 924.9 934.6 972.7 5590.9 5600.7 5633.7 5641.8 5643.0 5836.3 5867.4 5876.6 5908.3 5924.3 5384.5 5617.3 5620.2 5632.6 5666.5 3152.8 3157.5 3160.1 3165.0 3165.7 5918.9 6090.2 6136.3 6160.7 6177.0 5955.6 5987.7 5999.9 6001.2 6013.6 6048.5 6102.9 6108.7 6142.2 6142.5 5699.3 5837.3 5881.8 5889.2 5927.8 5805.5 5808.2 5829.2 5861.7 5866.6 6036.5 6139.7 6156.8 6164.7 6172.8 4135.3 4161.9 4165.3 4167.5 4169.6 5860.6 5881.3 5888.7 5901.3 5915.2 5511.8 5624.4 5734.5 5764.7 5777.9 5713.5 5728.7 5748.6 5814.8 5826.1 5483.2 5566.7 5643.8 5723.7 5726.0 5813.0 5816.8 5826.5 5841.6 5846.0 5466.5 5728.6 5738.9 5742.2 5746.7 20:17:51 INFO - PROCESS | 4060 | 20:17:51 INFO - PROCESS | 4060 | [#5] yui.html Cycles:180 Average:16591.86 Median:3934.45 stddev:20348.83 (517.2%) stddev-sans-first:20371.51 20:17:51 INFO - PROCESS | 4060 | Values: 834.0 863.7 870.2 874.6 896.2 14376.5 14630.9 14819.0 14819.0 14845.1 13016.6 13683.3 13687.9 13692.1 13752.0 684.3 800.8 806.0 811.1 814.7 810.5 813.3 818.3 818.4 818.9 856.3 859.3 862.8 863.1 868.9 860.5 862.9 863.0 863.3 863.6 616.6 622.0 623.7 625.0 625.0 13536.4 13582.4 13666.0 13684.5 13697.7 14077.5 14336.7 14399.4 14834.6 15015.0 11752.1 11761.2 11848.9 12043.2 12194.8 3825.3 3857.6 3863.5 3912.8 3956.1 56171.4 57106.4 59392.0 59486.0 59587.4 11473.9 11595.6 11609.2 11704.1 11901.3 20689.5 20698.3 20712.8 20793.2 20808.5 8169.6 8328.1 8347.8 8524.3 8673.2 4637.1 4647.0 4794.1 4794.4 4815.6 3349.8 3375.5 3419.7 3446.9 3500.3 696.8 699.8 701.6 704.1 716.0 696.6 713.7 784.7 804.3 818.2 10243.8 10347.4 10588.6 10686.0 10761.7 687.9 789.7 795.8 796.1 813.5 4842.1 4843.5 4923.7 4937.2 4957.2 75960.6 76133.2 76707.2 78344.6 78922.2 68672.3 69021.0 70430.3 70506.0 70660.0 51378.0 52512.5 61703.7 62843.4 63438.0 9735.3 9842.8 9938.8 10223.2 10364.4 37361.6 37706.4 37708.8 37797.6 37894.2 46547.0 51263.0 51309.7 51384.7 51893.7 12674.0 12861.8 13222.0 13242.3 13539.3 14438.9 14639.9 14640.2 14752.8 15013.3 13053.1 13470.5 13772.1 13828.7 13957.3 13539.0 13584.3 13703.8 13879.3 13950.4 13003.0 13349.2 13390.0 13498.7 13935.7 11015.4 11165.1 11257.8 11431.4 11906.1 11474.4 11547.3 11713.5 11779.5 11958.1 20:17:51 INFO - PROCESS | 4060 | -------- Summary: end -------- 20:17:51 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | ###!!! [Child][MessageChannel] Error: (msgtype=0x46010F,name=PContent::Msg_AsyncMessage) Channel closing: too late to send/recv, messages will be lost 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0043,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - PROCESS | 4060 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 20:17:52 INFO - PROCESS | 4060 | 20:17:52 INFO - TEST-INFO | 4060: exit 0 20:17:52 INFO - TEST-OK | dromaeo_css | took 1110369ms 20:17:52 INFO - TEST-START | kraken 20:17:52 INFO - operating with platform_type : linux_ 20:17:52 INFO - Initialising browser for kraken test... 20:17:52 INFO - TEST-INFO | started process 4293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZTuyq/profile http://localhost:41050/getInfo.html) 20:17:56 INFO - PROCESS | 4293 | 20:17:56 INFO - PROCESS | 4293 | (process:4363): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:17:57 INFO - PROCESS | 4293 | __metrics Screen width/height:1600/1200 20:17:57 INFO - PROCESS | 4293 | colorDepth:24 20:17:57 INFO - PROCESS | 4293 | Browser inner width/height: 1024/697 20:17:57 INFO - PROCESS | 4293 | __metrics 20:17:58 ERROR - PROCESS | 4293 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:17:58 INFO - TEST-INFO | 4293: exit 0 20:17:58 INFO - Browser initialized. 20:17:58 INFO - Running cycle 1/1 for kraken test... 20:17:58 INFO - TEST-INFO | started process 4414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzZTuyq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:00 INFO - PROCESS | 4414 | 20:18:00 INFO - PROCESS | 4414 | (process:4478): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:18:10 INFO - PROCESS | 4414 | RSS: Main: 164384768 20:18:10 INFO - PROCESS | 4414 | 20:18:13 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41050/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:14 INFO - PROCESS | 4414 | RSS: Main: 168886272 20:18:14 INFO - PROCESS | 4414 | 20:18:16 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41050/tests/kraken/driver.html?testName=audio-dft) 20:18:17 INFO - PROCESS | 4414 | RSS: Main: 169508864 20:18:17 INFO - PROCESS | 4414 | 20:18:20 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41050/tests/kraken/driver.html?testName=audio-fft) 20:18:20 INFO - PROCESS | 4414 | RSS: Main: 163868672 20:18:20 INFO - PROCESS | 4414 | 20:18:23 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41050/tests/kraken/driver.html?testName=audio-oscillator) 20:18:23 INFO - PROCESS | 4414 | RSS: Main: 164016128 20:18:23 INFO - PROCESS | 4414 | 20:18:25 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41050/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:26 INFO - PROCESS | 4414 | RSS: Main: 164200448 20:18:26 INFO - PROCESS | 4414 | 20:18:29 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41050/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:30 INFO - PROCESS | 4414 | RSS: Main: 164864000 20:18:30 INFO - PROCESS | 4414 | 20:18:33 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41050/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:34 INFO - PROCESS | 4414 | RSS: Main: 165146624 20:18:34 INFO - PROCESS | 4414 | 20:18:36 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41050/tests/kraken/driver.html?testName=json-parse-financial) 20:18:37 INFO - PROCESS | 4414 | RSS: Main: 165535744 20:18:37 INFO - PROCESS | 4414 | 20:18:39 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41050/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:39 INFO - PROCESS | 4414 | RSS: Main: 165044224 20:18:39 INFO - PROCESS | 4414 | 20:18:41 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:42 INFO - PROCESS | 4414 | RSS: Main: 165056512 20:18:42 INFO - PROCESS | 4414 | 20:18:44 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:44 INFO - PROCESS | 4414 | RSS: Main: 165195776 20:18:44 INFO - PROCESS | 4414 | 20:18:47 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:48 INFO - PROCESS | 4414 | RSS: Main: 165023744 20:18:48 INFO - PROCESS | 4414 | 20:18:50 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:51 INFO - PROCESS | 4414 | RSS: Main: 165183488 20:18:51 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:41050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41050/tests/kraken/driver.html?testName=ai-astar) 20:18:53 INFO - PROCESS | 4414 | RSS: Main: 166871040 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | __start_tp_report 20:18:53 INFO - PROCESS | 4414 | _x_x_mozilla_page_load 20:18:53 INFO - PROCESS | 4414 | _x_x_mozilla_page_load_details 20:18:53 INFO - PROCESS | 4414 | |i|pagename|runs| 20:18:53 INFO - PROCESS | 4414 | |0;ai-astar;112;106;112;112;111;112;111;112;110;111 20:18:53 INFO - PROCESS | 4414 | |1;audio-beat-detection;158;125;157;184;128;161;153;127;191;127 20:18:53 INFO - PROCESS | 4414 | |2;audio-dft;165;163;162;162;161;166;165;161;162;160 20:18:53 INFO - PROCESS | 4414 | |3;audio-fft;75;74;74;160;77;76;74;76;158;77 20:18:53 INFO - PROCESS | 4414 | |4;audio-oscillator;83;83;140;83;84;83;142;83;83;153 20:18:53 INFO - PROCESS | 4414 | |5;imaging-gaussian-blur;117;117;120;120;117;117;117;117;117;117 20:18:53 INFO - PROCESS | 4414 | |6;imaging-darkroom;147;146;147;147;146;146;147;145;146;145 20:18:53 INFO - PROCESS | 4414 | |7;imaging-desaturate;96;96;97;96;95;96;98;97;97;96 20:18:53 INFO - PROCESS | 4414 | |8;json-parse-financial;57;57;56;56;57;59;55;74;53;56 20:18:53 INFO - PROCESS | 4414 | |9;json-stringify-tinderbox;62;63;61;61;61;62;62;61;61;62 20:18:53 INFO - PROCESS | 4414 | |10;stanford-crypto-aes;80;81;81;81;81;82;83;87;82;82 20:18:53 INFO - PROCESS | 4414 | |11;stanford-crypto-ccm;127;122;136;129;131;124;136;130;166;126 20:18:53 INFO - PROCESS | 4414 | |12;stanford-crypto-pbkdf2;160;162;163;161;159;160;164;161;158;159 20:18:53 INFO - PROCESS | 4414 | |13;stanford-crypto-sha256-iterative;62;63;64;63;63;65;62;61;60;66 20:18:53 INFO - PROCESS | 4414 | __end_tp_report 20:18:53 INFO - PROCESS | 4414 | __start_cc_report 20:18:53 INFO - PROCESS | 4414 | _x_x_mozilla_cycle_collect,849 20:18:53 INFO - PROCESS | 4414 | __end_cc_report 20:18:53 INFO - PROCESS | 4414 | __startTimestamp1464146333325__endTimestamp 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | ------- Summary: start ------- 20:18:53 INFO - PROCESS | 4414 | Number of tests: 14 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:1.85 (1.7%) stddev-sans-first:1.92 20:18:53 INFO - PROCESS | 4414 | Values: 112.0 106.0 112.0 112.0 111.0 112.0 111.0 112.0 110.0 111.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.50 stddev:24.12 (15.3%) stddev-sans-first:25.45 20:18:53 INFO - PROCESS | 4414 | Values: 158.0 125.0 157.0 184.0 128.0 161.0 153.0 127.0 191.0 127.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.00 (1.2%) stddev-sans-first:1.94 20:18:53 INFO - PROCESS | 4414 | Values: 165.0 163.0 162.0 162.0 161.0 166.0 165.0 161.0 162.0 160.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.50 stddev:35.28 (46.7%) stddev-sans-first:36.87 20:18:53 INFO - PROCESS | 4414 | Values: 75.0 74.0 74.0 160.0 77.0 76.0 74.0 76.0 158.0 77.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.00 stddev:30.06 (36.2%) stddev-sans-first:31.12 20:18:53 INFO - PROCESS | 4414 | Values: 83.0 83.0 140.0 83.0 84.0 83.0 142.0 83.0 83.0 153.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 20:18:53 INFO - PROCESS | 4414 | Values: 117.0 117.0 120.0 120.0 117.0 117.0 117.0 117.0 117.0 117.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 20:18:53 INFO - PROCESS | 4414 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 145.0 146.0 145.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 20:18:53 INFO - PROCESS | 4414 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 98.0 97.0 97.0 96.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:5.83 (10.2%) stddev-sans-first:6.17 20:18:53 INFO - PROCESS | 4414 | Values: 57.0 57.0 56.0 56.0 57.0 59.0 55.0 74.0 53.0 56.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 20:18:53 INFO - PROCESS | 4414 | Values: 62.0 63.0 61.0 61.0 61.0 62.0 62.0 61.0 61.0 62.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.94 (2.4%) stddev-sans-first:1.92 20:18:53 INFO - PROCESS | 4414 | Values: 80.0 81.0 81.0 81.0 81.0 82.0 83.0 87.0 82.0 82.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:130.50 stddev:12.57 (9.6%) stddev-sans-first:13.16 20:18:53 INFO - PROCESS | 4414 | Values: 127.0 122.0 136.0 129.0 131.0 124.0 136.0 130.0 166.0 126.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 20:18:53 INFO - PROCESS | 4414 | Values: 160.0 162.0 163.0 161.0 159.0 160.0 164.0 161.0 158.0 159.0 20:18:53 INFO - PROCESS | 4414 | 20:18:53 INFO - PROCESS | 4414 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.79 (2.8%) stddev-sans-first:1.87 20:18:53 INFO - PROCESS | 4414 | Values: 62.0 63.0 64.0 63.0 63.0 65.0 62.0 61.0 60.0 66.0 20:18:53 INFO - PROCESS | 4414 | -------- Summary: end -------- 20:18:53 INFO - PROCESS | 4414 | 20:18:54 INFO - TEST-INFO | 4414: exit 0 20:18:54 INFO - TEST-OK | kraken | took 61650ms 20:18:54 INFO - SUITE-END | took 1172s 20:18:54 INFO - Completed test suite (00:19:32) 20:18:54 INFO - javascript benchmark 20:18:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.779916831101, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.842707864607, 3153.9211519712017, 3181.395534848379, 3190.186502441877, 3193.80837149771, 5366.597505187107, 5419.241306217128, 5445.591580631449, 5493.505584497394, 5516.282883225185, 5277.788888444457, 5338.62629615927, 5399.352077750666, 5411.675299482034, 5507.834764957048, 4921.409430868292, 4956.752162391884, 5010.924836127461, 5091.974540127294, 5141.383034035921, 4935.161022626162, 5009.599232061426, 5062.670926389791, 5108.974455127719, 5109.744512774365, 4878.634102442314, 4916.262560615901, 4928.7535623219055, 4973.104841128596, 4978.576820970222, 4956.983818317236, 4972.900541989176, 4973.602111831045, 4978.701277923336, 5022.748862556858, 4932.679375840559, 4954.157793175169, 4967.180415231483, 4978.8257410990445, 5013.949860501385, 5155.742212889378, 5270.314859068335, 5289.418164001957, 5350.38470575881, 5362.249285100089, 5777.075667893159, 5779.508741756956, 5782.190493330895, 5792.189093526909, 5805.390434004411, 5738.6556806591325, 5828.6211396259105, 5833.533317334603, 5840.0, 5852.180694702745, 5457.399686034533, 5498.697571633558, 5516.806911758109, 5522.088855338864, 5524.226608274845, 6020.187274717945, 6021.126936594169, 6053.606515576474, 6055.122007308915, 6055.394460553909, 5582.162675598612, 5596.888062238732, 5771.624844385102, 5777.0, 5801.50687191585, 5691.77232910679, 5744.626599271118, 5760.279965004374, 5772.7113644317615, 5810.535157187415, 5616.438356164351, 5654.264945557051, 5692.31692196939, 5726.77092916287, 5729.8567535811935, 5624.634398764068, 5808.767649294065, 5815.94184058154, 5851.707414629252, 5858.0, 4389.956100439019, 4420.160169567772, 4430.136123455895, 4438.289873620205, 4448.132614140211, 3912.5109361329833, 3947.131631041166, 3949.624785645359, 3965.5241371035086, 4001.519817621904, 5587.273654424899, 5593.776248949996, 5618.0, 5639.0, 5641.407652196543, 5847.210626565445, 5867.2959244890035, 5886.05823068307, 5895.086261629454, 5933.436323549256, 5611.130274807411, 5644.491995720405, 5648.209250704905, 5664.68844213564, 5669.036263835158, 4899.436564795023, 4920.286558449076, 4950.232713929275, 4957.876053098629, 5038.345015148007, 5918.615290006136, 5923.022701254245, 5939.851503712355, 5957.76168953237, 5965.194698715618, 5725.456081672234, 5731.598788084794, 5734.770609175753, 5772.018756811268, 5792.247007888947, 5932.080527518242, 5948.10778383246, 5969.552283578836, 5980.790672326448, 5991.550633702403, 5709.0, 5711.942880571141, 5722.856928576819, 5726.169705392612, 5731.942680573141, 5797.768089276382, 5806.883862322815, 5807.128930660435, 5817.156512305607, 5818.970905145447, 5525.171224316385, 5535.667859928417, 5570.053090974463, 5596.972015139898, 5611.551075913999, 5572.969000734877, 5664.886702266014, 5671.829845104653, 5685.0, 5688.345840228427, 5603.299587551556, 5647.971760141173, 5652.689102099424, 5662.292213473316, 5672.461116193955, 5607.691576963143, 5670.234518339971, 5736.196932429547, 5761.337446193741, 5773.97113014449, 5633.549316054624, 5655.0, 5660.716964151694, 5674.943250567441, 5676.063449530781], "value": 5361.13460166753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.2469587103735, 632.285517365377, 637.3881074168797, 638.1640051532491, 669.0599707411089, 37167.81416092919, 41413.79293103534, 41451.79274103629, 41456.17087658245, 41550.16899662005, 42285.0, 42719.35920961188, 43009.35485967713, 43014.0, 43195.784021079926, 8545.4445461045, 8720.563971801415, 8747.343949203803, 8779.692710755126, 8781.517016564087, 8618.181272779077, 8761.036286008566, 8769.517676527788, 8780.560971951409, 8794.86807697885, 8777.2100510954, 8780.385373023892, 8818.294536437103, 8823.11768823119, 8838.55807209637, 8721.302295816351, 8735.868961965576, 8786.912130878705, 8798.12018798115, 8810.603522841488, 8636.784080397978, 8720.607572659246, 8726.127387261287, 8726.214640682305, 8734.170253825876, 32348.6765132348, 38881.80559097186, 39448.802755986326, 39557.0, 39592.60407395918, 3372.089535825338, 3424.178197232671, 3433.8111403872776, 3464.497647841049, 3507.2810073934784, 28476.145715628565, 28950.855245723636, 30731.692683073332, 30794.076177714705, 31343.0, 4031.7217695109935, 4083.673306135502, 4112.876613701594, 4129.236091323085, 4186.079062606222, 297611.0, 299858.0, 299875.99999999785, 303709.0, 304318.0, 33379.49930751041, 33388.499172512435, 33835.66164338374, 33852.999999999505, 33879.32241355159, 35344.0, 36310.63689363126, 36328.09179770474, 38239.80880095637, 38253.04367390782, 15625.06249625026, 15796.526104216891, 15821.841781582038, 15859.0, 15882.444114455939, 11685.415729213675, 11826.053915686725, 11828.58599949015, 11851.88148118525, 11862.22895511789, 19184.232630694616, 19203.615927681647, 19211.852028497266, 19257.903710481358, 19409.0, 7066.328698773608, 7253.601051942193, 7268.0, 7376.668049937658, 7459.664315105833, 1043.7181960870523, 1154.330488316791, 1186.2230239193343, 1190.4761904761876, 1227.3863068465766, 31655.0, 31975.52036719451, 32053.839730801665, 32168.678313217035, 32762.508562371582, 1165.3939951225484, 1166.859976802789, 1223.406647775828, 1254.4292346982102, 1257.1765493601706, 16473.588160296087, 16640.334386624643, 16811.831881681028, 16828.74756878648, 16886.915565422096, 493656.0, 498104.0, 501122.0, 501714.0, 504476.0, 56716.149257761164, 56792.43207567954, 57397.71301143467, 57460.71269643625, 57622.0, 1349.1500354776429, 1391.2973948156116, 1399.5451478269604, 1411.823522059763, 1415.4409008441814, 30880.227994299425, 31195.37609247757, 31498.37003259968, 31747.84126079355, 31898.20254493656, 50847.745761270955, 52467.0, 53615.46384536261, 54150.45849541454, 60362.09456858238, 491693.0, 492547.0, 493572.0, 494363.0, 495712.0, 43756.78121609499, 43941.560584395025, 44020.0, 44045.0, 44129.77935110432, 48923.755381222865, 49152.0, 49349.25976110289, 50247.748761255956, 50552.24171637502, 40553.0, 41625.0, 42365.36451953161, 42659.57340426556, 42836.571634284504, 40752.59247407488, 40876.59123408728, 41157.588424115376, 41460.0, 42504.5749542513, 40426.39360409655, 40900.59099408968, 40987.0, 41811.37282940819, 44095.33856992212, 34830.30339393147, 35900.8204958984, 36621.633783661826, 37285.81357093306, 37539.0, 27983.30041748891, 28619.918536857447, 28645.856770716015, 28941.131766047052, 29021.85489072541], "value": 19670.855993350408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.26260897336726, 377.1890435563538, 383.49187326791997, 384.7960580892128, 392.3154096102302, 17322.826771732278, 18939.431817045475, 19166.520836979063, 19684.901575492102, 19761.209551617954, 18501.35245266416, 18731.812681873176, 19087.809121908813, 19197.904010479928, 19316.806831931677, 5343.412224655285, 5491.890162196753, 5504.972475137639, 5528.9723551382185, 5537.916931246034, 5374.0, 5514.972425137868, 5516.724163791794, 5564.1931919871595, 5570.721463926808, 5246.711430871301, 5455.263539422187, 5487.533559647435, 5495.0658388073925, 5513.393526712059, 5588.636738611997, 5604.971975140098, 5606.467385598362, 5635.380108188096, 5639.041362968284, 5381.4349493303425, 5662.886742265132, 5671.347795003586, 5672.8865422691315, 5686.943130568683, 12954.611361659165, 13104.606861794162, 13509.189448633113, 13532.323383830868, 13625.727485450236, 2238.910443582271, 2258.7967082962614, 2428.550718117154, 2495.089292408276, 2873.310405502685, 9657.130858222794, 10055.949720251425, 10164.542595583216, 10260.69217923456, 10320.896791032144, 1943.922243110274, 1954.2183126749271, 2018.4449276448947, 2030.5938812237612, 2030.614183305182, 74389.25610743878, 78158.60920695416, 78910.21089789143, 79241.60379198125, 80039.19960800375, 10262.0, 10324.380537167794, 10421.739456513647, 10462.319949203278, 10618.044376006197, 14333.14001159913, 14406.567802965928, 14453.566393008226, 14522.564323070324, 14531.782023269448, 7476.401887848959, 7668.38652907766, 7686.3082322591235, 7834.686612535549, 7904.723334683374, 7483.663235154431, 7498.100227972678, 7572.810679733051, 7627.275408836263, 7645.694172233159, 4365.388845561624, 4374.19077470669, 4418.293073108352, 4472.0608672179205, 4546.909061818745, 1844.9262029518936, 1867.8225568570963, 1871.7941026487076, 1912.311567835578, 1929.4404622659551, 955.5270141279972, 989.124624707125, 1037.3568387599585, 1052.1950707708609, 1080.081930359204, 18405.723914141297, 18574.399584058243, 18673.972931488897, 18990.71513927292, 19278.32525861616, 984.2421335571713, 1027.8509616105773, 1039.6725031615017, 1080.956761729522, 1097.6158344579333, 9913.603455861828, 10370.792584148276, 10894.67315980522, 10952.945235273932, 11327.660170194908, 186747.0, 341949.0, 485905.0, 490046.0, 493333.0, 93020.53489732508, 93863.53068234616, 93999.53000234955, 94298.5285073584, 95509.0, 1028.92797504174, 1032.6798692405227, 1050.1388861133796, 1057.6879820452984, 1061.384397049694, 17387.913060435123, 17551.122443878012, 17551.912240438716, 17746.5563360917, 17857.46427607174, 40545.594544054184, 40612.59387406088, 40672.38991415191, 40741.38887916625, 41090.0, 55962.0, 58043.0, 58114.41885581259, 58147.0, 58827.70586147042, 8110.553919534483, 8487.575621219037, 8495.78760530967, 8711.738647840575, 8748.737537873874, 12572.559960401342, 12614.0, 13160.934195328962, 13165.934170329087, 13435.932820335836, 11362.772744545227, 11491.195616307112, 11798.174127810971, 11845.111616628616, 11921.34432606215, 10476.266661333633, 11081.168912331446, 11561.653150405502, 11576.305421674726, 11650.718420973855, 11202.775944480902, 11306.717332066435, 11600.0, 11625.534978600761, 11885.465154067915, 8185.345172386075, 8298.543580103153, 8327.6668933242, 8380.53907035119, 8499.447535910145, 11081.168912331446, 11753.353565553976, 11761.647150585497, 11838.230515016496, 11906.285622862655], "value": 8908.286787670868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.8577035181656, 1517.8330383657799, 1673.9497815065552, 1773.299546679061, 1775.857931365491, 7690.6539205735735, 8313.625886835092, 8359.623816928237, 8880.777980550482, 8905.599248033837, 8437.3671974602, 8616.138386161381, 8676.52279124648, 8681.609327580258, 8691.217790398863, 2272.36373815332, 2307.746147923727, 2310.722713274401, 2311.1910831209025, 2317.177402022283, 2266.5126997695493, 2292.4612716011725, 2294.8623082615013, 2311.410590299471, 2315.0855412112205, 2279.87460689662, 2298.4368829636765, 2306.0, 2336.7312759032675, 2337.9766202338014, 2263.875486848223, 2268.5009297954425, 2299.8620082795087, 2301.413139649387, 2306.550222706573, 2284.23478134825, 2287.348105789842, 2300.068472268734, 2308.9653655195184, 2315.7336906255828, 8664.8700269496, 8689.26141277992, 8693.347998900108, 8744.081871403474, 8758.2993360531, 5196.53231209193, 5290.9735451322495, 5321.175217841241, 5324.840254792362, 5326.36083669962, 3227.5481432599454, 3293.3907227162813, 3357.4292370297107, 3434.6050204226585, 3485.8431370588382, 1047.2564479219764, 1054.4253381906803, 1062.8990245926702, 1068.5565490321508, 1084.951177197028, 12071.758564828655, 12114.394280285951, 12127.332996685178, 12143.271403715806, 12163.148579599432, 4594.770261486912, 4699.412573428322, 4721.197396442613, 4743.810247590127, 4784.68899521537, 10227.335223210468, 10227.488625568692, 10259.076683098558, 10261.02520260574, 10263.12763415118, 5330.520253177233, 5334.946650533522, 5352.598555108382, 5356.946430535645, 5372.140457526777, 4279.486461624625, 4625.306204069417, 4706.482286948433, 4767.903382222108, 4803.087413391444, 3956.6547373893013, 4023.939640905389, 4061.1268577256033, 4095.713300069026, 4113.71204015722, 1252.486480542973, 1267.3979859566632, 1271.7965125580047, 1272.0586765793432, 1280.801475771257, 869.9043105258417, 880.577322885006, 945.0974319524837, 963.8313295173317, 976.3653625143713, 5710.885782284331, 5839.357670656224, 5865.824025279248, 5949.1076338549565, 5963.4334738199805, 439.0669826618436, 440.8567215654925, 441.940338054365, 445.21419694239694, 449.2789073536926, 4171.290880550314, 4178.707490475698, 4198.0, 4207.284761590476, 4238.0, 10557.36655800639, 10846.511906964206, 10903.345799251912, 10926.726831829268, 10974.0, 10687.78624427507, 10742.462876856125, 10774.622888198875, 10832.295900766583, 10836.458177091114, 8033.55815430157, 8211.8357632847, 8268.793280168044, 8276.0, 8321.625526851185, 6140.4473597376455, 6193.969030154821, 6221.191245138103, 6250.312465628686, 6258.43674069336, 9947.502624868583, 9991.650292239738, 9992.550335234786, 10027.899721002697, 10148.54331555067, 10014.64948726791, 10181.829089654488, 10192.592296308361, 10243.539040743035, 10277.434741089312, 7039.472039596948, 7469.626518674153, 7749.147593764794, 7789.298963093349, 7906.0, 8535.786605334668, 8551.230389264996, 8603.698870539502, 8663.783405414915, 8664.783380415289, 7582.317591416799, 7666.693332266647, 7697.268759467842, 7773.494722842997, 7853.803654908673, 7490.063742032246, 7664.0, 7684.65419056155, 7704.383649308154, 7762.7671169865, 6972.023916651774, 6972.372486476242, 6994.5803251805055, 7044.15470143586, 7046.753363632249, 5154.252633368215, 5176.818811341585, 5281.683099014072, 5318.202269659582, 5334.306540149756, 5180.274761533464, 5246.055709972242, 5289.18017707256, 5295.285136506523, 5345.919811202757], "value": 4536.485956569816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.73621762046315, 330.73541167066355, 332.3751347466763, 335.47498165371206, 337.5847707319996, 5517.3792448586955, 5517.531009864167, 5562.5271851892585, 5582.413846546115, 5632.746526406317, 5487.204355368469, 5505.3393592768825, 5526.115821468566, 5528.391876893548, 5539.224508568804, 4122.835086596532, 4207.894802629943, 4303.91392172158, 4318.503372112216, 4322.805473753673, 4313.956860431403, 4325.480942286914, 4326.572231163725, 4328.156009578118, 4334.349847522865, 4294.613484786369, 4308.82764689412, 4321.9783901080455, 4323.805428755713, 4325.48094228693, 3948.4472173895533, 4202.0, 4207.305794543897, 4231.576842315774, 4301.333293339538, 3665.1753355495066, 3666.9083272918124, 3677.1542545214484, 3693.538307711536, 3703.666669999686, 5287.286216360781, 5289.761960711778, 5340.252364668911, 5350.250964864922, 5380.704061276629, 4602.516735742765, 4852.563269305744, 4855.368802055746, 4875.780589873464, 4903.779329930162, 5730.570207234474, 5761.683107429089, 5776.86256085247, 5783.71081445926, 5788.247527821399, 4079.571644977294, 4091.529474110486, 4094.324436467979, 4112.835486580533, 4114.839709152719, 5898.262717160355, 5990.700464976778, 6007.519398448114, 6035.426634469718, 6037.9396206038255, 4179.558052471893, 4181.581841815855, 4186.471937742702, 4190.664746820247, 4193.287141186006, 4244.766537840386, 4246.0, 4253.553376895444, 4258.701890867609, 4265.893352666146, 4672.602828759525, 4836.975815120902, 4858.882457034902, 4872.1473742094995, 4875.19559272716, 5752.827415177551, 5787.681677507778, 5802.419758024248, 5896.616719913192, 5901.645901245939, 1444.1407362619225, 1450.5938337265582, 1450.9709805803825, 1463.8289368505152, 1466.8826493880465, 919.4437365393974, 920.8434566123775, 924.8520236762085, 934.5747684803398, 972.6917296236551, 5590.86022849432, 5600.719964001865, 5633.661980281115, 5641.802536911188, 5642.971785141048, 5836.270466191726, 5867.3839246879315, 5876.588638795243, 5908.291005079418, 5924.348321684612, 5384.488473595002, 5617.269754931833, 5620.161818281742, 5632.648164440587, 5666.4900158985065, 3152.8019352645847, 3157.463231250693, 3160.0993716791063, 3164.9683503164674, 3165.699258570432, 5918.852028699231, 6090.23872015998, 6136.2636483622255, 6160.691965401712, 6177.0, 5955.612885162537, 5987.730552125165, 5999.910001349983, 6001.159837622737, 6013.579049466583, 6048.455638992424, 6102.908456373158, 6108.664023478663, 6142.174599684106, 6142.539309551712, 5699.2590963174525, 5837.270341207349, 5881.823545293648, 5889.175515427929, 5927.8221653350465, 5805.477507024388, 5808.15781711641, 5829.242198514166, 5861.677607731615, 5866.560007999332, 6036.486898613667, 6139.693015349304, 6156.784512542219, 6164.660943647963, 6172.845678858064, 4135.31767258399, 4161.937570936378, 4165.312723400605, 4167.499900011897, 4169.56219596938, 5860.648361098348, 5881.2942446906645, 5888.676122813286, 5901.3213480448585, 5915.231019967377, 5511.834644960658, 5624.437556244343, 5734.541236701138, 5764.740586673526, 5777.91333129995, 5713.542916566747, 5728.653766364984, 5748.597598168088, 5814.772801095432, 5826.067829147316, 5483.177523371526, 5566.693831839288, 5643.77071056922, 5723.656580605177, 5726.0, 5812.982728022664, 5816.789619944394, 5826.533877289891, 5841.649501029951, 5846.0, 5466.508014278734, 5728.627639203605, 5738.913916291175, 5742.224799652161, 5746.655200687972], "value": 4381.938893423467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9541325227113, 863.6588547523728, 870.2124577257576, 874.5645811282876, 896.1620884473018, 14376.49682261121, 14630.926845365771, 14818.999999999987, 14819.0, 14845.109293442401, 13016.60950171494, 13683.315834208299, 13687.863121368784, 13692.110012849183, 13752.0, 684.288340126268, 800.8438354520871, 806.0367860406816, 811.059171361221, 814.7107776739261, 810.4772421787943, 813.3290035720524, 818.3248819723722, 818.3984771193198, 818.9140140285274, 856.3063918226256, 859.299670768325, 862.7972426479772, 863.0765081362913, 868.8783570300131, 860.4880096342666, 862.9137086291383, 862.9525376104311, 863.3093525179862, 863.6027427383411, 616.5745635511482, 622.0327390907138, 623.7068577768441, 624.9937500625026, 625.0218408191166, 13536.390862411215, 13582.388792504262, 13666.043376963617, 13684.452621895112, 13697.726045479034, 14077.507287244896, 14336.713265734626, 14399.352029158714, 14834.554963351116, 15015.0, 11752.118591105702, 11761.176717629769, 11848.881511184863, 12043.156979011474, 12194.756104877853, 3825.2731980923813, 3857.5549190063166, 3863.459115723801, 3912.784796836173, 3956.109875278068, 56171.43828561703, 57106.428935710945, 59392.0, 59486.0, 59587.40412595905, 11473.942630286962, 11595.594154204562, 11609.187356885106, 11704.122190835722, 11901.285922844658, 20689.482762930747, 20698.275560355316, 20712.792872071386, 20793.1682732689, 20808.47978800512, 8169.63236654352, 8328.125546817619, 8347.833043339098, 8524.27543658796, 8673.219410253107, 4637.1421287062, 4646.95353046472, 4794.113089078532, 4794.400699912511, 4815.614750819926, 3349.7990120592845, 3375.5105509700957, 3419.743519236067, 3446.9310613787584, 3500.299940012008, 696.8257935516122, 699.8180473077036, 701.551007355293, 704.1198501872659, 715.992840071603, 696.6447111972828, 713.6645776485148, 784.7331907151596, 804.2721337189853, 818.1532114261711, 10243.84634230487, 10347.379157250438, 10588.61626603562, 10685.96966576348, 10761.677149685522, 687.9002544631101, 789.7078081110026, 795.7533164718956, 796.0765512006045, 813.4915677701437, 4842.055799119208, 4843.515648435128, 4923.729194894244, 4937.21004639256, 4957.231629097496, 75960.62019689976, 76133.23866761372, 76707.23292767, 78344.60827695826, 78922.21077789148, 68672.31327686759, 69021.0, 70430.2956970434, 70506.0, 70660.0, 51378.0, 52512.47487525152, 61703.69148154231, 62843.371566284666, 63438.0484292736, 9735.26985476078, 9842.803143937224, 9938.751531211488, 10223.233257505568, 10364.429956352473, 37361.626383736904, 37706.43440348342, 37708.81145594364, 37797.62202377941, 37894.24211515809, 46547.0, 51263.0, 51309.743451282506, 51384.74307628438, 51893.7405312971, 12674.0, 12861.807072894102, 13222.0, 13242.271675057964, 13539.255340956342, 14438.927805361327, 14639.853601463848, 14640.194789286692, 14752.778708319598, 15013.324400401789, 13053.086283960032, 13470.52853150135, 13772.10481318711, 13828.654283642989, 13957.302134893418, 13539.0, 13584.252866092065, 13703.794443083561, 13879.306034698022, 13950.441982320594, 13003.0, 13349.199048057148, 13390.0, 13498.662533436742, 13935.721285574435, 11015.449227538751, 11165.106791456827, 11257.831132533182, 11431.371274579978, 11906.107041971714, 11474.368909710047, 11547.330308629518, 11713.531458741554, 11779.52881884715, 11958.103142264192], "value": 7206.6110116187065, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 112.0, 111.0, 112.0, 111.0, 112.0, 110.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 157.0, 184.0, 128.0, 161.0, 153.0, 127.0, 191.0, 127.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 162.0, 161.0, 166.0, 165.0, 161.0, 162.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 160.0, 77.0, 76.0, 74.0, 76.0, 158.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 140.0, 83.0, 84.0, 83.0, 142.0, 83.0, 83.0, 153.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 120.0, 120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 98.0, 97.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 59.0, 55.0, 74.0, 53.0, 56.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 81.0, 81.0, 82.0, 83.0, 87.0, 82.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 122.0, 136.0, 129.0, 131.0, 124.0, 136.0, 130.0, 166.0, 126.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 161.0, 159.0, 160.0, 164.0, 161.0, 158.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 65.0, 62.0, 61.0, 60.0, 66.0], "value": 62.9, "unit": "score"}]}]} 20:18:54 INFO - Return code: 0 20:18:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:18:54 ERROR - # TBPL SUCCESS # 20:18:54 INFO - Running post-action listener: _resource_record_post_action 20:18:54 INFO - ##### 20:18:54 INFO - ##### Finished run-tests step (success) 20:18:54 INFO - ##### 20:18:54 INFO - Running post-run listener: _resource_record_post_run 20:18:54 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 471040; Write bytes: 365793280; Read time: 324; Write time: 270532 20:18:54 INFO - TinderboxPrint: CPU usage
13.3% 20:18:54 INFO - TinderboxPrint: I/O read bytes / time
471,040 / 324 20:18:54 INFO - TinderboxPrint: I/O write bytes / time
365,793,280 / 270,532 20:18:54 INFO - TinderboxPrint: CPU idle
8,233.3 (86.7%) 20:18:54 INFO - TinderboxPrint: CPU user
1,209.9 (12.7%) 20:18:54 INFO - TinderboxPrint: Swap in / out
0 / 0 20:18:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79048704; Read time: 0; Write time: 56376 20:18:54 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 471040; Write bytes: 286744576; Read time: 324; Write time: 214156 20:18:55 INFO - Running post-run listener: _upload_blobber_files 20:18:55 INFO - Blob upload gear active. 20:18:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:55 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 20:18:55 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:18:55 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:18:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:56 INFO - (blobuploader) - INFO - Done attempting. 20:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:00 INFO - (blobuploader) - INFO - Done attempting. 20:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:19:01 INFO - (blobuploader) - INFO - Done attempting. 20:19:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:19:01 INFO - Return code: 0 20:19:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:19:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:19:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eef3870c2cb10a517fdeb1cfe9d447738fc23ff71ce9e39e9a46aa99284c88c216696bd8e9583e6a5e1dbca8fc02678736b08a484fd1a067c19b5263aa7e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3239c1b869c91fa602f52b4de7de4cc72b4cc7d335c6500179f587a3f7c78ddc955fe5cc9974c0df18acc01e46c59eef90f419fd0bfd163c9f4ac38834295160", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4b4e03ca4782518903da796d02cdcaee09e9247f693f390898873a6172d96951f538df8666003ae0c1352aac50c0e75b365ed7eb5e9ae850e51f763a9f157c"} 20:19:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:19:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:19:01 INFO - Contents: 20:19:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eef3870c2cb10a517fdeb1cfe9d447738fc23ff71ce9e39e9a46aa99284c88c216696bd8e9583e6a5e1dbca8fc02678736b08a484fd1a067c19b5263aa7e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3239c1b869c91fa602f52b4de7de4cc72b4cc7d335c6500179f587a3f7c78ddc955fe5cc9974c0df18acc01e46c59eef90f419fd0bfd163c9f4ac38834295160", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4b4e03ca4782518903da796d02cdcaee09e9247f693f390898873a6172d96951f538df8666003ae0c1352aac50c0e75b365ed7eb5e9ae850e51f763a9f157c"} 20:19:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:19:01 INFO - Copying logs to upload dir... 20:19:01 INFO - mkdir: /builds/slave/test/build/upload/logs 20:19:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.714740 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 20:19:01.395044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:01.398872) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eef3870c2cb10a517fdeb1cfe9d447738fc23ff71ce9e39e9a46aa99284c88c216696bd8e9583e6a5e1dbca8fc02678736b08a484fd1a067c19b5263aa7e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3239c1b869c91fa602f52b4de7de4cc72b4cc7d335c6500179f587a3f7c78ddc955fe5cc9974c0df18acc01e46c59eef90f419fd0bfd163c9f4ac38834295160", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4b4e03ca4782518903da796d02cdcaee09e9247f693f390898873a6172d96951f538df8666003ae0c1352aac50c0e75b365ed7eb5e9ae850e51f763a9f157c"} build_url:https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/TTgwhr5hRtKJv47kzamY-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eef3870c2cb10a517fdeb1cfe9d447738fc23ff71ce9e39e9a46aa99284c88c216696bd8e9583e6a5e1dbca8fc02678736b08a484fd1a067c19b5263aa7e67f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3239c1b869c91fa602f52b4de7de4cc72b4cc7d335c6500179f587a3f7c78ddc955fe5cc9974c0df18acc01e46c59eef90f419fd0bfd163c9f4ac38834295160", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4b4e03ca4782518903da796d02cdcaee09e9247f693f390898873a6172d96951f538df8666003ae0c1352aac50c0e75b365ed7eb5e9ae850e51f763a9f157c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:01.424827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:01.425345) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1464144816.561757-1487032484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:19:01.508561) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:19:01.508876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:19:01.509176) ========= ========= Total master_lag: 0.17 =========